[09:12:58.303] New invocation is queued and will start shortly
[09:12:59.848] Starting the invocation (attempt 1)
[09:12:59.886] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:12:59.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:12:59.887] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9043321074663251568",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Mac Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"764900669286f1bd8b6d872d9a2ff7210c01671f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:WebRTC Chromium FYI Mac Builder",
"scheduler_invocation_id:9043321074663251568",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/764900669286f1bd8b6d872d9a2ff7210c01671f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/764900669286f1bd8b6d872d9a2ff7210c01671f",
"gitiles_ref:refs/heads/master"
]
}
[09:13:00.593] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1591780379981249",
"id": "8877891012239391088",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"764900669286f1bd8b6d872d9a2ff7210c01671f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591780380447508",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/6148",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/764900669286f1bd8b6d872d9a2ff7210c01671f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/764900669286f1bd8b6d872d9a2ff7210c01671f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043321074663251568",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8877891012239391088/+/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": "1591780380447629",
"url": "https://ci.chromium.org/b/8877891012239391088",
"utcnow_ts": "1591780380586355"
}
}
[09:13:00.594] Task URL: https://ci.chromium.org/b/8877891012239391088
[09:13:00.594] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:2:0) after 1m0s
[09:13:05.455] Received PubSub notification, asking Buildbucket for the build status
[09:13:06.113] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:01.085] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:2:0)
[09:14:01.085] Timer tick, asking Buildbucket for the build status
[09:14:01.325] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:01.325] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:4:0) after 1m0s
[09:15:01.507] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:4:0)
[09:15:01.507] Timer tick, asking Buildbucket for the build status
[09:15:01.780] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:01.780] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:5:0) after 1m0s
[09:16:02.078] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:5:0)
[09:16:02.078] Timer tick, asking Buildbucket for the build status
[09:16:02.295] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:6:0) after 1m0s
[09:17:02.415] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:6:0)
[09:17:02.415] Timer tick, asking Buildbucket for the build status
[09:17:02.597] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:02.597] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:7:0) after 1m0s
[09:18:02.749] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:7:0)
[09:18:02.749] Timer tick, asking Buildbucket for the build status
[09:18:03.026] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:03.026] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:8:0) after 1m0s
[09:19:03.086] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:8:0)
[09:19:03.086] Timer tick, asking Buildbucket for the build status
[09:19:03.264] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:03.264] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:9:0) after 1m0s
[09:20:03.334] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:9:0)
[09:20:03.334] Timer tick, asking Buildbucket for the build status
[09:20:03.562] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:03.562] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:10:0) after 1m0s
[09:21:03.703] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:10:0)
[09:21:03.703] Timer tick, asking Buildbucket for the build status
[09:21:04.052] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:04.052] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:11:0) after 1m0s
[09:22:04.114] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:11:0)
[09:22:04.114] Timer tick, asking Buildbucket for the build status
[09:22:04.301] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:04.301] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:12:0) after 1m0s
[09:23:04.329] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:12:0)
[09:23:04.329] Timer tick, asking Buildbucket for the build status
[09:23:04.608] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:04.608] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:13:0) after 1m0s
[09:24:04.679] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:13:0)
[09:24:04.679] Timer tick, asking Buildbucket for the build status
[09:24:04.843] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:04.843] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:14:0) after 1m0s
[09:25:04.893] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:14:0)
[09:25:04.893] Timer tick, asking Buildbucket for the build status
[09:25:07.308] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:07.308] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:15:0) after 1m0s
[09:26:07.401] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:15:0)
[09:26:07.401] Timer tick, asking Buildbucket for the build status
[09:26:07.553] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:07.553] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:16:0) after 1m0s
[09:27:07.621] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:16:0)
[09:27:07.621] Timer tick, asking Buildbucket for the build status
[09:27:07.786] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:07.786] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:17:0) after 1m0s
[09:28:07.808] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:17:0)
[09:28:07.808] Timer tick, asking Buildbucket for the build status
[09:28:08.218] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:08.218] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:18:0) after 1m0s
[09:29:08.239] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:18:0)
[09:29:08.239] Timer tick, asking Buildbucket for the build status
[09:29:08.585] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:08.585] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:19:0) after 1m0s
[09:30:08.788] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:19:0)
[09:30:08.788] Timer tick, asking Buildbucket for the build status
[09:30:11.153] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:11.153] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:20:0) after 1m0s
[09:31:11.174] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:20:0)
[09:31:11.174] Timer tick, asking Buildbucket for the build status
[09:31:11.318] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:11.318] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:21:0) after 1m0s
[09:32:11.447] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:21:0)
[09:32:11.447] Timer tick, asking Buildbucket for the build status
[09:32:11.634] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:11.634] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:22:0) after 1m0s
[09:33:11.642] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:22:0)
[09:33:11.642] Timer tick, asking Buildbucket for the build status
[09:33:11.811] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:11.811] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:23:0) after 1m0s
[09:34:11.845] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:23:0)
[09:34:11.845] Timer tick, asking Buildbucket for the build status
[09:34:12.097] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:12.097] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:24:0) after 1m0s
[09:35:12.120] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:24:0)
[09:35:12.120] Timer tick, asking Buildbucket for the build status
[09:35:12.259] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:12.259] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:25:0) after 1m0s
[09:36:12.294] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:25:0)
[09:36:12.294] Timer tick, asking Buildbucket for the build status
[09:36:12.642] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:12.642] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:26:0) after 1m0s
[09:37:12.665] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:26:0)
[09:37:12.665] Timer tick, asking Buildbucket for the build status
[09:37:12.847] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:12.847] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:27:0) after 1m0s
[09:38:12.889] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:27:0)
[09:38:12.889] Timer tick, asking Buildbucket for the build status
[09:38:13.243] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:13.243] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:28:0) after 1m0s
[09:39:13.266] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:28:0)
[09:39:13.267] Timer tick, asking Buildbucket for the build status
[09:39:13.423] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:29:0) after 1m0s
[09:40:13.485] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:29:0)
[09:40:13.485] Timer tick, asking Buildbucket for the build status
[09:40:13.681] Build 8877891012239391088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:13.681] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9043321074663251568:30:0) after 1m0s
[09:40:37.821] Received PubSub notification, asking Buildbucket for the build status
[09:40:37.932] Build 8877891012239391088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:40:37.932] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"completed_ts": "1591782036684577",
"created_by": "project:chromium",
"created_ts": "1591780379981249",
"id": "8877891012239391088",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"764900669286f1bd8b6d872d9a2ff7210c01671f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"vm326-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Mac Builder\", \"buildnumber\": 6148, \"clang_revision\": \"n356235-f7f1abdb-1\", \"got_angle_revision\": \"d80d9044857e168bb7945eb726a451c20140b80c\", \"got_cr_revision\": \"82c7f7848938e462385dabcee3d928e1fc950667\", \"got_cr_revision_cp\": \"refs/heads/master@{#776881}\", \"got_dawn_revision\": \"527080ff03ce4541a12c2648b6a44e53a1d6384e\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"764900669286f1bd8b6d872d9a2ff7210c01671f\", \"got_revision_cp\": \"refs/heads/master@{#31480}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"e3eb327e8c3c724a415fa4d5f4805f2e281f4760\", \"got_v8_revision\": \"9912e35d594bf00cd78697889beff6b238ebe66d\", \"got_v8_revision_cp\": \"refs/heads/8.5.133@{#1}\", \"got_webrtc_revision\": \"764900669286f1bd8b6d872d9a2ff7210c01671f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31480}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"764900669286f1bd8b6d872d9a2ff7210c01671f\", \"swarm_hashes_refs/heads/master(at){#31480}_without_patch\": {\"browser_tests\": \"b02dace91daba9252e0d04ed575eb5742f949395\", \"browser_tests_apprtc\": \"e87c693cde66b6700d200963ecfc87cf6139bc09\", \"content_browsertests\": \"71a504ac934b8b81dc9cf9ff62e50946b10e065a\", \"content_unittests\": \"a53db396ce0526e1303f921aa08e5d49121b07f6\", \"jingle_unittests\": \"309940df80fe18ee90d98eda0b4b63d61ad00997\", \"remoting_unittests\": \"0934e2a5dbdec2fa62621ffba72709020e25ba83\"}, \"xcode_build_version\": \"11c29\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_4d315a21d49582f6ac1269241de18b93ec0f808a2ae7b2201a57612ac5fb468f_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11c29\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"vm326-m9\"], \"mac_model\": [\"VMware7,1\"], \"machine_type\": [\"n1-highcpu-8\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.webrtc.fyi\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5190-b7dcd03\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1591780384211736",
"status": "COMPLETED",
"status_changed_ts": "1591782037260426",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/6148",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/764900669286f1bd8b6d872d9a2ff7210c01671f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/764900669286f1bd8b6d872d9a2ff7210c01671f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043321074663251568",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8877891012239391088/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4cb6529a65c84810",
"user_agent:luci-scheduler"
],
"updated_ts": "1591782037271614",
"url": "https://ci.chromium.org/b/8877891012239391088",
"utcnow_ts": "1591782037924425"
}
}
[09:40:37.932] Invocation finished in 27m39.64559797s with status SUCCEEDED