[2026-05-12T16:29:01.603311] Job 156282 queued by schedule:2026-05-12T16:29:00 Connection: Lemonsoda (meta_ads) Sync template: Meta Ads - Incremental Sync Queue class: foreground Procrastinate queue: kpiper Command: python meta_ads_pipeline.py [2026-05-12T16:29:02.758058] Queued via Procrastinate as job 155133 (queue=kpiper, priority=50). [2026-05-12T16:46:50.273376] Starting job 156282 for connection Lemonsoda (meta_ads) / sync template Meta Ads - Incremental Sync (type=dlt) Resolved command: cd /srv/kpiper && python meta_ads_pipeline.py Injected profile context env vars (tokens exported: 1). Pipeline env overrides applied: AD_ACCOUNT_ID, BACKFILL_CHUNK_DAYS, CAMPAIGN_TOTALS_LOOKBACK_DAYS, ENABLE_ACCOUNT_INSIGHTS, ENABLE_ADS, ENABLE_AD_ACCOUNT_OBJECTS, ENABLE_AD_INSIGHTS, ENABLE_AD_SETS, ENABLE_AD_SET_INSIGHTS, ENABLE_CAMPAIGNS, ENABLE_CAMPAIGN_INSIGHTS, ENABLE_CAMPAIGN_TOTALS_SNAPSHOT, INSIGHTS_FIELDS, INSIGHTS_LOOKBACK_DAYS, INSIGHT_WINDOW_DAYS, OBJECT_LIMIT, PAGE_SIZE, SOURCES__META_ADS_REST_API_SOURCE__ACCESS_TOKEN, SYNC_MODE Synced Meta system user token at 2026-05-12T16:46:50.250834. Forced unbuffered Python output for child process. /usr/local/lib/python3.11/site-packages/dlt/pipeline/progress.py:27: UserWarning: psutil dependency is not installed and memory stats will not be available. Add psutil to your environment or pass dump_system_stats=False to disable this warning. return log() ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 0/11 (0.0%) | Time: 0.00s | Rate: 0.00/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 0/11 (0.0%) | Time: 0.52s | Rate: 0.00/s ad_account_objects: 1 | Time: 0.00s | Rate: 99864.38/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 0/11 (0.0%) | Time: 2.44s | Rate: 0.00/s ad_account_objects: 1 | Time: 1.91s | Rate: 0.52/s campaign_objects: 1 | Time: 0.00s | Rate: 40721.40/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 2/11 (18.2%) | Time: 3.00s | Rate: 0.67/s ad_account_objects: 1 | Time: 2.48s | Rate: 0.40/s campaign_objects: 1 | Time: 0.57s | Rate: 1.76/s account_insight_values: 1 | Time: 0.00s | Rate: 119837.26/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 2/11 (18.2%) | Time: 3.85s | Rate: 0.52/s ad_account_objects: 1 | Time: 3.32s | Rate: 0.30/s campaign_objects: 1 | Time: 1.41s | Rate: 0.71/s account_insight_values: 1 | Time: 0.84s | Rate: 1.19/s campaign_insight_values: 1 | Time: 0.00s | Rate: 107546.26/s Meta Ads rate limit on account 402544838999792 (attempt 1/4); cooling down 30.0s. Error: {"error":{"message":"Application request limit reached","type":"OAuthException","is_transient":true,"code":4,"error_subcode":1504022,"error_user_title":"Too many API requests","error_user_msg":"There have been too many calls from this app. Wait a bit and try again. For more info, please refer to https:\/\/developers.facebook.com\/docs\/marketing-api\/insights\/best-practices\/#insightscallload.","fbtrace_id":"AU0Sj4C0_IAZrfLQO91XkaU"}} Cooling down Meta Ads requests for account 402544838999792 for 30.0s after rate limiting. Meta Ads rate limit on account 402544838999792 (attempt 1/4); cooling down 60.0s. Error: {"error":{"message":"Application request limit reached","type":"OAuthException","is_transient":true,"code":4,"error_subcode":1504022,"error_user_title":"Too many API requests","error_user_msg":"There have been too many calls from this app. Wait a bit and try again. For more info, please refer to https:\/\/developers.facebook.com\/docs\/marketing-api\/insights\/best-practices\/#insightscallload.","fbtrace_id":"AsIPJ_WupSbqh-KPoLLbQ8I"}} Cooling down Meta Ads requests for account 402544838999792 for 60.0s after rate limiting. ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 2/11 (18.2%) | Time: 108.01s | Rate: 0.02/s ad_account_objects: 1 | Time: 107.49s | Rate: 0.01/s campaign_objects: 1 | Time: 105.58s | Rate: 0.01/s account_insight_values: 1 | Time: 105.01s | Rate: 0.01/s campaign_insight_values: 1 | Time: 104.17s | Rate: 0.01/s campaign_total_snapshots: 1 | Time: 0.00s | Rate: 80659.69/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 11/11 (100.0%) | Time: 108.14s | Rate: 0.10/s ad_account_objects: 1 | Time: 107.62s | Rate: 0.01/s campaign_objects: 228 | Time: 105.70s | Rate: 2.16/s account_insight_values: 3 | Time: 105.14s | Rate: 0.03/s campaign_insight_values: 6 | Time: 104.29s | Rate: 0.06/s campaign_total_snapshots: 231 | Time: 0.13s | Rate: 1809.02/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 0/5 (0.0%) | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 0/5 (0.0%) | Time: 0.02s | Rate: 0.00/s ad_account_objects: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 1/5 (20.0%) | Time: 0.03s | Rate: 37.92/s ad_account_objects: 1 | Time: 0.01s | Rate: 196.54/s campaign_objects: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 2/5 (40.0%) | Time: 0.05s | Rate: 39.12/s ad_account_objects: 1 | Time: 0.03s | Rate: 33.51/s campaign_objects: 228 | Time: 0.02s | Rate: 9208.04/s account_insight_values: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 3/5 (60.0%) | Time: 0.06s | Rate: 53.63/s ad_account_objects: 1 | Time: 0.03s | Rate: 28.85/s campaign_objects: 228 | Time: 0.03s | Rate: 7708.07/s account_insight_values: 3 | Time: 0.00s | Rate: 621.62/s campaign_insight_values: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 4/5 (80.0%) | Time: 0.06s | Rate: 65.24/s ad_account_objects: 1 | Time: 0.04s | Rate: 24.98/s campaign_objects: 228 | Time: 0.03s | Rate: 6523.47/s account_insight_values: 3 | Time: 0.01s | Rate: 294.19/s campaign_insight_values: 6 | Time: 0.01s | Rate: 1115.11/s campaign_total_snapshots: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778604414.1503718 ----------- Files: 5/5 (100.0%) | Time: 0.19s | Rate: 26.99/s ad_account_objects: 1 | Time: 0.16s | Rate: 6.10/s campaign_objects: 228 | Time: 0.16s | Rate: 1435.23/s account_insight_values: 3 | Time: 0.13s | Rate: 22.37/s campaign_insight_values: 6 | Time: 0.13s | Rate: 46.41/s campaign_total_snapshots: 231 | Time: 0.12s | Rate: 1864.18/s ------------- Load meta_ads_rest_api_source in 1778604414.1503718 -------------- Jobs: 0/5 (0.0%) | Time: 0.00s | Rate: 0.00/s ------------- Load meta_ads_rest_api_source in 1778604414.1503718 -------------- Jobs: 10/10 (100.0%) | Time: 0.97s | Rate: 10.33/s Pipeline meta_ads_pipeline load step completed in 0.97 seconds 1 load package(s) were loaded to destination postgres and into dataset meta_ads The postgres destination used postgresql://kpiper_dlt_app:***@[/cloudsql/pacelab-487114:europe-west4:pacelab-pg18-ew4]:5432/kpiper_data location to store data Load package 1778604414.1503718 is LOADED and contains no failed jobs [2026-05-12T16:48:44.129294] Command completed successfully. [2026-05-12T16:48:44.129625] Pipeline status payload: {"ad_account_id": "402544838999792", "backfill_complete": true, "backfill_progress_mode": "incremental", "campaign_totals_effective_start_date": "2024-02-20", "campaign_totals_end_date": "2026-05-12", "campaign_totals_start_date": "2016-05-15", "requested_end_date": "2026-05-12", "requested_start_date": "2026-05-10", "sync_mode": "incremental"}