[12:03:00.798] New invocation is queued and will start shortly
[12:03:03.127] Starting the invocation (attempt 1)
[12:03:03.185] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:03:03.185] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:03:03.186] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052370073217660032",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6e80e25cc0bb3838ecf665ce03936895f464ffe3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052370073217660032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"gitiles_ref:refs/heads/master"
]
}
[12:03:04.479] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583150583685370",
"id": "8886940009519947200",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e80e25cc0bb3838ecf665ce03936895f464ffe3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583150584147981",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052370073217660032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886940009519947200/+/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": "1583150584148082",
"url": "https://ci.chromium.org/b/8886940009519947200",
"utcnow_ts": "1583150584466480"
}
}
[12:03:04.479] Task URL: https://ci.chromium.org/b/8886940009519947200
[12:03:04.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:2:0) after 1m0s
[12:04:04.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:2:0)
[12:04:04.593] Timer tick, asking Buildbucket for the build status
[12:04:04.812] Build 8886940009519947200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:04:04.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:3:0) after 1m0s
[12:05:04.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:3:0)
[12:05:04.848] Timer tick, asking Buildbucket for the build status
[12:05:05.084] Build 8886940009519947200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:05:05.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:4:0) after 1m0s
[12:05:48.393] Received PubSub notification, asking Buildbucket for the build status
[12:05:48.564] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:05.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:4:0)
[12:06:05.247] Timer tick, asking Buildbucket for the build status
[12:06:05.359] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:05.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:6:0) after 1m0s
[12:07:05.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:6:0)
[12:07:05.426] Timer tick, asking Buildbucket for the build status
[12:07:05.677] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:05.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:7:0) after 1m0s
[12:08:05.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:7:0)
[12:08:05.698] Timer tick, asking Buildbucket for the build status
[12:08:06.276] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:8:0) after 1m0s
[12:09:06.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:8:0)
[12:09:06.308] Timer tick, asking Buildbucket for the build status
[12:09:06.427] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:06.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:9:0) after 1m0s
[12:10:06.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:9:0)
[12:10:06.483] Timer tick, asking Buildbucket for the build status
[12:10:06.757] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:06.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:10:0) after 1m0s
[12:11:06.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:10:0)
[12:11:06.806] Timer tick, asking Buildbucket for the build status
[12:11:06.907] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:06.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:11:0) after 1m0s
[12:12:07.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:11:0)
[12:12:07.008] Timer tick, asking Buildbucket for the build status
[12:12:08.197] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:08.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:12:0) after 1m0s
[12:13:08.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:12:0)
[12:13:08.298] Timer tick, asking Buildbucket for the build status
[12:13:08.398] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:08.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:13:0) after 1m0s
[12:14:08.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:13:0)
[12:14:08.456] Timer tick, asking Buildbucket for the build status
[12:14:08.751] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:08.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:14:0) after 1m0s
[12:15:08.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:14:0)
[12:15:08.799] Timer tick, asking Buildbucket for the build status
[12:15:09.140] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:09.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:15:0) after 1m0s
[12:16:09.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:15:0)
[12:16:09.139] Timer tick, asking Buildbucket for the build status
[12:16:09.573] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:09.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:16:0) after 1m0s
[12:17:09.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:16:0)
[12:17:09.594] Timer tick, asking Buildbucket for the build status
[12:17:09.705] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:09.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:17:0) after 1m0s
[12:18:09.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:17:0)
[12:18:09.762] Timer tick, asking Buildbucket for the build status
[12:18:09.989] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:18:0) after 1m0s
[12:19:10.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:18:0)
[12:19:10.062] Timer tick, asking Buildbucket for the build status
[12:19:10.693] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:10.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:19:0) after 1m0s
[12:20:10.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:19:0)
[12:20:10.729] Timer tick, asking Buildbucket for the build status
[12:20:10.950] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:10.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:20:0) after 1m0s
[12:21:11.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:20:0)
[12:21:11.003] Timer tick, asking Buildbucket for the build status
[12:21:11.212] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:11.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:21:0) after 1m0s
[12:22:11.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:21:0)
[12:22:11.245] Timer tick, asking Buildbucket for the build status
[12:22:11.564] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:11.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:22:0) after 1m0s
[12:23:11.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:22:0)
[12:23:11.705] Timer tick, asking Buildbucket for the build status
[12:23:11.829] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:11.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:23:0) after 1m0s
[12:24:11.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:23:0)
[12:24:11.895] Timer tick, asking Buildbucket for the build status
[12:24:12.003] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:12.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:24:0) after 1m0s
[12:25:12.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:24:0)
[12:25:12.128] Timer tick, asking Buildbucket for the build status
[12:25:12.361] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:12.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:25:0) after 1m0s
[12:26:12.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:25:0)
[12:26:12.421] Timer tick, asking Buildbucket for the build status
[12:26:12.607] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:12.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:26:0) after 1m0s
[12:27:12.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:26:0)
[12:27:12.629] Timer tick, asking Buildbucket for the build status
[12:27:12.766] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:12.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:27:0) after 1m0s
[12:28:12.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:27:0)
[12:28:12.818] Timer tick, asking Buildbucket for the build status
[12:28:13.014] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:28:0) after 1m0s
[12:29:13.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:28:0)
[12:29:13.015] Timer tick, asking Buildbucket for the build status
[12:29:13.143] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:13.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:29:0) after 1m0s
[12:30:13.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:29:0)
[12:30:13.167] Timer tick, asking Buildbucket for the build status
[12:30:13.311] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:13.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:30:0) after 1m0s
[12:31:13.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:30:0)
[12:31:13.305] Timer tick, asking Buildbucket for the build status
[12:31:13.630] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:13.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:31:0) after 1m0s
[12:32:13.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:31:0)
[12:32:13.625] Timer tick, asking Buildbucket for the build status
[12:32:13.884] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:13.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:32:0) after 1m0s
[12:33:14.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:32:0)
[12:33:14.002] Timer tick, asking Buildbucket for the build status
[12:33:14.352] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:33:0) after 1m0s
[12:34:14.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:33:0)
[12:34:14.352] Timer tick, asking Buildbucket for the build status
[12:34:14.787] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:14.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:34:0) after 1m0s
[12:35:14.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:34:0)
[12:35:14.807] Timer tick, asking Buildbucket for the build status
[12:35:15.295] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:15.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:35:0) after 1m0s
[12:36:15.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:35:0)
[12:36:15.388] Timer tick, asking Buildbucket for the build status
[12:36:15.549] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:15.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:36:0) after 1m0s
[12:37:15.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:36:0)
[12:37:15.616] Timer tick, asking Buildbucket for the build status
[12:37:15.808] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:37:0) after 1m0s
[12:38:15.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:37:0)
[12:38:15.840] Timer tick, asking Buildbucket for the build status
[12:38:16.005] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:38:0) after 1m0s
[12:39:16.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:38:0)
[12:39:16.171] Timer tick, asking Buildbucket for the build status
[12:39:16.300] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:39:0) after 1m0s
[12:40:16.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:39:0)
[12:40:16.341] Timer tick, asking Buildbucket for the build status
[12:40:16.477] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:16.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:40:0) after 1m0s
[12:41:16.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:40:0)
[12:41:16.496] Timer tick, asking Buildbucket for the build status
[12:41:16.630] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:41:0) after 1m0s
[12:42:16.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:41:0)
[12:42:16.675] Timer tick, asking Buildbucket for the build status
[12:42:16.849] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:16.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:42:0) after 1m0s
[12:43:16.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:42:0)
[12:43:16.868] Timer tick, asking Buildbucket for the build status
[12:43:16.989] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:16.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:43:0) after 1m0s
[12:44:17.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:43:0)
[12:44:17.008] Timer tick, asking Buildbucket for the build status
[12:44:17.241] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:44:0) after 1m0s
[12:45:17.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:44:0)
[12:45:17.323] Timer tick, asking Buildbucket for the build status
[12:45:17.485] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:17.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:45:0) after 1m0s
[12:46:17.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:45:0)
[12:46:17.505] Timer tick, asking Buildbucket for the build status
[12:46:17.603] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:17.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:46:0) after 1m0s
[12:47:17.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:46:0)
[12:47:17.624] Timer tick, asking Buildbucket for the build status
[12:47:17.756] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:17.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:47:0) after 1m0s
[12:48:17.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:47:0)
[12:48:17.774] Timer tick, asking Buildbucket for the build status
[12:48:17.897] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:17.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:48:0) after 1m0s
[12:49:17.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:48:0)
[12:49:17.939] Timer tick, asking Buildbucket for the build status
[12:49:18.109] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:18.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:49:0) after 1m0s
[12:50:18.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:49:0)
[12:50:18.168] Timer tick, asking Buildbucket for the build status
[12:50:18.316] Build 8886940009519947200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:18.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052370073217660032:50:0) after 1m0s
[12:50:24.154] Received PubSub notification, asking Buildbucket for the build status
[12:50:24.247] Build 8886940009519947200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:50:24.247] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583153423390212",
"created_by": "project:chromium",
"created_ts": "1583150583685370",
"id": "8886940009519947200",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e80e25cc0bb3838ecf665ce03936895f464ffe3\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"luci-chromium-ci-xenial-us-central1-b-8-73-b54o\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169235, \"got_angle_revision\": \"6e1e64d8c2c0b87de69abd644f5ef9244f1e18e7\", \"got_dawn_revision\": \"3ded65e8072e0cdccd0d0edebccffde37d4428b0\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"6e80e25cc0bb3838ecf665ce03936895f464ffe3\", \"got_revision_cp\": \"refs/heads/master@{#745905}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"416d374522757fc042282b3ae61c53f5510421fc\", \"got_v8_revision\": \"0e841118af5bce4a09c69c6cdd8e9ce97813bc57\", \"got_v8_revision_cp\": \"refs/heads/8.2.224@{#1}\", \"got_webrtc_revision\": \"c6a65c8866487c6adc0a7bb472d3bad9389501f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30653}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e80e25cc0bb3838ecf665ce03936895f464ffe3\", \"swarm_hashes_refs/heads/master(at){#745905}_without_patch\": {\"accessibility_unittests\": \"e8f5bdfba7ca70aa9afcadbb597653afb852e005\", \"angle_unittests\": \"ed0cc47aa39a78ae1fec96b40c7a9e5ccd62e82b\", \"app_shell_unittests\": \"5feafa0236672b7926186cc74a1cd55f188b36bb\", \"aura_unittests\": \"bff3b15ecd506e2872809abbbd5b81de9a260ae4\", \"base_unittests\": \"e6f4fa54a2c7612c7f60cfe8db394bfac6c741c1\", \"base_util_unittests\": \"84a4235415a646a50cbd42a9e751b97bb45e834e\", \"blink_common_unittests\": \"041dbd36bd44e08375fa357ad1d30b160a8cac6d\", \"blink_fuzzer_unittests\": \"54dbc82ab0489d11c9639ea3c4f8f93d3abbf9db\", \"blink_heap_unittests\": \"ccaf1d644d5231018829771a1de702b188e5b63f\", \"blink_platform_unittests\": \"e4a635727d031da41757867a160dd42e2a81deee\", \"blink_python_tests\": \"c6a520437373cca7bce1bbae7d0bb7fe55786680\", \"blink_unittests\": \"b9faf143d63a25e22226891e5e8260fe3827507a\", \"blink_web_tests\": \"10e16978f1a8d380968b502f364855accf7ee250\", \"boringssl_crypto_tests\": \"705c000c1413adf65639ba8f33f15c869965a4ad\", \"boringssl_ssl_tests\": \"53169e0c0a46e57591036da0f4b43701af430949\", \"browser_tests\": \"882aebc1b146dc5443c7c7e19c831b14acfbe6bf\", \"cacheinvalidation_unittests\": \"94b17304d32c5608a7d6231460c02ed0d3e3b512\", \"capture_unittests\": \"da93694a0a062cfa7c92c755da675ee5dbfa4c85\", \"cast_unittests\": \"87a16b03c490387a4ccb09fb746ced7a6177ba0c\", \"cc_unittests\": \"750c2675cc59a5a15f2c99e02ac3a731be7a4742\", \"chrome_app_unittests\": \"1d2968e8f688ec1ce4f40642d0f2df501dbf6ce8\", \"chromedriver_unittests\": \"5cd3907416a915aa92272a648b2cab6a5c2d65e6\", \"components_browsertests\": \"60c112579756343263643099ed8f9a511be385da\", \"components_unittests\": \"81f68fc3cdfe9dbf89d2e66b7030065a43aa1f84\", \"compositor_unittests\": \"02d766b4cc06c20bc098d735195e4c84ec683127\", \"content_browsertests\": \"fc4235120df68cc696a5d787e65fb4d53cd43f7b\", \"content_shell_crash_test\": \"c431b0df70007fdcb48df49a483a60b0aa3ab1a7\", \"content_unittests\": \"3996e0636211a5e839668518b23da3d3aa17a5d2\", \"crashpad_tests\": \"0b6b587adc70c7689d96eb2d2a88edc1be489b0e\", \"cronet_tests\": \"26acb65ffb76adb5946d38f42978003417775ce8\", \"cronet_unittests\": \"4c7b7f871cc110ae39d51b7d3210342bc4eef25f\", \"crypto_unittests\": \"1f091cbb68029c64812aa310083e3e1d13691ae4\", \"dbus_unittests\": \"6a5fb5d4160dbd94d0dde534955a86387ea6bae6\", \"device_unittests\": \"b3ef3dab63c489ebf8338639c9cbfbe8006ac730\", \"display_unittests\": \"19f9590ebd65574aae2c7b456c908767efe843f0\", \"events_unittests\": \"a8b2af7a3845322511bc60567f774936354a00cf\", \"extensions_browsertests\": \"33ec5509b812e18a1d159e181a76f47bde50819d\", \"extensions_unittests\": \"b7458ee394b0a8f230c9913c9d9f0a3071867166\", \"filesystem_service_unittests\": \"aa070e916355c62dab649064cb534403dd4db27b\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"4d9211f0b86e1a9fc98e4b4fb625811aeffb4c2d\", \"gfx_unittests\": \"027dbfe9df3e006dfe76edeb81b053cffe23de4c\", \"gin_unittests\": \"9cd58c1a8d91c839beb9c683df8a93651cedbfed\", \"google_apis_unittests\": \"44b662652728fa63c8df1c542c5cf046e42e1001\", \"gpu_unittests\": \"9a62a84c7d6624ecf580dd3785972368acb80044\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"c2854b14981fedac2d195827a8fe1d30b848b9bd\", \"headless_browsertests\": \"86d45966a2e3efd6acba65db25670d6590171976\", \"headless_unittests\": \"c5c53e88a000dae13d331c6fde14d0fe9e652e8d\", \"interactive_ui_tests\": \"219aae4eec65802ace04de131db6e9a90a75b252\", \"ipc_tests\": \"033e0c1773ae7b0862fb914b833c1a78abb070e2\", \"jingle_unittests\": \"b42e49379ccbd2ec0544661bbad07dec1830b93c\", \"latency_unittests\": \"99afc1a595387ad9bd48126272c7e1c33fae51e7\", \"libjingle_xmpp_unittests\": \"41d94e1543e8aa27b581a8ea0016b02405b25b33\", \"media_blink_unittests\": \"cf38ab5bad794233a54d718728fb844ae59b840c\", \"media_service_unittests\": \"4bb4fc2c51c57260fa8702fcee37592ccf5c14cf\", \"media_unittests\": \"6d0effe7875fe46141457757fa7d3a97b5d3fe31\", \"message_center_unittests\": \"119ebe87b3b3a6e5095afc44c6293bf8318b62a4\", \"metrics_python_tests\": \"d90d16411b5324664b73d68a522c526b0973a535\", \"midi_unittests\": \"9933c4bc0284baabe6967804d79bc528053db5b2\", \"mojo_core_unittests\": \"e9f60462f8f3b538be7b96883d2ca6e46175bc48\", \"mojo_unittests\": \"527d6f5ba58255a735e132199c681579b419486f\", \"nacl_helper_nonsfi_unittests\": \"c64b6af1fb222d24fd742b914a17b0b88b54d303\", \"nacl_loader_unittests\": \"6c21238483ee16b05df29356a240628e6b2b5a45\", \"native_theme_unittests\": \"1509c7d5a79a52cd83254347b6dfd709304725ae\", \"net_unittests\": \"1b715df11c1e525c15cd4e347e58b074c3366c43\", \"pdf_unittests\": \"3f6918b1fb7ad250a174c12d323a3c89fbc57bf1\", \"perfetto_unittests\": \"d011574b4eb69d46a3a2eab6b002579d442051d7\", \"ppapi_unittests\": \"08e631d1d815878bbd8ebc15694912c225f7c572\", \"printing_unittests\": \"fcb9eccb4d178ad571787300d17e3ca5f0f87bde\", \"remoting_unittests\": \"f48d293cf369b33d1d5f9106f4e4a8cda38fd010\", \"sandbox_linux_unittests\": \"9ec9d9240a8dd847672d460ff75ac0b8c2fce84c\", \"service_manager_unittests\": \"7fb56b6a0d4ce0f81f22fcd87b2287e3e58bdb6e\", \"services_unittests\": \"56d6df718efd3caf2b40dc83c87c25f145812bc9\", \"shell_dialogs_unittests\": \"0e5b973f4dd99be940d00682607774292d882aa6\", \"skia_unittests\": \"0339a8f30e4805f385855290109d1ce6f5b554ac\", \"snapshot_unittests\": \"a3e61be1cae17bf2fc3cc3b89a53465b91bd9d52\", \"sql_unittests\": \"374f5a3453e391928647584903c307851b7a7217\", \"storage_unittests\": \"054cbfa2f04914c6d042882bb92c565389e57b1e\", \"sync_integration_tests\": \"8f65e212ec6ea732e4628f24b8c99ce27669b1a5\", \"telemetry_gpu_unittests\": \"d52a891897d0dfee56df80baa620a8eeb7c6b75f\", \"telemetry_perf_unittests\": \"948e30c0b5488aa36134a25045b052ab8d6ba11c\", \"telemetry_unittests\": \"e030dfa1f41bd3001b680969072f398964418ce0\", \"traffic_annotation_auditor_unittests\": \"81c1626ec58642f733a82570463e0e7e9f2dc631\", \"ui_base_unittests\": \"6d71f117332adc9745b94a00d3081ea6fd5c3c37\", \"ui_touch_selection_unittests\": \"e051a96aedfebf59fa33226fdd65e08d902964e0\", \"unit_tests\": \"96e4bd8471f7686d22ad613cfd8bf1bb30a5151d\", \"url_unittests\": \"993fdb09aaba6b96a43c048b4bfe18ed8038ec36\", \"views_perftests\": \"20bce9c9eb9d517a6d54ec761c720b7fe0ea3233\", \"views_unittests\": \"b16b31234818e4e5add0ef05a3f9cee634f8cbad\", \"viz_unittests\": \"b99fd63c159b16874311ab8e4659e89311fb8677\", \"vr_common_unittests\": \"98fc2918dfd5cbc16089da097c6f65abe8b8a30c\", \"vr_pixeltests\": \"965bf1136d94b6b26e740fbca095b8e2c722568d\", \"webdriver_wpt_tests\": \"ce4f8413a08df8dd79743c9296ea97e7e8da4893\", \"weblayer_browsertests\": \"14fb6bc0130cbf21f8835d1f165290922e72ece5\", \"wm_unittests\": \"879c8ca36ef321f3748e662cea53f16bb8e5d6d5\", \"wtf_unittests\": \"447638330b7b43ff07ca845e85c80f02b5674706\", \"xr_browser_tests\": \"db2edca4180455480479bedf52680eb190fa5472\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_beb776337cf5e2ff0f3cb2908a8270f1e35b65aa6652b9e320dd7c6c902817db_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-73-b54o\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4840-d3c86f9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583150746662250",
"status": "COMPLETED",
"status_changed_ts": "1583153423793227",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e80e25cc0bb3838ecf665ce03936895f464ffe3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052370073217660032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886940009519947200/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4ab3f25c3c410d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583153423803633",
"url": "https://ci.chromium.org/b/8886940009519947200",
"utcnow_ts": "1583153424234224"
}
}
[12:50:24.247] Invocation finished in 47m23.472023381s with status SUCCEEDED