[04:21:08.932] New invocation is queued and will start shortly
[04:21:10.016] Starting the invocation (attempt 1)
[04:21:10.053] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:21:10.053] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:21:10.053] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064539124708382464",
"parameters_json": "{\"builder_name\":\"ToTAndroidOfficial\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTAndroidOfficial",
"scheduler_invocation_id:9064539124708382464",
"scheduler_job_id:chromium/ToTAndroidOfficial",
"user_agent:luci-scheduler",
"buildset:commit/git/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"gitiles_ref:refs/heads/master"
]
}
[04:21:10.952] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571545270227914",
"id": "8899109062684342752",
"parameters_json": "{\"builder_name\": \"ToTAndroidOfficial\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571545270758849",
"tags": [
"build_address:luci.chromium.ci/ToTAndroidOfficial/5011",
"builder:ToTAndroidOfficial",
"buildset:commit/git/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064539124708382464",
"scheduler_job_id:chromium/ToTAndroidOfficial",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899109062684342752/+/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": "1571545270758996",
"url": "https://ci.chromium.org/b/8899109062684342752",
"utcnow_ts": "1571545270940635"
}
}
[04:21:10.952] Task URL: https://ci.chromium.org/b/8899109062684342752
[04:21:10.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:2:0) after 1m0s
[04:21:36.121] Received PubSub notification, asking Buildbucket for the build status
[04:21:36.604] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:11.204] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:2:0)
[04:22:11.204] Timer tick, asking Buildbucket for the build status
[04:22:11.357] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:11.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:4:0) after 1m0s
[04:23:11.541] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:4:0)
[04:23:11.541] Timer tick, asking Buildbucket for the build status
[04:23:11.750] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:11.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:5:0) after 1m0s
[04:24:11.922] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:5:0)
[04:24:11.922] Timer tick, asking Buildbucket for the build status
[04:24:12.122] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:6:0) after 1m0s
[04:25:12.499] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:6:0)
[04:25:12.499] Timer tick, asking Buildbucket for the build status
[04:25:17.169] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:17.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:7:0) after 1m0s
[04:26:17.191] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:7:0)
[04:26:17.191] Timer tick, asking Buildbucket for the build status
[04:26:18.510] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:18.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:8:0) after 1m0s
[04:27:18.586] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:8:0)
[04:27:18.586] Timer tick, asking Buildbucket for the build status
[04:27:19.061] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:19.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:9:0) after 1m0s
[04:28:19.085] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:9:0)
[04:28:19.085] Timer tick, asking Buildbucket for the build status
[04:28:19.641] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:19.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:10:0) after 1m0s
[04:29:19.667] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:10:0)
[04:29:19.667] Timer tick, asking Buildbucket for the build status
[04:29:19.809] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:19.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:11:0) after 1m0s
[04:30:20.003] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:11:0)
[04:30:20.003] Timer tick, asking Buildbucket for the build status
[04:30:21.331] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:12:0) after 1m0s
[04:31:21.358] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:12:0)
[04:31:21.358] Timer tick, asking Buildbucket for the build status
[04:31:21.620] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:21.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:13:0) after 1m0s
[04:32:21.641] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:13:0)
[04:32:21.641] Timer tick, asking Buildbucket for the build status
[04:32:22.627] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:22.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:14:0) after 1m0s
[04:33:22.715] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:14:0)
[04:33:22.715] Timer tick, asking Buildbucket for the build status
[04:33:23.082] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:23.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:15:0) after 1m0s
[04:34:23.124] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:15:0)
[04:34:23.124] Timer tick, asking Buildbucket for the build status
[04:34:23.330] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:23.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:16:0) after 1m0s
[04:35:23.395] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:16:0)
[04:35:23.395] Timer tick, asking Buildbucket for the build status
[04:35:24.814] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:17:0) after 1m0s
[04:36:24.831] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:17:0)
[04:36:24.831] Timer tick, asking Buildbucket for the build status
[04:36:25.700] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:18:0) after 1m0s
[04:37:25.752] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:18:0)
[04:37:25.752] Timer tick, asking Buildbucket for the build status
[04:37:28.719] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:28.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:19:0) after 1m0s
[04:38:28.715] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:19:0)
[04:38:28.715] Timer tick, asking Buildbucket for the build status
[04:38:29.859] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:29.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:20:0) after 1m0s
[04:39:29.881] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:20:0)
[04:39:29.881] Timer tick, asking Buildbucket for the build status
[04:39:30.664] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:30.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:21:0) after 1m0s
[04:40:30.786] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:21:0)
[04:40:30.786] Timer tick, asking Buildbucket for the build status
[04:40:32.313] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:22:0) after 1m0s
[04:41:32.390] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:22:0)
[04:41:32.390] Timer tick, asking Buildbucket for the build status
[04:41:32.899] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:32.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:23:0) after 1m0s
[04:42:32.885] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:23:0)
[04:42:32.885] Timer tick, asking Buildbucket for the build status
[04:42:33.080] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:33.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:24:0) after 1m0s
[04:43:33.175] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:24:0)
[04:43:33.175] Timer tick, asking Buildbucket for the build status
[04:43:34.193] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:34.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:25:0) after 1m0s
[04:44:34.223] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:25:0)
[04:44:34.223] Timer tick, asking Buildbucket for the build status
[04:44:34.945] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:34.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:26:0) after 1m0s
[04:45:34.988] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:26:0)
[04:45:34.988] Timer tick, asking Buildbucket for the build status
[04:45:35.161] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:35.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:27:0) after 1m0s
[04:46:35.192] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:27:0)
[04:46:35.192] Timer tick, asking Buildbucket for the build status
[04:46:35.682] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:35.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:28:0) after 1m0s
[04:47:35.714] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:28:0)
[04:47:35.714] Timer tick, asking Buildbucket for the build status
[04:47:35.992] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:35.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:29:0) after 1m0s
[04:48:36.017] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:29:0)
[04:48:36.017] Timer tick, asking Buildbucket for the build status
[04:48:36.257] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:30:0) after 1m0s
[04:49:36.277] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:30:0)
[04:49:36.277] Timer tick, asking Buildbucket for the build status
[04:49:36.484] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:36.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:31:0) after 1m0s
[04:50:36.559] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:31:0)
[04:50:36.559] Timer tick, asking Buildbucket for the build status
[04:50:36.745] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:36.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:32:0) after 1m0s
[04:51:36.792] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:32:0)
[04:51:36.792] Timer tick, asking Buildbucket for the build status
[04:51:36.983] Build 8899109062684342752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:36.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroidOfficial:9064539124708382464:33:0) after 1m0s
[04:51:58.044] Received PubSub notification, asking Buildbucket for the build status
[04:51:58.427] Build 8899109062684342752: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:51:58.427] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571547117098591",
"created_by": "project:chromium",
"created_ts": "1571545270227914",
"failure_reason": "BUILD_FAILURE",
"id": "8899109062684342752",
"parameters_json": "{\"builder_name\": \"ToTAndroidOfficial\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[43/84669] CXX obj/buildtools/third_party/libunwind/libunwind/libunwind.o\\nFAILED: obj/buildtools/third_party/libunwind/libunwind/libunwind.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/buildtools/third_party/libunwi...(too long)\\nIn file included from ../../buildtools/third_party/libunwind/trunk/src/libunwind.cpp:29:\\n../../buildtools/third_party/libunwind/trunk/src/UnwindCursor.hpp:1344:51: error: operator '?:' has lower precedence than '|'; '|' will be evaluated first [-Werror,-Wbitwise-conditional-parentheses]\\n_info.flags = isSingleWordEHT ? 1 : 0 | scope32 ? 0x2 : 0; // Use enum?\\n~~~~~~~~~~~ ^\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"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-32-1-leko\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTAndroidOfficial\", \"buildnumber\": 5011, \"got_angle_revision\": \"2bf23ea84e4f071c18f01b94748f3be7dccc4019\", \"got_clang_revision\": \"375350-722b6189-0\", \"got_dawn_revision\": \"8d000e0cc230663dbeae86f59aaa16fc91b1eac1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d\", \"got_revision_cp\": \"refs/heads/master@{#707666}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"11e5ee3a8e919a0f6a3c518bf124952fe6995e18\", \"got_v8_revision_cp\": \"refs/heads/8.0.2@{#1}\", \"got_webrtc_revision\": \"3663ed3ad67893746efd86267a936a7295031ab1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29548}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d\"}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[43/84669] CXX obj/buildtools/third_party/libunwind/libunwind/libunwind.o\\nFAILED: obj/buildtools/third_party/libunwind/libunwind/libunwind.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/buildtools/third_party/libunwi...(too long)\\nIn file included from ../../buildtools/third_party/libunwind/trunk/src/libunwind.cpp:29:\\n../../buildtools/third_party/libunwind/trunk/src/UnwindCursor.hpp:1344:51: error: operator '?:' has lower precedence than '|'; '|' will be evaluated first [-Werror,-Wbitwise-conditional-parentheses]\\n_info.flags = isSingleWordEHT ? 1 : 0 | scope32 ? 0x2 : 0; // Use enum?\\n~~~~~~~~~~~ ^\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571545293112445",
"status": "COMPLETED",
"status_changed_ts": "1571545270758849",
"tags": [
"build_address:luci.chromium.ci/ToTAndroidOfficial/5011",
"builder:ToTAndroidOfficial",
"buildset:commit/git/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ce9df8a2e31427ae9ff2f2ae2f62cd26c80014d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064539124708382464",
"scheduler_job_id:chromium/ToTAndroidOfficial",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899109062684342752/+/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:48003753a0443810",
"user_agent:luci-scheduler"
],
"updated_ts": "1571547117599430",
"url": "https://ci.chromium.org/b/8899109062684342752",
"utcnow_ts": "1571547118419406"
}
}
[04:51:58.427] Invocation finished in 30m49.513357561s with status FAILED