[18:54:58.129] New invocation is queued and will start shortly
[18:54:59.154] Starting the invocation (attempt 1)
[18:54:59.186] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:54:59.186] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:54:59.186] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9081788169292004048",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Mac Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"330fbee5d870d7519a3067fe191117545f310c0c\"}}",
"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:9081788169292004048",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/330fbee5d870d7519a3067fe191117545f310c0c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/330fbee5d870d7519a3067fe191117545f310c0c",
"gitiles_ref:refs/heads/master"
]
}
[18:55:00.365] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1555095299273598",
"id": "8916358107427515360",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"330fbee5d870d7519a3067fe191117545f310c0c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1555095300080931",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/2743",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/330fbee5d870d7519a3067fe191117545f310c0c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/330fbee5d870d7519a3067fe191117545f310c0c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9081788169292004048",
"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/8916358107427515360/+/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": "1555095300081072",
"url": "https://ci.chromium.org/b/8916358107427515360",
"utcnow_ts": "1555095300348854"
}
}
[18:55:00.365] Task URL: https://ci.chromium.org/b/8916358107427515360
[18:55:00.365] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:2:0) after 1m0s
[18:55:38.325] Received PubSub notification, asking Buildbucket for the build status
[18:55:38.457] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:00.354] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:2:0)
[18:56:00.354] Timer tick, asking Buildbucket for the build status
[18:56:00.423] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:00.423] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:4:0) after 1m0s
[18:57:00.444] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:4:0)
[18:57:00.444] Timer tick, asking Buildbucket for the build status
[18:57:00.692] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:00.692] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:5:0) after 1m0s
[18:58:00.689] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:5:0)
[18:58:00.689] Timer tick, asking Buildbucket for the build status
[18:58:00.867] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:00.867] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:6:0) after 1m0s
[18:59:00.869] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:6:0)
[18:59:00.869] Timer tick, asking Buildbucket for the build status
[18:59:01.296] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:01.296] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:7:0) after 1m0s
[19:00:01.296] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:7:0)
[19:00:01.296] Timer tick, asking Buildbucket for the build status
[19:00:01.459] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:01.459] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:8:0) after 1m0s
[19:01:01.429] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:8:0)
[19:01:01.429] Timer tick, asking Buildbucket for the build status
[19:01:01.568] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:01.568] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:9:0) after 1m0s
[19:02:01.560] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:9:0)
[19:02:01.560] Timer tick, asking Buildbucket for the build status
[19:02:01.709] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:01.709] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:10:0) after 1m0s
[19:03:01.726] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:10:0)
[19:03:01.726] Timer tick, asking Buildbucket for the build status
[19:03:01.819] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:01.819] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:11:0) after 1m0s
[19:04:01.820] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:11:0)
[19:04:01.820] Timer tick, asking Buildbucket for the build status
[19:04:01.909] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:01.909] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:12:0) after 1m0s
[19:05:01.936] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:12:0)
[19:05:01.936] Timer tick, asking Buildbucket for the build status
[19:05:02.070] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:02.070] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:13:0) after 1m0s
[19:06:02.085] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:13:0)
[19:06:02.085] Timer tick, asking Buildbucket for the build status
[19:06:02.146] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:02.146] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:14:0) after 1m0s
[19:07:02.165] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:14:0)
[19:07:02.165] Timer tick, asking Buildbucket for the build status
[19:07:02.291] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:02.291] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:15:0) after 1m0s
[19:08:02.332] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:15:0)
[19:08:02.332] Timer tick, asking Buildbucket for the build status
[19:08:02.603] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:02.603] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:16:0) after 1m0s
[19:09:02.639] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:16:0)
[19:09:02.639] Timer tick, asking Buildbucket for the build status
[19:09:03.250] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:03.250] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:17:0) after 1m0s
[19:10:03.269] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:17:0)
[19:10:03.269] Timer tick, asking Buildbucket for the build status
[19:10:03.410] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:03.410] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:18:0) after 1m0s
[19:11:03.420] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:18:0)
[19:11:03.420] Timer tick, asking Buildbucket for the build status
[19:11:03.561] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:03.561] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:19:0) after 1m0s
[19:12:03.580] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:19:0)
[19:12:03.580] Timer tick, asking Buildbucket for the build status
[19:12:03.640] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:03.640] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:20:0) after 1m0s
[19:13:03.659] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:20:0)
[19:13:03.659] Timer tick, asking Buildbucket for the build status
[19:13:03.715] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:03.715] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:21:0) after 1m0s
[19:14:03.735] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:21:0)
[19:14:03.735] Timer tick, asking Buildbucket for the build status
[19:14:07.915] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:07.915] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:22:0) after 1m0s
[19:15:08.021] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:22:0)
[19:15:08.021] Timer tick, asking Buildbucket for the build status
[19:15:08.469] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:08.469] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:23:0) after 1m0s
[19:16:08.497] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:23:0)
[19:16:08.497] Timer tick, asking Buildbucket for the build status
[19:16:08.579] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:08.579] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:24:0) after 1m0s
[19:17:08.581] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:24:0)
[19:17:08.581] Timer tick, asking Buildbucket for the build status
[19:17:08.757] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:08.757] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:25:0) after 1m0s
[19:18:08.849] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:25:0)
[19:18:08.849] Timer tick, asking Buildbucket for the build status
[19:18:09.074] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:09.074] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:26:0) after 1m0s
[19:19:09.075] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:26:0)
[19:19:09.075] Timer tick, asking Buildbucket for the build status
[19:19:09.275] Build 8916358107427515360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:09.275] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9081788169292004048:27:0) after 1m0s
[19:19:43.723] Received PubSub notification, asking Buildbucket for the build status
[19:19:43.777] Build 8916358107427515360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:19:43.777] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "AUTO",
"completed_ts": "1555096783056801",
"created_by": "project:chromium",
"created_ts": "1555095299273598",
"id": "8916358107427515360",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"330fbee5d870d7519a3067fe191117545f310c0c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"vm325-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Mac Builder\", \"buildnumber\": 2743, \"got_angle_revision\": \"4877ef358434d307c3531b9fd0bf6fb4ab6632ec\", \"got_clang_revision\": \"357692-1\", \"got_cr_revision\": \"8e6a06fa3a2554c26ed8d40c4313a0a5b379bf49\", \"got_cr_revision_cp\": \"refs/heads/master@{#650394}\", \"got_dawn_revision\": \"9a9b837519953393aa8c76dd4f6df6090fba08c7\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"330fbee5d870d7519a3067fe191117545f310c0c\", \"got_revision_cp\": \"refs/heads/master@{#27601}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"485dd5e545f287badf15ade24d8c1c5a8cee5e48\", \"got_v8_revision_cp\": \"refs/heads/7.5.267@{#1}\", \"got_webrtc_revision\": \"330fbee5d870d7519a3067fe191117545f310c0c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27601}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"330fbee5d870d7519a3067fe191117545f310c0c\", \"swarm_hashes_refs/heads/master(at){#27601}_without_patch\": {\"browser_tests\": \"56b48dffae7d30aea01b04e4c50e4416a40fff13\", \"browser_tests_apprtc\": \"a5ba19add3e299dfb6aa61c9cecb22a1781bf6d9\", \"content_browsertests\": \"6aca2bec08c64701e8c6bb42a029e008903f669e\", \"content_unittests\": \"85846be4777ef4973051ffd1faf33d3507c80aef\", \"jingle_unittests\": \"37270511bdeef24ca65b736a52caa68295e3e0cc\", \"remoting_unittests\": \"376fc9aa66ea51e15ef916572c428a0c179a4d19\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_4d315a21d49582f6ac1269241de18b93ec0f808a2ae7b2201a57612ac5fb468f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"vm325-m9\"], \"mac_model\": [\"VMware7,1\"], \"machine_type\": [\"n1-highcpu-8\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.webrtc.fyi\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4253-3d44409\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1555095337695306",
"status": "COMPLETED",
"status_changed_ts": "1555096783434661",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/2743",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/330fbee5d870d7519a3067fe191117545f310c0c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/330fbee5d870d7519a3067fe191117545f310c0c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9081788169292004048",
"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/8916358107427515360/+/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:442bb8b0f04d0810",
"user_agent:luci-scheduler"
],
"updated_ts": "1555096783447135",
"url": "https://ci.chromium.org/b/8916358107427515360",
"utcnow_ts": "1555096783767487"
}
}
[19:19:43.777] Invocation finished in 24m45.66510884s with status SUCCEEDED