[adminpk@CentOS7-x64 ~]$ sudo journalctl -fu sen2agri-services --since today [sudo] password for adminpk: -- Logs begin at Thu 2021-03-18 09:59:42 CET. -- Mar 18 09:59:55 CentOS7-x64 systemd[1]: Started Services for Sen2Agri. Mar 18 09:59:55 CentOS7-x64 start.sh[2456]: Installed services: LPIS/GSAA Service,Object Storage Service,Progress Reporting Service,S1 Backscatter/Coherence S2-gridded Service,S1 Pre-processing Service,Sen2Agri Services Mar 18 09:59:55 CentOS7-x64 start.sh[2456]: Configuration files will be read from /usr/share/sen2agri/sen2agri-services/config Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: Active logging levels: org.esa.sen2agri -> TRACE, org.esa.sen4cap -> TRACE, ro.cs.tao -> TRACE, root -> ERROR, Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: LOGBACK: No context given for c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1886491834 Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: Sen4CAP Services v2.1.0 Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:56.442 INFO [main ] o.esa.sen4cap.ServicesStartup - Starting ServicesStartup v2.1.0 on CentOS7-x64 with PID 2464 (/usr/share/sen2agri/sen2agri-services/modules/sen4cap-startup-2.1.0.jar started by sen2agri-service in /usr/share/sen2agri/sen2agri-services/bin) Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:56.444 DEBUG [main ] o.esa.sen4cap.ServicesStartup - Running with Spring Boot v2.2.0.RELEASE, Spring v5.2.0.RELEASE Mar 18 09:59:56 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:56.444 INFO [main ] o.esa.sen4cap.ServicesStartup - The following profiles are active: server Mar 18 09:59:58 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:58.254 INFO [main ] r.c.t.s.c.ServletConfiguration - Sen4CAP Services version: 2.1.0 (2020-12-27T18:24:58Z) Mar 18 09:59:58 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:58.254 INFO [main ] r.c.t.s.c.ServletConfiguration - TAO Services version: 1.0.3.5 (2020-12-17T10:03:42Z) Mar 18 09:59:58 CentOS7-x64 start.sh[2456]: 2021-Mar-18 09:59:58.254 INFO [main ] r.c.t.s.c.ServletConfiguration - Using server port 8080 Mar 18 10:00:00 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:00.865 DEBUG [main ] o.e.s.db.PersistenceManager - Sensor Sentinel3 is not supported in Sen2Agri Mar 18 10:00:00 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:00.905 DEBUG [main ] o.esa.sen2agri.commons.Config - Initialized datasource [Scientific Data Hub,S2] with 1 max connections and timeout 9000s Mar 18 10:00:00 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:00.906 DEBUG [main ] o.esa.sen2agri.commons.Config - Initialized datasource [Scientific Data Hub,S1] with 1 max connections and timeout 9000s Mar 18 10:00:00 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:00.962 INFO [main ] o.e.s.services.ScheduleManager - Enabled sites: Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.020 DEBUG [main ] o.e.s.services.ScheduleManager - Found scheduled job types: ObjectStorage,Lookup,S1,Retry,Reports Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.026 INFO [main ] o.e.s.services.ScheduleManager - Setting scheduled.object.storage.move.enabled is disabled Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.050 INFO [main ] o.e.s.services.ScheduleManager - Scheduled new job 'Reports.Reports' (next run: 2021-03-18T10:01:01, repeat after 1440 minutes) Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.767 INFO [main ] org.esa.sen2agri.CoreLauncher - Network connection timeout initialized at 30 seconds Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.768 INFO [main ] org.esa.sen2agri.CoreLauncher - Database configuration polling is disabled Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.776 INFO [main ] org.esa.sen2agri.CoreLauncher - Batch notification initialized at 60 minutes with message limit of 0 Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.776 DEBUG [main ] o.esa.sen4cap.ServicesStartup - Spring initialization completed Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.803 DEBUG [pool-3-thread-1] o.esa.sen4cap.ServicesStartup - Cleaning up working directory '/mnt/archive/s1_preprocessing_work_dir' Mar 18 10:00:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:00:01.843 INFO [main ] o.esa.sen4cap.ServicesStartup - Started ServicesStartup in 5.737 seconds (JVM running for 6.612) Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.045 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.ReportJob - Starting job 'Reports.Reports' Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.059 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.068 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.075 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.075 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.ReportJob - Job 'Reports.Reports' completed Mar 18 10:01:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:01:01.077 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.services.ScheduleManager - Trigger 'Reports.Reports' completed with code 'NOOP' Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.616 DEBUG [http-nio-8080-exec-4] o.e.s.db.PersistenceManager - Sensor Sentinel3 is not supported in Sen2Agri Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.650 DEBUG [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Configuration refreshed from database Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.692 DEBUG [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Jobs in progress: none Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.712 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Setting scheduled.object.storage.move.enabled is disabled Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.807 DEBUG [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Old interval: 86400000 min; new interval: 1440 min Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.808 DEBUG [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Deleted previous job 'Reports.Reports' Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.809 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Rescheduled job 'Reports.Reports' (next run: 2021-03-18T10:04:02, repeat after 1440 minutes) Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.873 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Scheduled new job 'Lookup-s1-test_5000' (next run: 2021-03-18T10:03:12, repeat after 30 minutes) Mar 18 10:03:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:02.934 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Scheduled new job 'Lookup-s2-test_5000' (next run: 2021-03-18T10:03:12, repeat after 30 minutes) Mar 18 10:03:03 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:03.001 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Scheduled new job 'Retry-s1-test_5000' (next run: 2021-03-18T10:03:13, repeat after 30 minutes) Mar 18 10:03:03 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:03.074 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Scheduled new job 'Retry-s2-test_5000' (next run: 2021-03-18T10:03:13, repeat after 30 minutes) Mar 18 10:03:03 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:03.168 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Scheduled new job 'S1.S1-test_5000' (next run: 2021-03-18T10:03:13, repeat after 60 minutes) Mar 18 10:03:03 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:03.168 INFO [http-nio-8080-exec-4] o.e.s.services.ScheduleManager - Running scheduled jobs: 0 Mar 18 10:03:03 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:03.178 INFO [http-nio-8080-exec-5] o.e.s.web.DownloadController - /downloader/stop/11/2 received Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.876 INFO [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - Starting job 'Lookup.Lookup-s1-test_5000' Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.898 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Seasons defined: 2020 [2019-11-01,2020-04-30,2020-11-30] Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.923 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Using start date: 2019-10-26T00:00 and end date: 2020-11-30T23:59:59 Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.923 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Lookup for new products in range 2019-10-26 00:00:00 - 2020-11-30 23:59:59 Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.935 INFO [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - Starting job 'Lookup.Lookup-s2-test_5000' Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.948 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel1'] Performing query for interval 2019-10-26T00:00 - 2020-11-30T23:59:59 Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.948 TRACE [DefaultQuartzScheduler_Worker-2] o.esa.sen2agri.commons.Config - Requested worker for Scientific Data Hub,S1 (active workers: 0, queued tasks: 0) Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.954 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Seasons defined: 2020 [2019-11-01,2020-04-30,2020-11-30] Mar 18 10:03:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:12.993 TRACE [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - Query timeout is set to 90000 s Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.009 INFO [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - Starting job 'Retry.Retry-s1-test_5000' Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.076 INFO [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - Starting job 'Retry.Retry-s2-test_5000' Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.080 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Using start date: 2019-09-01T00:00 and end date: 2020-11-30T23:59:59 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.080 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Lookup for new products in range 2019-09-01 00:00:00 - 2020-11-30 23:59:59 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.091 DEBUG [Scientific Data Hub-S1-1] o.e.s.s.i.DownloadServiceImpl - Querying page #1 (query 1 of 1) for {site id=11,satellite=S1} Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.092 INFO [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Starting job 'S1.S1-test_5000' Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.096 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel1} has 1 subqueries: d98793bc-b8a4-43ee-b0fc-b79af31b9562 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.100 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=0&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.108 DEBUG [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] Retry failed products Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.122 TRACE [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - Validating S2 tile filter for site test_5000 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.144 INFO [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] No products to retry Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.145 DEBUG [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] Retry last chance products Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.157 INFO [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] No products to retry Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.157 INFO [DefaultQuartzScheduler_Worker-4] o.e.s.scheduling.RetryJob - Job 'Retry.Retry-s1-test_5000' completed Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.157 DEBUG [DefaultQuartzScheduler_Worker-4] o.e.s.services.ScheduleManager - Trigger 'Retry.Retry-s1-test_5000' completed with code 'NOOP' Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.173 DEBUG [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] Retry failed products Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.185 INFO [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] No products to retry Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.186 DEBUG [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] Retry last chance products Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.199 INFO [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] No products to retry Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.209 INFO [DefaultQuartzScheduler_Worker-5] o.e.s.scheduling.RetryJob - Job 'Retry.Retry-s2-test_5000' completed Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.210 DEBUG [DefaultQuartzScheduler_Worker-5] o.e.s.services.ScheduleManager - Trigger 'Retry.Retry-s2-test_5000' completed with code 'NOOP' Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.335 INFO [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Found 0 stalled products Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.338 INFO [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Found 0 products eligible for pre-processing Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.363 TRACE [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - No S2 tiles were discarded. Filter has 1 tiles. Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.365 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel2'] Performing query for interval 2019-09-01T00:00 - 2020-11-30T23:59:59 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.365 TRACE [DefaultQuartzScheduler_Worker-3] o.esa.sen2agri.commons.Config - Requested worker for Scientific Data Hub,S2 (active workers: 0, queued tasks: 0) Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.397 DEBUG [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Sentinel-1 pre-processing enabled for polarisations VH,VV Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.417 TRACE [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - Query timeout is set to 90000 s Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.446 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #1 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.447 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 50054f8f-064f-4c36-81fc-26bb1815ee4d Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.448 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 50054f8f-064f-4c36-81fc-26bb1815ee4d: https://scihub.copernicus.eu/dhus/search?rows=50&start=0&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.457 DEBUG [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Sentinel-1 pre-processing will use S1B products as master Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.457 DEBUG [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Execution parallelism set to 1 Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.457 INFO [DefaultQuartzScheduler_Worker-6] o.e.s.s.Sentinel1Level2Job - Job 'S1.S1-test_5000' completed Mar 18 10:03:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:13.457 DEBUG [DefaultQuartzScheduler_Worker-6] o.e.s.services.ScheduleManager - Trigger 'S1.S1-test_5000' completed with code 'NOOP' Mar 18 10:03:37 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:37.170 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 50054f8f-064f-4c36-81fc-26bb1815ee4d page 1 returned 50 products Mar 18 10:03:37 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:37.170 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 50054f8f-064f-4c36-81fc-26bb1815ee4d: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:03:41 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:41.081 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 1 returned 50 products Mar 18 10:03:41 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:41.081 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:03:49 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:49.917 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 50054f8f-064f-4c36-81fc-26bb1815ee4d page 2 returned 50 products Mar 18 10:03:49 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:49.917 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 50054f8f-064f-4c36-81fc-26bb1815ee4d: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:03:58 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:58.967 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 2 returned 50 products Mar 18 10:03:58 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:03:58.968 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:04:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:01.293 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 50054f8f-064f-4c36-81fc-26bb1815ee4d page 3 returned 50 products Mar 18 10:04:01 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:01.294 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 50054f8f-064f-4c36-81fc-26bb1815ee4d: https://scihub.copernicus.eu/dhus/search?rows=50&start=150&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.785 INFO [DefaultQuartzScheduler_Worker-7] o.e.s.scheduling.ReportJob - Starting job 'Reports.Reports' Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.812 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 3 returned 50 products Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.818 DEBUG [DefaultQuartzScheduler_Worker-7] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.812 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=150&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.829 DEBUG [DefaultQuartzScheduler_Worker-7] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.842 DEBUG [DefaultQuartzScheduler_Worker-7] o.e.s.scheduling.ReportJob - Report for S1 pre-processing added new 0 rows Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.842 INFO [DefaultQuartzScheduler_Worker-7] o.e.s.scheduling.ReportJob - Job 'Reports.Reports' completed Mar 18 10:04:02 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:02.842 DEBUG [DefaultQuartzScheduler_Worker-7] o.e.s.services.ScheduleManager - Trigger 'Reports.Reports' completed with code 'NOOP' Mar 18 10:04:05 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:05.913 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 4 returned 50 products Mar 18 10:04:05 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:05.913 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=200&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.211 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 5 returned 50 products Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.211 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=250&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.697 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query d98793bc-b8a4-43ee-b0fc-b79af31b9562 page 6 returned 9 products Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.697 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query d98793bc-b8a4-43ee-b0fc-b79af31b9562: https://scihub.copernicus.eu/dhus/search?rows=50&start=300&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.736 WARN [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - At least one query failed for site test_5000 (reason: ro.cs.tao.datasource.QueryException: The request was not successful. Reason: Too Many Requests). It was saved in '/mnt/archive/dwn_def/s1/default/test_5000/failed_queries' and will be retried later. Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.739 TRACE [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - No S1 products were discarded. Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.761 INFO [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel1'] Found 0 products for site test_5000 and satellite S1 Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.767 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - Actual products to download for site test_5000 and satellite S1: 0 Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.767 INFO [DefaultQuartzScheduler_Worker-2] o.e.s.scheduling.LookupJob - Job 'Lookup.Lookup-s1-test_5000' completed Mar 18 10:04:09 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:09.768 DEBUG [DefaultQuartzScheduler_Worker-2] o.e.s.services.ScheduleManager - Trigger 'Lookup.Lookup-s1-test_5000' completed with code 'NOOP' Mar 18 10:04:11 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:11.513 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 50054f8f-064f-4c36-81fc-26bb1815ee4d page 4 returned 37 products Mar 18 10:04:11 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:11.514 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 50054f8f-064f-4c36-81fc-26bb1815ee4d: https://scihub.copernicus.eu/dhus/search?rows=50&start=200&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.517 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 50054f8f-064f-4c36-81fc-26bb1815ee4d page 5 returned 0 products Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.518 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 187 products Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.518 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 66072 ms. Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.520 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #1 (query 1 of 1) for {site id=11,satellite=S2} returned 187 results Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.520 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #2 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.520 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 69975b05-b2c6-49d1-857a-7c7a248d556a Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.521 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 69975b05-b2c6-49d1-857a-7c7a248d556a: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.813 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 69975b05-b2c6-49d1-857a-7c7a248d556a page 2 returned 50 products Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.813 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 50 products Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.813 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 293 ms. Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.813 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #2 (query 1 of 1) for {site id=11,satellite=S2} returned 50 results Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.813 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #3 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.814 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 9a232a66-f58f-4b06-a238-e41fb281b761 Mar 18 10:04:19 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:19.814 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 9a232a66-f58f-4b06-a238-e41fb281b761: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.037 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 9a232a66-f58f-4b06-a238-e41fb281b761 page 3 returned 50 products Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.037 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 50 products Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.038 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 225 ms. Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.038 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #3 (query 1 of 1) for {site id=11,satellite=S2} returned 50 results Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.038 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #4 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.038 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: fc807534-da6d-40c8-bad1-48fab2ef7673 Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.039 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query fc807534-da6d-40c8-bad1-48fab2ef7673: https://scihub.copernicus.eu/dhus/search?rows=50&start=150&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query fc807534-da6d-40c8-bad1-48fab2ef7673 page 4 returned 37 products Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 37 products Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 254 ms. Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #4 (query 1 of 1) for {site id=11,satellite=S2} returned 37 results Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #5 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 96df6d2b-37f7-4c89-8fe6-ac6f8bab7746 Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.292 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 96df6d2b-37f7-4c89-8fe6-ac6f8bab7746: https://scihub.copernicus.eu/dhus/search?rows=50&start=200&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.348 WARN [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - At least one query failed for site test_5000 (reason: ro.cs.tao.datasource.QueryException: The request was not successful. Reason: Too Many Requests). It was saved in '/mnt/archive/dwn_def/s2/default/test_5000/failed_queries' and will be retried later. Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.355 TRACE [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - No S2 products were discarded. Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.361 INFO [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel2'] Found 0 products for site test_5000 and satellite S2 Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.369 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - Actual products to download for site test_5000 and satellite S2: 0 Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.369 INFO [DefaultQuartzScheduler_Worker-3] o.e.s.scheduling.LookupJob - Job 'Lookup.Lookup-s2-test_5000' completed Mar 18 10:04:20 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:04:20.369 DEBUG [DefaultQuartzScheduler_Worker-3] o.e.s.services.ScheduleManager - Trigger 'Lookup.Lookup-s2-test_5000' completed with code 'NOOP' Mar 18 10:08:46 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:08:46.973 DEBUG [http-nio-8080-exec-5] o.e.s.db.PersistenceManager - Sensor Sentinel3 is not supported in Sen2Agri Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.874 INFO [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - Starting job 'Lookup.Lookup-s1-test_5000' Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.885 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Seasons defined: 2020 [2019-11-01,2020-04-30,2020-11-30] Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.897 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Using start date: 2019-10-26T00:00 and end date: 2020-11-30T23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.898 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel1'] Lookup for new products in range 2019-10-26 00:00:00 - 2020-11-30 23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.901 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel1'] Performing query for interval 2019-10-26T00:00 - 2020-11-30T23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.901 TRACE [DefaultQuartzScheduler_Worker-8] o.esa.sen2agri.commons.Config - Requested worker for Scientific Data Hub,S1 (active workers: 0, queued tasks: 0) Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.907 TRACE [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - Query timeout is set to 90000 s Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.913 DEBUG [Scientific Data Hub-S1-1] o.e.s.s.i.DownloadServiceImpl - Querying page #1 (query 1 of 1) for {site id=11,satellite=S1} Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.915 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel1} has 1 subqueries: b411a5b5-09e4-43da-974e-9b0739a29204 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.915 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query b411a5b5-09e4-43da-974e-9b0739a29204: https://scihub.copernicus.eu/dhus/search?rows=50&start=0&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.935 INFO [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - Starting job 'Lookup.Lookup-s2-test_5000' Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.946 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Seasons defined: 2020 [2019-11-01,2020-04-30,2020-11-30] Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.965 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Using start date: 2019-09-01T00:00 and end date: 2020-11-30T23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.965 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - [site 'test_5000',sensor 'Sentinel2'] Lookup for new products in range 2019-09-01 00:00:00 - 2020-11-30 23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.971 TRACE [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - Validating S2 tile filter for site test_5000 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.971 TRACE [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - No S2 tiles were discarded. Filter has 1 tiles. Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.974 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel2'] Performing query for interval 2019-09-01T00:00 - 2020-11-30T23:59:59 Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.974 TRACE [DefaultQuartzScheduler_Worker-9] o.esa.sen2agri.commons.Config - Requested worker for Scientific Data Hub,S2 (active workers: 0, queued tasks: 0) Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.982 TRACE [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - Query timeout is set to 90000 s Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.991 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #1 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.991 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 11197eb2-8121-4220-98c0-9684f49b6b6d Mar 18 10:33:12 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:12.992 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 11197eb2-8121-4220-98c0-9684f49b6b6d: https://scihub.copernicus.eu/dhus/search?rows=50&start=0&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.002 INFO [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - Starting job 'Retry.Retry-s1-test_5000' Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.045 DEBUG [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] Retry failed products Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.047 INFO [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] No products to retry Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.047 DEBUG [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] Retry last chance products Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.048 INFO [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel1'] No products to retry Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.049 INFO [DefaultQuartzScheduler_Worker-10] o.e.s.scheduling.RetryJob - Job 'Retry.Retry-s1-test_5000' completed Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.049 DEBUG [DefaultQuartzScheduler_Worker-10] o.e.s.services.ScheduleManager - Trigger 'Retry.Retry-s1-test_5000' completed with code 'NOOP' Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.082 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - Starting job 'Retry.Retry-s2-test_5000' Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.102 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] Retry failed products Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.104 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] No products to retry Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.104 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] Retry last chance products Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.106 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - [site 'test_5000',sensor 'Sentinel2'] No products to retry Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.106 INFO [DefaultQuartzScheduler_Worker-1] o.e.s.scheduling.RetryJob - Job 'Retry.Retry-s2-test_5000' completed Mar 18 10:33:13 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:13.106 DEBUG [DefaultQuartzScheduler_Worker-1] o.e.s.services.ScheduleManager - Trigger 'Retry.Retry-s2-test_5000' completed with code 'NOOP' Mar 18 10:33:22 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:22.068 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query b411a5b5-09e4-43da-974e-9b0739a29204 page 1 returned 50 products Mar 18 10:33:22 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:22.068 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query b411a5b5-09e4-43da-974e-9b0739a29204: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:33:25 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:25.704 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 11197eb2-8121-4220-98c0-9684f49b6b6d page 1 returned 50 products Mar 18 10:33:25 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:25.704 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 11197eb2-8121-4220-98c0-9684f49b6b6d: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.684 INFO [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Query b411a5b5-09e4-43da-974e-9b0739a29204 page 2 returned 50 products Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.684 DEBUG [Scientific Data Hub-S1-1] r.c.t.d.r.s.SciHubDataQuery - Executing query b411a5b5-09e4-43da-974e-9b0739a29204: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=footprint%3A%22Intersects%28POLYGON%28%2811.1434%2045.252%2C11.1449%2045.2918%2C11.145%2045.2962%2C11.1514%2045.2961%2C11.2184%2045.2948%2C11.2247%2045.2947%2C11.2246%2045.2902%2C11.223%2045.2505%2C11.2228%2045.246%2C11.2165%2045.2461%2C11.1496%2045.2474%2C11.1432%2045.2475%2C11.1434%2045.252%29%29%29%22%20AND%20endPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20polarisationMode%3AVV%2BVH%20AND%20sensorOperationalMode%3AIW%20AND%20platformName%3ASentinel-1%20AND%20beginPosition%3A%5B2019-10-26T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3ASLC&orderby=beginposition%20asc Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.713 WARN [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - At least one query failed for site test_5000 (reason: ro.cs.tao.datasource.QueryException: The request was not successful. Reason: Too Many Requests). It was saved in '/mnt/archive/dwn_def/s1/default/test_5000/failed_queries' and will be retried later. Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.714 TRACE [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - No S1 products were discarded. Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.718 INFO [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel1'] Found 0 products for site test_5000 and satellite S1 Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.724 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - Actual products to download for site test_5000 and satellite S1: 0 Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.724 INFO [DefaultQuartzScheduler_Worker-8] o.e.s.scheduling.LookupJob - Job 'Lookup.Lookup-s1-test_5000' completed Mar 18 10:33:26 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:26.724 DEBUG [DefaultQuartzScheduler_Worker-8] o.e.s.services.ScheduleManager - Trigger 'Lookup.Lookup-s1-test_5000' completed with code 'NOOP' Mar 18 10:33:35 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:35.094 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 11197eb2-8121-4220-98c0-9684f49b6b6d page 2 returned 50 products Mar 18 10:33:35 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:35.094 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 11197eb2-8121-4220-98c0-9684f49b6b6d: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:43 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:43.127 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 11197eb2-8121-4220-98c0-9684f49b6b6d page 3 returned 50 products Mar 18 10:33:43 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:43.127 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 11197eb2-8121-4220-98c0-9684f49b6b6d: https://scihub.copernicus.eu/dhus/search?rows=50&start=150&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.546 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 11197eb2-8121-4220-98c0-9684f49b6b6d page 4 returned 37 products Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.546 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 11197eb2-8121-4220-98c0-9684f49b6b6d: https://scihub.copernicus.eu/dhus/search?rows=50&start=200&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.621 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 11197eb2-8121-4220-98c0-9684f49b6b6d page 5 returned 0 products Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.621 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 187 products Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.622 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 38631 ms. Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.622 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #1 (query 1 of 1) for {site id=11,satellite=S2} returned 187 results Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.622 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #2 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.623 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: 63458ade-6c4f-4676-8d5f-f743c674b87f Mar 18 10:33:51 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:51.623 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query 63458ade-6c4f-4676-8d5f-f743c674b87f: https://scihub.copernicus.eu/dhus/search?rows=50&start=50&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.734 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query 63458ade-6c4f-4676-8d5f-f743c674b87f page 2 returned 50 products Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.734 INFO [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} returned 50 products Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.734 TRACE [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Data query completed in 1112 ms. Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.734 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Page #2 (query 1 of 1) for {site id=11,satellite=S2} returned 50 results Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.734 DEBUG [Scientific Data Hub-S2-1] o.e.s.s.i.DownloadServiceImpl - Querying page #3 (query 1 of 1) for {site id=11,satellite=S2} Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.735 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Query {Scientific Data Hub-Sentinel2} has 1 subqueries: edaee89a-e77f-4c60-8264-f3b30eaf1454 Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.735 DEBUG [Scientific Data Hub-S2-1] r.c.t.d.r.s.SciHubDataQuery - Executing query edaee89a-e77f-4c60-8264-f3b30eaf1454: https://scihub.copernicus.eu/dhus/search?rows=50&start=100&q=endPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20filename%3A*32TPR*%20AND%20platformName%3ASentinel-2%20AND%20beginPosition%3A%5B2019-09-01T02%3A00%3A00.000Z%20TO%202020-12-01T00%3A59%3A59.000Z%5D%20AND%20productType%3AS2MSI1C&orderby=beginposition%20asc Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.769 WARN [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - At least one query failed for site test_5000 (reason: ro.cs.tao.datasource.QueryException: The request was not successful. Reason: Too Many Requests). It was saved in '/mnt/archive/dwn_def/s2/default/test_5000/failed_queries' and will be retried later. Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.788 TRACE [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - No S2 products were discarded. Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.797 INFO [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - [site 'Test_5000',sensor 'Sentinel2'] Found 0 products for site test_5000 and satellite S2 Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.805 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - Actual products to download for site test_5000 and satellite S2: 0 Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.805 INFO [DefaultQuartzScheduler_Worker-9] o.e.s.scheduling.LookupJob - Job 'Lookup.Lookup-s2-test_5000' completed Mar 18 10:33:52 CentOS7-x64 start.sh[2456]: 2021-Mar-18 10:33:52.805 DEBUG [DefaultQuartzScheduler_Worker-9] o.e.s.services.ScheduleManager - Trigger 'Lookup.Lookup-s2-test_5000' completed with code 'NOOP'