[2026-05-13T08:31:34.228965] Job 157479 queued by detail-backfill-auto Connection: WBF NYC (meta_ads) Sync template: Meta Ads - Detail Backfill Queue class: historical Procrastinate queue: kpiper-historical Command: python meta_ads_pipeline.py [2026-05-13T08:31:34.338440] Queued via Procrastinate as job 156330 (queue=kpiper-historical, priority=100). [2026-05-13T08:31:34.393506] Starting job 157479 for connection WBF NYC (meta_ads) / sync template Meta Ads - Detail Backfill (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, ENABLE_ACCOUNT_INSIGHTS, ENABLE_ADS, ENABLE_AD_ACCOUNT_OBJECTS, ENABLE_AD_INSIGHTS, ENABLE_AD_SETS, ENABLE_AD_SET_INSIGHTS, ENABLE_CAMPAIGNS, ENABLE_CAMPAIGN_INSIGHTS, 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-13T08:31:34.374798. Resuming historical backfill from 2025-09-13. 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 Meta Ads rate limit on account 1829488277102363 (attempt 1/4); cooling down 30.0s. Error: {"error":{"message":"User request limit reached","type":"OAuthException","is_transient":false,"code":17,"error_subcode":2446079,"error_user_title":"Ad Account Has Too Many API Calls","error_user_msg":"There have been too many calls from this ad-account. Please wait a bit and try again.","fbtrace_id":"A3y_PrwAJ1-fqpiw0Y696dM"}} Cooling down Meta Ads requests for account 1829488277102363 for 30.0s after rate limiting. Meta Ads rate limit on account 1829488277102363 (attempt 2/4); cooling down 60.0s. Error: {"error":{"message":"User request limit reached","type":"OAuthException","is_transient":false,"code":17,"error_subcode":2446079,"error_user_title":"Ad Account Has Too Many API Calls","error_user_msg":"There have been too many calls from this ad-account. Please wait a bit and try again.","fbtrace_id":"AtobRyyXlJDIlsVfdgiTzao"}} Cooling down Meta Ads requests for account 1829488277102363 for 60.0s after rate limiting. Meta Ads rate limit on account 1829488277102363 (attempt 3/4); cooling down 120.0s. Error: {"error":{"message":"User request limit reached","type":"OAuthException","is_transient":false,"code":17,"error_subcode":2446079,"error_user_title":"Ad Account Has Too Many API Calls","error_user_msg":"There have been too many calls from this ad-account. Please wait a bit and try again.","fbtrace_id":"AuUv0kAITjerfDtiI4MeYLr"}} Cooling down Meta Ads requests for account 1829488277102363 for 120.0s after rate limiting. Meta Ads rate limit on account 1829488277102363 (attempt 4/4); cooling down 240.0s. Error: {"error":{"message":"User request limit reached","type":"OAuthException","is_transient":false,"code":17,"error_subcode":2446079,"error_user_title":"Ad Account Has Too Many API Calls","error_user_msg":"There have been too many calls from this ad-account. Please wait a bit and try again.","fbtrace_id":"AtPXBPxts2rvfwimug2_gF0"}} Cooling down Meta Ads requests for account 1829488277102363 for 240.0s after rate limiting. ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 3/11 (27.3%) | Time: 458.82s | Rate: 0.01/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 3/11 (27.3%) | Time: 458.83s | Rate: 0.01/s ad_objects: 1 | Time: 0.00s | Rate: 61680.94/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 7/11 (63.6%) | Time: 460.93s | Rate: 0.02/s ad_objects: 1 | Time: 2.09s | Rate: 0.48/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 7/11 (63.6%) | Time: 460.94s | Rate: 0.02/s ad_objects: 1 | Time: 2.11s | Rate: 0.47/s ad_set_insight_values: 1 | Time: 0.00s | Rate: 74898.29/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 7/11 (63.6%) | Time: 462.30s | Rate: 0.02/s ad_objects: 1 | Time: 3.47s | Rate: 0.29/s ad_set_insight_values: 1 | Time: 1.36s | Rate: 0.73/s ad_insight_values: 1 | Time: 0.00s | Rate: 79137.81/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 7/11 (63.6%) | Time: 462.31s | Rate: 0.02/s ad_objects: 1 | Time: 3.47s | Rate: 0.29/s ad_set_insight_values: 1 | Time: 1.37s | Rate: 0.73/s ad_insight_values: 1 | Time: 0.01s | Rate: 191.46/s fetch_skips: 1 | Time: 0.00s | Rate: 182361.04/s ----------------------- Extract meta_ads_rest_api_source ----------------------- Resources: 11/11 (100.0%) | Time: 462.40s | Rate: 0.02/s ad_objects: 250 | Time: 3.56s | Rate: 70.19/s ad_set_insight_values: 4 | Time: 1.46s | Rate: 2.75/s ad_insight_values: 23 | Time: 0.09s | Rate: 243.60/s fetch_skips: 1 | Time: 0.09s | Rate: 11.21/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 0/4 (0.0%) | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 0/4 (0.0%) | Time: 0.03s | Rate: 0.00/s ad_objects: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 1/4 (25.0%) | Time: 0.06s | Rate: 17.37/s ad_objects: 250 | Time: 0.03s | Rate: 7999.51/s ad_set_insight_values: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 2/4 (50.0%) | Time: 0.06s | Rate: 31.80/s ad_objects: 250 | Time: 0.04s | Rate: 6830.76/s ad_set_insight_values: 4 | Time: 0.01s | Rate: 746.58/s ad_insight_values: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 3/4 (75.0%) | Time: 0.07s | Rate: 42.76/s ad_objects: 250 | Time: 0.04s | Rate: 5700.86/s ad_set_insight_values: 4 | Time: 0.01s | Rate: 317.17/s ad_insight_values: 23 | Time: 0.01s | Rate: 3168.11/s fetch_skips: 0 | Time: 0.00s | Rate: 0.00/s ----------- Normalize meta_ads_rest_api_source in 1778661098.3040268 ----------- Files: 4/4 (100.0%) | Time: 0.10s | Rate: 40.45/s ad_objects: 250 | Time: 0.07s | Rate: 3444.56/s ad_set_insight_values: 4 | Time: 0.04s | Rate: 96.77/s ad_insight_values: 23 | Time: 0.04s | Rate: 639.16/s fetch_skips: 1 | Time: 0.03s | Rate: 34.81/s ------------- Load meta_ads_rest_api_source in 1778661098.3040268 -------------- Jobs: 0/4 (0.0%) | Time: 0.00s | Rate: 0.00/s ------------- Load meta_ads_rest_api_source in 1778661098.3040268 -------------- Jobs: 8/8 (100.0%) | Time: 0.77s | Rate: 10.41/s Pipeline meta_ads_pipeline load step completed in 0.77 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 1778661098.3040268 is LOADED and contains no failed jobs [2026-05-13T08:39:22.600757] Command completed successfully. [2026-05-13T08:39:22.601069] Pipeline status payload: {"ad_account_id": "1829488277102363", "backfill_chunk_days": 3, "backfill_complete": false, "backfill_next_start": "2025-09-16", "backfill_progress_mode": "chunked", "backfill_target_end": "2026-05-12", "backfill_target_start": "2025-05-13", "backfill_window_end": "2025-09-15", "backfill_window_start": "2025-09-13", "requested_end_date": "2026-05-13", "requested_start_date": "2025-05-14", "sync_mode": "historical"} [2026-05-13T08:39:23.919413] Meta Ads detail repair remains incomplete; queued follow-up chunk as job 157496. [2026-05-13T08:39:23.919763] Historical chunk runtime 468.2s >= 180s threshold.