[15:56:26.215] New invocation is queued and will start shortly
[15:56:27.278] Starting the invocation (attempt 1)
[15:56:27.309] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:56:27.309] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:56:27.310] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071471347380159104",
"parameters_json": "{\"builder_name\":\"ToTAndroid x64\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d254c22c89f7ecf850b92dd1b85e9836612d031b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTAndroid x64",
"scheduler_invocation_id:9071471347380159104",
"scheduler_job_id:chromium/ToTAndroid x64",
"user_agent:luci-scheduler",
"buildset:commit/git/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"gitiles_ref:refs/heads/master"
]
}
[15:56:28.053] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564934187458360",
"id": "8906041285410037648",
"parameters_json": "{\"builder_name\": \"ToTAndroid x64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d254c22c89f7ecf850b92dd1b85e9836612d031b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564934187943782",
"tags": [
"build_address:luci.chromium.ci/ToTAndroid x64/6154",
"builder:ToTAndroid x64",
"buildset:commit/git/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071471347380159104",
"scheduler_job_id:chromium/ToTAndroid x64",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8906041285410037648/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1564934187943874",
"url": "https://ci.chromium.org/b/8906041285410037648",
"utcnow_ts": "1564934188039451"
}
}
[15:56:28.053] Task URL: https://ci.chromium.org/b/8906041285410037648
[15:56:28.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:2:0) after 1m0s
[15:57:09.729] Received PubSub notification, asking Buildbucket for the build status
[15:57:09.821] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:30.742] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:2:0)
[15:57:30.742] Timer tick, asking Buildbucket for the build status
[15:57:30.925] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:30.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:4:0) after 1m0s
[15:58:31.666] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:4:0)
[15:58:31.666] Timer tick, asking Buildbucket for the build status
[15:58:31.798] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:31.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:5:0) after 1m0s
[15:59:31.796] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:5:0)
[15:59:31.796] Timer tick, asking Buildbucket for the build status
[15:59:31.951] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:31.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:6:0) after 1m0s
[16:00:32.298] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:6:0)
[16:00:32.298] Timer tick, asking Buildbucket for the build status
[16:00:32.675] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:32.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:7:0) after 1m0s
[16:01:32.703] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:7:0)
[16:01:32.703] Timer tick, asking Buildbucket for the build status
[16:01:32.903] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:32.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:8:0) after 1m0s
[16:02:33.229] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:8:0)
[16:02:33.229] Timer tick, asking Buildbucket for the build status
[16:02:34.199] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:34.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:9:0) after 1m0s
[16:03:34.272] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:9:0)
[16:03:34.273] Timer tick, asking Buildbucket for the build status
[16:03:34.457] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:34.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:10:0) after 1m0s
[16:04:34.751] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:10:0)
[16:04:34.751] Timer tick, asking Buildbucket for the build status
[16:04:35.341] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:35.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:11:0) after 1m0s
[16:05:35.480] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:11:0)
[16:05:35.480] Timer tick, asking Buildbucket for the build status
[16:05:35.903] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:35.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:12:0) after 1m0s
[16:06:35.963] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:12:0)
[16:06:35.963] Timer tick, asking Buildbucket for the build status
[16:06:36.166] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:36.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:13:0) after 1m0s
[16:07:36.239] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:13:0)
[16:07:36.239] Timer tick, asking Buildbucket for the build status
[16:07:37.111] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:37.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:14:0) after 1m0s
[16:08:37.218] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:14:0)
[16:08:37.218] Timer tick, asking Buildbucket for the build status
[16:08:37.476] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:37.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:15:0) after 1m0s
[16:09:37.594] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:15:0)
[16:09:37.594] Timer tick, asking Buildbucket for the build status
[16:09:38.038] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:38.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:16:0) after 1m0s
[16:10:38.158] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:16:0)
[16:10:38.158] Timer tick, asking Buildbucket for the build status
[16:10:38.418] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:38.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:17:0) after 1m0s
[16:11:38.468] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:17:0)
[16:11:38.468] Timer tick, asking Buildbucket for the build status
[16:11:39.022] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:39.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:18:0) after 1m0s
[16:12:39.048] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:18:0)
[16:12:39.048] Timer tick, asking Buildbucket for the build status
[16:12:39.549] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:39.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:19:0) after 1m0s
[16:13:39.576] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:19:0)
[16:13:39.576] Timer tick, asking Buildbucket for the build status
[16:13:40.223] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:20:0) after 1m0s
[16:14:40.406] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:20:0)
[16:14:40.406] Timer tick, asking Buildbucket for the build status
[16:14:41.083] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:41.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:21:0) after 1m0s
[16:15:41.231] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:21:0)
[16:15:41.231] Timer tick, asking Buildbucket for the build status
[16:15:41.397] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:41.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:22:0) after 1m0s
[16:16:41.401] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:22:0)
[16:16:41.401] Timer tick, asking Buildbucket for the build status
[16:16:42.010] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:42.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:23:0) after 1m0s
[16:17:42.016] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:23:0)
[16:17:42.016] Timer tick, asking Buildbucket for the build status
[16:17:42.292] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:42.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:24:0) after 1m0s
[16:18:42.311] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:24:0)
[16:18:42.311] Timer tick, asking Buildbucket for the build status
[16:18:42.797] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:42.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:25:0) after 1m0s
[16:19:42.817] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:25:0)
[16:19:42.817] Timer tick, asking Buildbucket for the build status
[16:19:42.980] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:42.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:26:0) after 1m0s
[16:20:43.007] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:26:0)
[16:20:43.007] Timer tick, asking Buildbucket for the build status
[16:20:43.246] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:43.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:27:0) after 1m0s
[16:21:43.268] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:27:0)
[16:21:43.268] Timer tick, asking Buildbucket for the build status
[16:21:43.837] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:43.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:28:0) after 1m0s
[16:22:44.178] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:28:0)
[16:22:44.178] Timer tick, asking Buildbucket for the build status
[16:22:44.362] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:44.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:29:0) after 1m0s
[16:23:44.393] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:29:0)
[16:23:44.393] Timer tick, asking Buildbucket for the build status
[16:23:44.545] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:44.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:30:0) after 1m0s
[16:24:44.611] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:30:0)
[16:24:44.611] Timer tick, asking Buildbucket for the build status
[16:24:45.347] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:45.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:31:0) after 1m0s
[16:25:45.420] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:31:0)
[16:25:45.420] Timer tick, asking Buildbucket for the build status
[16:25:45.646] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:45.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:32:0) after 1m0s
[16:26:45.967] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:32:0)
[16:26:45.967] Timer tick, asking Buildbucket for the build status
[16:26:46.131] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:46.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:33:0) after 1m0s
[16:27:46.399] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:33:0)
[16:27:46.399] Timer tick, asking Buildbucket for the build status
[16:27:48.309] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:48.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:34:0) after 1m0s
[16:28:48.661] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:34:0)
[16:28:48.661] Timer tick, asking Buildbucket for the build status
[16:28:48.891] Build 8906041285410037648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:48.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x64:9071471347380159104:35:0) after 1m0s
[16:28:53.928] Received PubSub notification, asking Buildbucket for the build status
[16:28:55.318] Build 8906041285410037648: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:28:55.318] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564936133458717",
"created_by": "project:chromium",
"created_ts": "1564934187458360",
"failure_reason": "BUILD_FAILURE",
"id": "8906041285410037648",
"parameters_json": "{\"builder_name\": \"ToTAndroid x64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d254c22c89f7ecf850b92dd1b85e9836612d031b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"```\\n[2/79250] CC android_clang_x86/obj/third_party/ffmpeg/ffmpeg_internal/mdct_float.o\\nFAILED: android_clang_x86/obj/third_party/ffmpeg/ffmpeg_internal/mdct_float.o\\n../../third_party/llvm-build/Release+Asserts/bin/c...\\nclang: error: argument unused during compilation: '-momit-leaf-frame-pointer' [-Werror,-Wunused-command-line-argument]\\n```\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-32-0-sbsi\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTAndroid x64\", \"buildnumber\": 6154, \"got_angle_revision\": \"dc2c5c5a419e45891ec5898e675b8f447b1bd9fa\", \"got_clang_revision\": \"367785-6d83ab08-0\", \"got_dawn_revision\": \"bfc9cee5d3bea7e37ff26f2952d2d112f3776790\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"d254c22c89f7ecf850b92dd1b85e9836612d031b\", \"got_revision_cp\": \"refs/heads/master@{#683881}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7550297429f9368192c5ef4570696526e8e0b773\", \"got_v8_revision_cp\": \"refs/heads/7.8.58@{#1}\", \"got_webrtc_revision\": \"fedd625e0cc634a6ae12683e7bf61f6bc01e677d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28752}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d254c22c89f7ecf850b92dd1b85e9836612d031b\"}, \"ui\": {\"info\": \"```\\n[2/79250] CC android_clang_x86/obj/third_party/ffmpeg/ffmpeg_internal/mdct_float.o\\nFAILED: android_clang_x86/obj/third_party/ffmpeg/ffmpeg_internal/mdct_float.o\\n../../third_party/llvm-build/Release+Asserts/bin/c...\\nclang: error: argument unused during compilation: '-momit-leaf-frame-pointer' [-Werror,-Wunused-command-line-argument]\\n```\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564934228376020",
"status": "COMPLETED",
"status_changed_ts": "1564934187943782",
"tags": [
"build_address:luci.chromium.ci/ToTAndroid x64/6154",
"builder:ToTAndroid x64",
"buildset:commit/git/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d254c22c89f7ecf850b92dd1b85e9836612d031b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071471347380159104",
"scheduler_job_id:chromium/ToTAndroid x64",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8906041285410037648/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:46762a346c97ac10",
"user_agent:luci-scheduler"
],
"updated_ts": "1564936133572424",
"url": "https://ci.chromium.org/b/8906041285410037648",
"utcnow_ts": "1564936135256994"
}
}
[16:28:55.318] Invocation finished in 32m29.121638433s with status FAILED