[06:55:09.399] New invocation is queued and will start shortly
[06:55:10.628] Starting the invocation (attempt 1)
[06:55:10.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:55:10.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:55:10.663] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021495876332416000",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b5021ad4b3431fda930f7be2f163317b5764e440\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021495876332416000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b5021ad4b3431fda930f7be2f163317b5764e440",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5021ad4b3431fda930f7be2f163317b5764e440",
"gitiles_ref:refs/heads/master"
]
}
[06:55:20.832] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612594511294905",
"id": "8856065813684002048",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5021ad4b3431fda930f7be2f163317b5764e440\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612594518473280",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180333",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b5021ad4b3431fda930f7be2f163317b5764e440",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5021ad4b3431fda930f7be2f163317b5764e440",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021495876332416000",
"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/8856065813684002048/+/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": "1612594518473519",
"url": "https://ci.chromium.org/b/8856065813684002048",
"utcnow_ts": "1612594520617418"
}
}
[06:55:20.832] Task URL: https://ci.chromium.org/b/8856065813684002048
[06:55:20.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:2:0) after 1m0s
[06:56:20.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:2:0)
[06:56:20.883] Timer tick, asking Buildbucket for the build status
[06:56:23.361] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:23.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:3:0) after 1m0s
[06:57:23.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:3:0)
[06:57:23.409] Timer tick, asking Buildbucket for the build status
[06:57:25.501] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:25.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:4:0) after 1m0s
[06:58:25.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:4:0)
[06:58:25.609] Timer tick, asking Buildbucket for the build status
[06:58:26.459] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:26.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:5:0) after 1m0s
[06:59:26.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:5:0)
[06:59:26.517] Timer tick, asking Buildbucket for the build status
[06:59:29.824] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:29.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:6:0) after 1m0s
[07:00:29.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:6:0)
[07:00:29.995] Timer tick, asking Buildbucket for the build status
[07:00:30.229] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:30.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:7:0) after 1m0s
[07:01:30.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:7:0)
[07:01:30.270] Timer tick, asking Buildbucket for the build status
[07:01:32.481] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:32.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:8:0) after 1m0s
[07:02:32.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:8:0)
[07:02:32.643] Timer tick, asking Buildbucket for the build status
[07:02:32.934] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:32.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:9:0) after 1m0s
[07:03:32.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:9:0)
[07:03:32.942] Timer tick, asking Buildbucket for the build status
[07:03:37.340] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:37.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:10:0) after 1m0s
[07:04:37.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:10:0)
[07:04:37.363] Timer tick, asking Buildbucket for the build status
[07:04:37.499] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:37.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:11:0) after 1m0s
[07:05:37.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:11:0)
[07:05:37.556] Timer tick, asking Buildbucket for the build status
[07:05:44.070] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:44.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:12:0) after 1m0s
[07:06:44.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:12:0)
[07:06:44.207] Timer tick, asking Buildbucket for the build status
[07:06:45.501] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:45.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:13:0) after 1m0s
[07:07:45.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:13:0)
[07:07:45.519] Timer tick, asking Buildbucket for the build status
[07:07:46.875] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:46.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:14:0) after 1m0s
[07:08:46.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:14:0)
[07:08:46.878] Timer tick, asking Buildbucket for the build status
[07:08:47.080] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:47.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:15:0) after 1m0s
[07:09:47.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:15:0)
[07:09:47.085] Timer tick, asking Buildbucket for the build status
[07:09:47.204] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:47.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:16:0) after 1m0s
[07:10:47.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:16:0)
[07:10:47.226] Timer tick, asking Buildbucket for the build status
[07:10:47.521] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:47.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:17:0) after 1m0s
[07:11:47.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:17:0)
[07:11:47.541] Timer tick, asking Buildbucket for the build status
[07:11:48.449] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:48.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:18:0) after 1m0s
[07:12:48.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:18:0)
[07:12:48.509] Timer tick, asking Buildbucket for the build status
[07:12:50.530] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:50.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:19:0) after 1m0s
[07:13:50.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:19:0)
[07:13:50.549] Timer tick, asking Buildbucket for the build status
[07:13:53.064] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:53.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:20:0) after 1m0s
[07:14:53.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:20:0)
[07:14:53.085] Timer tick, asking Buildbucket for the build status
[07:14:55.789] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:55.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:21:0) after 1m0s
[07:15:55.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:21:0)
[07:15:55.900] Timer tick, asking Buildbucket for the build status
[07:15:59.669] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:59.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:22:0) after 1m0s
[07:16:59.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:22:0)
[07:16:59.699] Timer tick, asking Buildbucket for the build status
[07:17:02.400] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:02.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:23:0) after 1m0s
[07:18:02.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:23:0)
[07:18:02.536] Timer tick, asking Buildbucket for the build status
[07:18:03.848] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:03.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:24:0) after 1m0s
[07:19:03.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:24:0)
[07:19:03.820] Timer tick, asking Buildbucket for the build status
[07:19:04.004] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:04.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:25:0) after 1m0s
[07:20:04.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:25:0)
[07:20:04.014] Timer tick, asking Buildbucket for the build status
[07:20:04.245] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:04.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:26:0) after 1m0s
[07:21:04.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:26:0)
[07:21:04.297] Timer tick, asking Buildbucket for the build status
[07:21:04.446] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:04.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:27:0) after 1m0s
[07:22:04.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:27:0)
[07:22:04.478] Timer tick, asking Buildbucket for the build status
[07:22:04.609] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:04.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:28:0) after 1m0s
[07:23:04.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:28:0)
[07:23:04.628] Timer tick, asking Buildbucket for the build status
[07:23:05.348] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:05.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:29:0) after 1m0s
[07:24:05.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:29:0)
[07:24:05.361] Timer tick, asking Buildbucket for the build status
[07:24:06.713] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:06.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:30:0) after 1m0s
[07:25:06.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:30:0)
[07:25:06.704] Timer tick, asking Buildbucket for the build status
[07:25:06.829] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:06.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:31:0) after 1m0s
[07:26:06.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:31:0)
[07:26:06.866] Timer tick, asking Buildbucket for the build status
[07:26:09.398] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:09.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:32:0) after 1m0s
[07:27:09.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:32:0)
[07:27:09.415] Timer tick, asking Buildbucket for the build status
[07:27:10.410] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:10.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:33:0) after 1m0s
[07:28:10.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:33:0)
[07:28:10.462] Timer tick, asking Buildbucket for the build status
[07:28:10.596] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:10.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:34:0) after 1m0s
[07:29:10.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:34:0)
[07:29:10.708] Timer tick, asking Buildbucket for the build status
[07:29:11.136] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:11.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:35:0) after 1m0s
[07:30:11.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:35:0)
[07:30:11.142] Timer tick, asking Buildbucket for the build status
[07:30:11.500] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:11.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:36:0) after 1m0s
[07:31:11.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:36:0)
[07:31:11.559] Timer tick, asking Buildbucket for the build status
[07:31:11.917] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:11.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:37:0) after 1m0s
[07:32:11.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:37:0)
[07:32:11.912] Timer tick, asking Buildbucket for the build status
[07:32:12.018] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:12.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:38:0) after 1m0s
[07:33:12.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:38:0)
[07:33:12.132] Timer tick, asking Buildbucket for the build status
[07:33:12.214] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:12.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:39:0) after 1m0s
[07:34:12.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:39:0)
[07:34:12.274] Timer tick, asking Buildbucket for the build status
[07:34:12.369] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:12.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:40:0) after 1m0s
[07:35:12.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:40:0)
[07:35:12.386] Timer tick, asking Buildbucket for the build status
[07:35:13.683] Build 8856065813684002048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:13.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:41:0) after 1m0s
[07:35:31.103] Received PubSub notification, asking Buildbucket for the build status
[07:35:31.695] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:13.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:41:0)
[07:36:13.706] Timer tick, asking Buildbucket for the build status
[07:36:13.896] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:13.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:43:0) after 1m0s
[07:37:13.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:43:0)
[07:37:13.878] Timer tick, asking Buildbucket for the build status
[07:37:14.301] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:14.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:44:0) after 1m0s
[07:38:14.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:44:0)
[07:38:14.336] Timer tick, asking Buildbucket for the build status
[07:38:14.452] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:14.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:45:0) after 1m0s
[07:39:14.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:45:0)
[07:39:14.482] Timer tick, asking Buildbucket for the build status
[07:39:14.603] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:46:0) after 1m0s
[07:40:14.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:46:0)
[07:40:14.785] Timer tick, asking Buildbucket for the build status
[07:40:14.897] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:14.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:47:0) after 1m0s
[07:41:14.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:47:0)
[07:41:14.989] Timer tick, asking Buildbucket for the build status
[07:41:15.095] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:48:0) after 1m0s
[07:42:15.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:48:0)
[07:42:15.183] Timer tick, asking Buildbucket for the build status
[07:42:15.293] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:15.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:49:0) after 1m0s
[07:43:15.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:49:0)
[07:43:15.316] Timer tick, asking Buildbucket for the build status
[07:43:15.393] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:15.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:50:0) after 1m0s
[07:44:15.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:50:0)
[07:44:15.421] Timer tick, asking Buildbucket for the build status
[07:44:15.484] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:15.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:51:0) after 1m0s
[07:45:15.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:51:0)
[07:45:15.604] Timer tick, asking Buildbucket for the build status
[07:45:15.719] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:15.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:52:0) after 1m0s
[07:46:15.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:52:0)
[07:46:15.759] Timer tick, asking Buildbucket for the build status
[07:46:15.855] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:15.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:53:0) after 1m0s
[07:47:15.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:53:0)
[07:47:15.909] Timer tick, asking Buildbucket for the build status
[07:47:16.202] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:16.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:54:0) after 1m0s
[07:48:16.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:54:0)
[07:48:16.184] Timer tick, asking Buildbucket for the build status
[07:48:16.246] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:16.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:55:0) after 1m0s
[07:49:16.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:55:0)
[07:49:16.263] Timer tick, asking Buildbucket for the build status
[07:49:16.847] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:16.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:56:0) after 1m0s
[07:50:16.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:56:0)
[07:50:16.938] Timer tick, asking Buildbucket for the build status
[07:50:17.130] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:17.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:57:0) after 1m0s
[07:51:17.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:57:0)
[07:51:17.297] Timer tick, asking Buildbucket for the build status
[07:51:17.412] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:17.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:58:0) after 1m0s
[07:52:18.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:58:0)
[07:52:18.062] Timer tick, asking Buildbucket for the build status
[07:52:19.497] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:19.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:59:0) after 1m0s
[07:53:19.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:59:0)
[07:53:19.721] Timer tick, asking Buildbucket for the build status
[07:53:19.799] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:19.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:60:0) after 1m0s
[07:54:19.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:60:0)
[07:54:19.866] Timer tick, asking Buildbucket for the build status
[07:54:20.096] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:20.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:61:0) after 1m0s
[07:55:20.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:61:0)
[07:55:20.304] Timer tick, asking Buildbucket for the build status
[07:55:20.524] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:20.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:62:0) after 1m0s
[07:56:20.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:62:0)
[07:56:20.624] Timer tick, asking Buildbucket for the build status
[07:56:22.637] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:22.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:63:0) after 1m0s
[07:57:22.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:63:0)
[07:57:22.707] Timer tick, asking Buildbucket for the build status
[07:57:23.378] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:23.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:64:0) after 1m0s
[07:58:23.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:64:0)
[07:58:23.490] Timer tick, asking Buildbucket for the build status
[07:58:23.639] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:23.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:65:0) after 1m0s
[07:59:23.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:65:0)
[07:59:23.691] Timer tick, asking Buildbucket for the build status
[07:59:25.993] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:25.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:66:0) after 1m0s
[08:00:26.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:66:0)
[08:00:26.195] Timer tick, asking Buildbucket for the build status
[08:00:26.571] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:26.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:67:0) after 1m0s
[08:01:26.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:67:0)
[08:01:26.674] Timer tick, asking Buildbucket for the build status
[08:01:27.428] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:27.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:68:0) after 1m0s
[08:02:27.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:68:0)
[08:02:27.628] Timer tick, asking Buildbucket for the build status
[08:02:28.945] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:69:0) after 1m0s
[08:03:29.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:69:0)
[08:03:29.098] Timer tick, asking Buildbucket for the build status
[08:03:29.434] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:29.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:70:0) after 1m0s
[08:04:29.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:70:0)
[08:04:29.545] Timer tick, asking Buildbucket for the build status
[08:04:29.747] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:29.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:71:0) after 1m0s
[08:05:30.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:71:0)
[08:05:30.361] Timer tick, asking Buildbucket for the build status
[08:05:31.130] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:72:0) after 1m0s
[08:06:31.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:72:0)
[08:06:31.148] Timer tick, asking Buildbucket for the build status
[08:06:31.329] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:31.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:73:0) after 1m0s
[08:07:31.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:73:0)
[08:07:31.556] Timer tick, asking Buildbucket for the build status
[08:07:31.610] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:31.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:74:0) after 1m0s
[08:08:31.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:74:0)
[08:08:31.803] Timer tick, asking Buildbucket for the build status
[08:08:31.871] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:31.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:75:0) after 1m0s
[08:09:32.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:75:0)
[08:09:32.017] Timer tick, asking Buildbucket for the build status
[08:09:33.485] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:33.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:76:0) after 1m0s
[08:10:33.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:76:0)
[08:10:33.590] Timer tick, asking Buildbucket for the build status
[08:10:33.749] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:33.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:77:0) after 1m0s
[08:11:33.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:77:0)
[08:11:33.816] Timer tick, asking Buildbucket for the build status
[08:11:33.876] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:33.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:78:0) after 1m0s
[08:12:34.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:78:0)
[08:12:34.493] Timer tick, asking Buildbucket for the build status
[08:12:35.398] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:35.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:79:0) after 1m0s
[08:13:35.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:79:0)
[08:13:35.517] Timer tick, asking Buildbucket for the build status
[08:13:35.832] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:80:0) after 1m0s
[08:14:35.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:80:0)
[08:14:35.868] Timer tick, asking Buildbucket for the build status
[08:14:35.947] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:35.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:81:0) after 1m0s
[08:15:36.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:81:0)
[08:15:36.036] Timer tick, asking Buildbucket for the build status
[08:15:36.141] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:36.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:82:0) after 1m0s
[08:16:36.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:82:0)
[08:16:36.336] Timer tick, asking Buildbucket for the build status
[08:16:36.698] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:36.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:83:0) after 1m0s
[08:17:36.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:83:0)
[08:17:36.719] Timer tick, asking Buildbucket for the build status
[08:17:36.780] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:84:0) after 1m0s
[08:18:36.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:84:0)
[08:18:36.814] Timer tick, asking Buildbucket for the build status
[08:18:36.956] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:36.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:85:0) after 1m0s
[08:19:36.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:85:0)
[08:19:36.976] Timer tick, asking Buildbucket for the build status
[08:19:37.083] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:37.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:86:0) after 1m0s
[08:20:37.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:86:0)
[08:20:37.129] Timer tick, asking Buildbucket for the build status
[08:20:37.201] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:37.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:87:0) after 1m0s
[08:21:37.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:87:0)
[08:21:37.228] Timer tick, asking Buildbucket for the build status
[08:21:37.291] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:37.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:88:0) after 1m0s
[08:22:37.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:88:0)
[08:22:37.335] Timer tick, asking Buildbucket for the build status
[08:22:37.434] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:89:0) after 1m0s
[08:23:37.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:89:0)
[08:23:37.497] Timer tick, asking Buildbucket for the build status
[08:23:37.853] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:37.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:90:0) after 1m0s
[08:24:37.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:90:0)
[08:24:37.950] Timer tick, asking Buildbucket for the build status
[08:24:38.322] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:91:0) after 1m0s
[08:25:38.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:91:0)
[08:25:38.396] Timer tick, asking Buildbucket for the build status
[08:25:38.607] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:38.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:92:0) after 1m0s
[08:26:38.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:92:0)
[08:26:38.699] Timer tick, asking Buildbucket for the build status
[08:26:38.757] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:38.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:93:0) after 1m0s
[08:27:38.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:93:0)
[08:27:38.803] Timer tick, asking Buildbucket for the build status
[08:27:38.862] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:38.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:94:0) after 1m0s
[08:28:38.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:94:0)
[08:28:38.841] Timer tick, asking Buildbucket for the build status
[08:28:38.887] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:95:0) after 1m0s
[08:29:38.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:95:0)
[08:29:38.997] Timer tick, asking Buildbucket for the build status
[08:29:40.062] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:40.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:96:0) after 1m0s
[08:30:40.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:96:0)
[08:30:40.086] Timer tick, asking Buildbucket for the build status
[08:30:40.147] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:40.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:97:0) after 1m0s
[08:31:40.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:97:0)
[08:31:40.384] Timer tick, asking Buildbucket for the build status
[08:31:40.867] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:40.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:98:0) after 1m0s
[08:32:40.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:98:0)
[08:32:40.921] Timer tick, asking Buildbucket for the build status
[08:32:40.991] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:40.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:99:0) after 1m0s
[08:33:41.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:99:0)
[08:33:41.018] Timer tick, asking Buildbucket for the build status
[08:33:41.095] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:41.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:100:0) after 1m0s
[08:34:41.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:100:0)
[08:34:41.122] Timer tick, asking Buildbucket for the build status
[08:34:41.215] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:41.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:101:0) after 1m0s
[08:35:41.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:101:0)
[08:35:41.221] Timer tick, asking Buildbucket for the build status
[08:35:41.440] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:41.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:102:0) after 1m0s
[08:36:41.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:102:0)
[08:36:41.461] Timer tick, asking Buildbucket for the build status
[08:36:41.558] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:41.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:103:0) after 1m0s
[08:37:41.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:103:0)
[08:37:41.578] Timer tick, asking Buildbucket for the build status
[08:37:42.521] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:42.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:104:0) after 1m0s
[08:38:42.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:104:0)
[08:38:42.765] Timer tick, asking Buildbucket for the build status
[08:38:44.672] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:44.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:105:0) after 1m0s
[08:39:44.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:105:0)
[08:39:44.789] Timer tick, asking Buildbucket for the build status
[08:39:44.983] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:44.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:106:0) after 1m0s
[08:40:45.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:106:0)
[08:40:45.089] Timer tick, asking Buildbucket for the build status
[08:40:45.180] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:45.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:107:0) after 1m0s
[08:41:45.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:107:0)
[08:41:45.267] Timer tick, asking Buildbucket for the build status
[08:41:45.410] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:45.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:108:0) after 1m0s
[08:42:45.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:108:0)
[08:42:45.473] Timer tick, asking Buildbucket for the build status
[08:42:45.626] Build 8856065813684002048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:45.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021495876332416000:109:0) after 1m0s
[08:43:19.712] Received PubSub notification, asking Buildbucket for the build status
[08:43:19.777] Build 8856065813684002048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:43:19.777] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612600998889091",
"created_by": "project:chromium",
"created_ts": "1612594511294905",
"id": "8856065813684002048",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5021ad4b3431fda930f7be2f163317b5764e440\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"b5021ad4b3431fda930f7be2f163317b5764e440\", \"project\": \"chromium/src\"}], \"$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-east1-d-8-44-62jq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180333, \"got_angle_revision\": \"0bb520adffe41d0f2007c4fe7fdf5754d2939a1d\", \"got_dawn_revision\": \"7fe5aa2eacae7ccbf0cdee379827a4567fc6845d\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"b5021ad4b3431fda930f7be2f163317b5764e440\", \"got_revision_cp\": \"refs/heads/master@{#851440}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"1184b5537fdc37535cb3d099db6a49a2b759f20b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33176}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5021ad4b3431fda930f7be2f163317b5764e440\", \"swarm_hashes_refs/heads/master(at){#851440}_without_patch\": {\"absl_hardening_tests\": \"b66b776734088491471d580a2d3936850f885c37\", \"accessibility_unittests\": \"a74f0832e061129e49e37d7db93ec295921013dd\", \"angle_unittests\": \"fb73cd5e443f7cb1333a00994c6f8b4cf4a2ef40\", \"app_shell_unittests\": \"0fbe1bc1f32f2fbb4be1c9374db6d2639059ae33\", \"aura_unittests\": \"27bf14ac022dfa9f02e3698da727e936c9b833f7\", \"base_unittests\": \"02b357ab857e106698c35d09de90c5a14f98912c\", \"base_util_unittests\": \"0874d2b539b0224c71712d36c9a2326bb286443f\", \"blink_common_unittests\": \"3d45e423b9d76473f6374e3997fef253a65eaaac\", \"blink_fuzzer_unittests\": \"15129b4d244146f291f0809292ebb7dfb9081310\", \"blink_heap_unittests\": \"1335273c4ba0f9a0ca46914e196fc1178c14b170\", \"blink_platform_unittests\": \"7c9164baa32d12cf4a89c0c81fc159d4b97b45e3\", \"blink_python_tests\": \"3fee940019a74843b7b678382a7a94dcff347e7b\", \"blink_unittests\": \"1fec272c2086260580c563ff82ca6454453d895d\", \"blink_web_tests\": \"d86c776e235f75fdd4eaeeb16ee7658c5a9585fc\", \"boringssl_crypto_tests\": \"9d5af019999b2cdd2dee2ac369f375816566ab9c\", \"boringssl_ssl_tests\": \"a49bfe6d50be8ffae20108af6e233be3a54408d6\", \"browser_tests\": \"5d1055d10866e60ddcb5f8f7fc95e3b0eb000411\", \"capture_unittests\": \"b17948fc523cd0fd5ef84b0ffaaca71a73763cdd\", \"cast_unittests\": \"c601e972e9a75620c97cdb8ef54ce379eea62de8\", \"cc_unittests\": \"15755893ac047b7d0c8634fc2aa2d3f41d315865\", \"chrome_app_unittests\": \"1493056b62e975bf0ab2526740d3ebeaf7b6852c\", \"chromedriver_unittests\": \"eb5414d79171b20661f06c06b0558db71cddad58\", \"components_browsertests\": \"476819f9d70f3c50984c187040e2d20ced528ed2\", \"components_unittests\": \"f77ca24b5cb4269fa6ec24262fd85dee71c37c76\", \"compositor_unittests\": \"0f582e666d8472567039d559ccf0102e93bc3cac\", \"content_browsertests\": \"3dc23bd15217b76bd8f7d63f627b34c1cd4ac802\", \"content_shell_crash_test\": \"b99858d36966709fe62e78c0bb7041051f86ae97\", \"content_unittests\": \"7bc635a3c0f4163e50f7ec2bf5c440ab034d906f\", \"crashpad_tests\": \"f87d458a1ef08ad2d3afce8e8fb3d0ae7e2fa92e\", \"cronet_tests\": \"592d9a084eb5be6fda3cc9d6df3d79d4adb523d6\", \"cronet_unittests\": \"602f4d647225fc72799269951c5fd0cd6ee11ef8\", \"crypto_unittests\": \"18acb5240213ea5cb4ef797283557e80cb52a296\", \"dbus_unittests\": \"b7af6d9f4d82f9394f4fe4f8d715790b8ada8be0\", \"device_unittests\": \"ac2af8b54d25ca6fc56e36b9f1543c00e25dd49e\", \"display_unittests\": \"ea16320f0979ce46381650bd30ab9d784d198bbb\", \"events_unittests\": \"420d02e4f7c8a8f5be2d2b51d5baf8fe8365f543\", \"extensions_browsertests\": \"22c57ca0403d6c10872673a5a2421af844a50197\", \"extensions_unittests\": \"a14eed95f7bff9f8fbfbd0cf30b14394b67f1e2e\", \"filesystem_service_unittests\": \"864a1d9dcc7e218ba7755ead98f2b7ec94178ab3\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"3828842be372c346c572662c9efa93c613597e66\", \"gfx_unittests\": \"4c2ca1f78dca3fb0927e114969870395a6f367fd\", \"gin_unittests\": \"556de9d7b4858d75c82da60f7277cdfc3d0e4c4c\", \"google_apis_unittests\": \"e266f131154c0f6691164dc304c5bf5e67c6d690\", \"gpu_unittests\": \"c94c36f5b6484143456e768f01eaec4e19bf50f5\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"0e875b2f55880612c756537c2353070f7e7556ca\", \"headless_browsertests\": \"eb7e388d9f9c7782520bac7a3361b58e2e7421f0\", \"headless_unittests\": \"b8e7b3b0749cfc7d87b1b7b599ce83dc2b76c5df\", \"interactive_ui_tests\": \"e543066a0454eb51bfe1040c350e8f70c1b8a89c\", \"ipc_tests\": \"8ec9a9a9f65c358de432a5f08cda722c42f1809e\", \"jingle_unittests\": \"8d3d1e3d93c4c8588bd9680effcb6c75324f673a\", \"latency_unittests\": \"643d1d906704abe68b3ec82758f3b88a6e54cfb4\", \"libjingle_xmpp_unittests\": \"2fe2f86b9450e577c6e14ddc1cbcb7d6fff2e83a\", \"liburlpattern_unittests\": \"4a6f15112060ab248cc8d54f6e0339541de152d1\", \"media_blink_unittests\": \"292bc978d9704b37e1fefa7f2705f4c4f88e86e9\", \"media_unittests\": \"5b6eb7bc51197e3018b3dfa4cf9567451058cc3c\", \"message_center_unittests\": \"cb2b943f976d1ea08e7bd91498d6b84eaaf52e88\", \"metrics_python_tests\": \"3ec5a2e84318170a457f0d240c2a62b060eba507\", \"midi_unittests\": \"63616176c491367ccf7323ba98028bb0965cdcf4\", \"mojo_core_unittests\": \"1b628f9a5e886e1bfe48b524a09193630ca1cd6f\", \"mojo_unittests\": \"78d24670a1dce0644e3abab14dbad6e75dc90ddd\", \"nacl_helper_nonsfi_unittests\": \"ed9e2a87728689a05c40c9504f3e6dcbd5caa541\", \"nacl_loader_unittests\": \"c89cd781cd09da23ba2364d674ce2559518ff1eb\", \"native_theme_unittests\": \"81787c07df91641321186edaeb281013b2ae5abb\", \"net_unittests\": \"4461fe301d0184ca0db6dc026de6ef6d05db0086\", \"openscreen_unittests\": \"cb509cf43731031cedf762c067f262df10bd7874\", \"pdf_unittests\": \"732077fee3b477c9f51fe536f0b0eb5528a64e35\", \"perfetto_unittests\": \"0e54169d8872dd8ad223a9cabf2c4d2c7b581ce9\", \"ppapi_unittests\": \"53cfa3bcad38100b75852aa440fd217c80666764\", \"printing_unittests\": \"8794a02550d92e82e0f097c46529b6899f87527d\", \"remoting_unittests\": \"9a98400dab232d4956c3e537f9f602511885c9d8\", \"sandbox_linux_unittests\": \"474792755cc1f14e7d9f61f64214d5d28529c006\", \"service_manager_unittests\": \"5caeb16a08b4f48d61a8e773f17d640a50aa7279\", \"services_unittests\": \"bd8fc9dc2c68f3371661f02cf8a67f92ee9de8a8\", \"shell_dialogs_unittests\": \"a6a3fbfbc15901ba26eba33ef544d100b6c8f9e2\", \"skia_unittests\": \"8c675e5155c6a574af4d3af71be9bde17aefcf3c\", \"snapshot_unittests\": \"a2a2801aef3d6f28054ec7898f9bde8a99b6987b\", \"sql_unittests\": \"943d86b0c7c8bbd019634589bf35be7bd2390cc3\", \"storage_unittests\": \"d58bde576b49fa184b07113cd714725cd2c2ba55\", \"sync_integration_tests\": \"0b2ff833757d9136bcd97a9d7c0bb3b1eb799e48\", \"telemetry_gpu_unittests\": \"25217b23122cc9e4a5a2519fd90fb92f4da80cff\", \"telemetry_perf_unittests\": \"eae3f11e24648551518244c570d9b4c05be28932\", \"telemetry_unittests\": \"e0f8ec627f9539158fcdced6c9690e1f9f4b1e07\", \"traffic_annotation_auditor_unittests\": \"2aefba1e128a4231c3dee55d41ad624024f9569d\", \"ui_base_unittests\": \"67f9264e83583755ac8ed8ba0be413642c5d0312\", \"ui_touch_selection_unittests\": \"f3c3ed6109db1afe66a313113a9a8cd62ef94b52\", \"unit_tests\": \"cef1cadd8ed6ec87d00fbe0677042ba7e566f8ab\", \"url_unittests\": \"35264504f31644af9ad52d2b3a06fb776aec9c67\", \"views_perftests\": \"48deaa35a19d126eb45c19177811937b90003768\", \"views_unittests\": \"45237bf01d6c8e7ecd73067a188d0d4fd9aa884d\", \"viz_unittests\": \"ba318a53dc7c9237a7e6a573779cebb870ce4612\", \"vr_common_unittests\": \"e64c53a93dfddc0d3e193a7ff8f442ab08e8e595\", \"vr_pixeltests\": \"dd5327fd2f75b4bfc82e82db6e84eff9dbd32352\", \"webdriver_wpt_tests\": \"a3fe1ef0b94900cc3405b832f8767d0badc10498\", \"weblayer_browsertests\": \"f5142da0eeb3ab2f0c206d49983f458c2903263b\", \"weblayer_unittests\": \"b0e9c24aa504236c50bcfcb043b2621d9cee7395\", \"wm_unittests\": \"3a80d80a4a0631674b5990c4689352faef897763\", \"wtf_unittests\": \"6db393ae1a682ad3522e9be54ce91dc9d87bbb72\", \"x11_unittests\": \"ef7ec8772f35222fd721dab3a0b982cc4573174c\", \"xr_browser_tests\": \"89255f749ac66a762c92d156090493e456dab8aa\", \"zlib_unittests\": \"a00a66c10c10dbe79b117b5b45890933a170f868\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_279625ee090c361ea8cf031374b7b020d1191c526e0ef1068ab634999c69ee70_v2\", \"builder_32ded518776cda8cac391977d607693e2958c39df4b87a6f7ec8056ca6add5b1_v2\", \"builder_5c30bb016a77fbc5ea3e6fb824c869c1bb0f4222c21aad0a92d459b086fbc996_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_ce300ca2149b7ede2a11dc5f29b170d3e5c2bdd2b201177604ba7c6bb221adeb_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_fad65aa1181b0cae2430b762f4f30b6d09779e5e6c0bbaecfe62f78c8fc0ada8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-44-62jq\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612596929990684",
"status": "COMPLETED",
"status_changed_ts": "1612600999529550",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180333",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b5021ad4b3431fda930f7be2f163317b5764e440",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5021ad4b3431fda930f7be2f163317b5764e440",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021495876332416000",
"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/8856065813684002048/+/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:518ef13de6914d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612600999534433",
"url": "https://ci.chromium.org/b/8856065813684002048",
"utcnow_ts": "1612600999767288"
}
}
[08:43:19.777] Invocation finished in 1h48m10.39358608s with status SUCCEEDED