[01:53:28.907] New invocation is queued and will start shortly
[01:53:34.386] Starting the invocation (attempt 1)
[01:53:34.430] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:53:34.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:53:34.430] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9073608111755603920",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Mac Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"58388aa07c17bb0d3ea2aa284651934c147de3e6\"}}",
"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:9073608111755603920",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"gitiles_ref:refs/heads/master"
]
}
[01:53:37.101] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1562896414569789",
"id": "8908178045155253008",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"58388aa07c17bb0d3ea2aa284651934c147de3e6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562896416820362",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/3612",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073608111755603920",
"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/8908178045155253008/+/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": "1562896416820462",
"url": "https://ci.chromium.org/b/8908178045155253008",
"utcnow_ts": "1562896417088309"
}
}
[01:53:37.101] Task URL: https://ci.chromium.org/b/8908178045155253008
[01:53:37.101] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:2:0) after 1m0s
[01:54:37.127] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:2:0)
[01:54:37.127] Timer tick, asking Buildbucket for the build status
[01:54:37.289] Build 8908178045155253008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:37.289] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:3:0) after 1m0s
[01:54:40.444] Received PubSub notification, asking Buildbucket for the build status
[01:54:40.515] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:37.389] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:3:0)
[01:55:37.389] Timer tick, asking Buildbucket for the build status
[01:55:37.502] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:37.502] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:5:0) after 1m0s
[01:56:37.591] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:5:0)
[01:56:37.591] Timer tick, asking Buildbucket for the build status
[01:56:38.146] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:38.146] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:6:0) after 1m0s
[01:57:38.223] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:6:0)
[01:57:38.223] Timer tick, asking Buildbucket for the build status
[01:57:38.338] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:38.338] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:7:0) after 1m0s
[01:58:38.382] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:7:0)
[01:58:38.382] Timer tick, asking Buildbucket for the build status
[01:58:39.483] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:39.483] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:8:0) after 1m0s
[01:59:39.571] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:8:0)
[01:59:39.571] Timer tick, asking Buildbucket for the build status
[01:59:39.708] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:39.708] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:9:0) after 1m0s
[02:00:39.785] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:9:0)
[02:00:39.785] Timer tick, asking Buildbucket for the build status
[02:00:40.053] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:40.053] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:10:0) after 1m0s
[02:01:40.158] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:10:0)
[02:01:40.158] Timer tick, asking Buildbucket for the build status
[02:01:40.452] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:40.452] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:11:0) after 1m0s
[02:02:40.470] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:11:0)
[02:02:40.470] Timer tick, asking Buildbucket for the build status
[02:02:41.070] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:41.070] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:12:0) after 1m0s
[02:03:41.257] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:12:0)
[02:03:41.257] Timer tick, asking Buildbucket for the build status
[02:03:41.325] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:41.325] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:13:0) after 1m0s
[02:04:41.412] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:13:0)
[02:04:41.412] Timer tick, asking Buildbucket for the build status
[02:04:41.519] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:41.519] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:14:0) after 1m0s
[02:05:41.560] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:14:0)
[02:05:41.560] Timer tick, asking Buildbucket for the build status
[02:05:41.663] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:15:0) after 1m0s
[02:06:41.697] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:15:0)
[02:06:41.697] Timer tick, asking Buildbucket for the build status
[02:06:41.888] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:41.888] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:16:0) after 1m0s
[02:07:41.941] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:16:0)
[02:07:41.941] Timer tick, asking Buildbucket for the build status
[02:07:42.129] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:42.129] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:17:0) after 1m0s
[02:08:42.196] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:17:0)
[02:08:42.196] Timer tick, asking Buildbucket for the build status
[02:08:42.333] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:42.333] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:18:0) after 1m0s
[02:09:42.352] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:18:0)
[02:09:42.352] Timer tick, asking Buildbucket for the build status
[02:09:42.522] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:19:0) after 1m0s
[02:10:42.565] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:19:0)
[02:10:42.565] Timer tick, asking Buildbucket for the build status
[02:10:42.811] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:20:0) after 1m0s
[02:11:43.031] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:20:0)
[02:11:43.031] Timer tick, asking Buildbucket for the build status
[02:11:44.556] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:44.556] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:21:0) after 1m0s
[02:12:44.633] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:21:0)
[02:12:44.633] Timer tick, asking Buildbucket for the build status
[02:12:44.718] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:22:0) after 1m0s
[02:13:44.887] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:22:0)
[02:13:44.887] Timer tick, asking Buildbucket for the build status
[02:13:44.992] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:44.992] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:23:0) after 1m0s
[02:14:45.115] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:23:0)
[02:14:45.115] Timer tick, asking Buildbucket for the build status
[02:14:46.032] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:46.033] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:24:0) after 1m0s
[02:15:46.153] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:24:0)
[02:15:46.153] Timer tick, asking Buildbucket for the build status
[02:15:46.262] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:46.262] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:25:0) after 1m0s
[02:16:46.329] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:25:0)
[02:16:46.329] Timer tick, asking Buildbucket for the build status
[02:16:47.572] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:47.572] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:26:0) after 1m0s
[02:17:47.757] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:26:0)
[02:17:47.757] Timer tick, asking Buildbucket for the build status
[02:17:47.976] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:27:0) after 1m0s
[02:18:48.002] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:27:0)
[02:18:48.002] Timer tick, asking Buildbucket for the build status
[02:18:48.247] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.247] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:28:0) after 1m0s
[02:19:48.370] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:28:0)
[02:19:48.370] Timer tick, asking Buildbucket for the build status
[02:19:48.479] Build 8908178045155253008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:48.479] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9073608111755603920:29:0) after 1m0s
[02:19:52.614] Received PubSub notification, asking Buildbucket for the build status
[02:19:52.681] Build 8908178045155253008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:19:52.681] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"completed_ts": "1562897973452914",
"created_by": "project:chromium",
"created_ts": "1562896414569789",
"id": "8908178045155253008",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"58388aa07c17bb0d3ea2aa284651934c147de3e6\"}}",
"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\": \"vm324-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Mac Builder\", \"buildnumber\": 3612, \"got_angle_revision\": \"ecd2e3b15215d8812c05d18a60704642cc1103cf\", \"got_clang_revision\": \"365097-f7e52fbd-1\", \"got_cr_revision\": \"898f60fea38ac6df154b23575aa840a54a4bc3f5\", \"got_cr_revision_cp\": \"refs/heads/master@{#676699}\", \"got_dawn_revision\": \"27e67b5f97191ed448ae5b11885c42845dd4cebc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"58388aa07c17bb0d3ea2aa284651934c147de3e6\", \"got_revision_cp\": \"refs/heads/master@{#28546}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2206e55ad023327a744c06084a594944486d0ef8\", \"got_v8_revision_cp\": \"refs/heads/7.7.216@{#1}\", \"got_webrtc_revision\": \"58388aa07c17bb0d3ea2aa284651934c147de3e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28546}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"58388aa07c17bb0d3ea2aa284651934c147de3e6\", \"swarm_hashes_refs/heads/master(at){#28546}_without_patch\": {\"browser_tests\": \"8b49988523673afca90f92c93c8db7f0eeaf00cb\", \"browser_tests_apprtc\": \"6e64be4780506c1304068cb8e340f96a38fb9c37\", \"content_browsertests\": \"175201b95df0b3b6251aed4fb87f769c727f9cc4\", \"content_unittests\": \"2e3c93ea694c23e75d48dbc2c247a24cc84d8321\", \"jingle_unittests\": \"2889e1597ea8143d32c17654e67788fc71cda2cf\", \"remoting_unittests\": \"5db71122e94268dc10f6b7ee408a978a5521f457\"}}, \"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\": [\"vm324-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\": [\"4370-0e704a3\"], \"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": "1562896478045979",
"status": "COMPLETED",
"status_changed_ts": "1562897992177329",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/3612",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/58388aa07c17bb0d3ea2aa284651934c147de3e6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073608111755603920",
"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/8908178045155253008/+/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:45fcb44e2e54d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1562897992228890",
"url": "https://ci.chromium.org/b/8908178045155253008",
"utcnow_ts": "1562897992673823"
}
}
[02:19:52.681] Invocation finished in 26m23.789893317s with status SUCCEEDED