[22:53:31.596] New invocation is queued and will start shortly
[22:53:32.842] Starting the invocation (attempt 1)
[22:53:32.879] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:53:32.879] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:53:32.879] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027143189792595568",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9027143189792595568",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"gitiles_ref:refs/heads/master"
]
}
[22:53:33.663] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607208812992911",
"id": "8861713127665933136",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607208813438590",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178372",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027143189792595568",
"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/8861713127665933136/+/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": "1607208813439082",
"url": "https://ci.chromium.org/b/8861713127665933136",
"utcnow_ts": "1607208813639819"
}
}
[22:53:33.663] Task URL: https://ci.chromium.org/b/8861713127665933136
[22:53:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:2:0) after 1m0s
[22:54:33.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:2:0)
[22:54:33.735] Timer tick, asking Buildbucket for the build status
[22:54:33.831] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:33.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:3:0) after 1m0s
[22:55:33.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:3:0)
[22:55:33.844] Timer tick, asking Buildbucket for the build status
[22:55:33.953] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:33.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:4:0) after 1m0s
[22:56:34.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:4:0)
[22:56:34.023] Timer tick, asking Buildbucket for the build status
[22:56:34.095] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:34.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:5:0) after 1m0s
[22:57:34.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:5:0)
[22:57:34.154] Timer tick, asking Buildbucket for the build status
[22:57:34.390] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:34.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:6:0) after 1m0s
[22:58:34.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:6:0)
[22:58:34.443] Timer tick, asking Buildbucket for the build status
[22:58:34.819] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:34.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:7:0) after 1m0s
[22:59:34.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:7:0)
[22:59:34.875] Timer tick, asking Buildbucket for the build status
[22:59:34.984] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:34.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:8:0) after 1m0s
[23:00:35.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:8:0)
[23:00:35.166] Timer tick, asking Buildbucket for the build status
[23:00:35.227] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:35.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:9:0) after 1m0s
[23:01:35.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:9:0)
[23:01:35.551] Timer tick, asking Buildbucket for the build status
[23:01:35.653] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:35.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:10:0) after 1m0s
[23:02:35.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:10:0)
[23:02:35.786] Timer tick, asking Buildbucket for the build status
[23:02:36.027] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:11:0) after 1m0s
[23:03:36.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:11:0)
[23:03:36.159] Timer tick, asking Buildbucket for the build status
[23:03:36.275] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:36.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:12:0) after 1m0s
[23:04:36.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:12:0)
[23:04:36.321] Timer tick, asking Buildbucket for the build status
[23:04:36.476] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:36.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:13:0) after 1m0s
[23:05:36.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:13:0)
[23:05:36.584] Timer tick, asking Buildbucket for the build status
[23:05:36.860] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:36.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:14:0) after 1m0s
[23:06:37.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:14:0)
[23:06:37.011] Timer tick, asking Buildbucket for the build status
[23:06:37.344] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:37.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:15:0) after 1m0s
[23:07:37.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:15:0)
[23:07:37.554] Timer tick, asking Buildbucket for the build status
[23:07:37.665] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:37.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:16:0) after 1m0s
[23:08:37.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:16:0)
[23:08:37.715] Timer tick, asking Buildbucket for the build status
[23:08:38.067] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:17:0) after 1m0s
[23:09:38.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:17:0)
[23:09:38.241] Timer tick, asking Buildbucket for the build status
[23:09:48.929] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:48.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:18:0) after 1m0s
[23:10:49.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:18:0)
[23:10:49.107] Timer tick, asking Buildbucket for the build status
[23:10:49.252] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:49.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:19:0) after 1m0s
[23:11:49.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:19:0)
[23:11:49.380] Timer tick, asking Buildbucket for the build status
[23:11:49.596] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:49.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:20:0) after 1m0s
[23:12:49.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:20:0)
[23:12:49.676] Timer tick, asking Buildbucket for the build status
[23:12:49.756] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:49.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:21:0) after 1m0s
[23:13:49.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:21:0)
[23:13:49.845] Timer tick, asking Buildbucket for the build status
[23:13:50.274] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:50.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:22:0) after 1m0s
[23:14:50.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:22:0)
[23:14:50.321] Timer tick, asking Buildbucket for the build status
[23:15:00.808] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:00.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:23:0) after 1m0s
[23:16:00.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:23:0)
[23:16:00.961] Timer tick, asking Buildbucket for the build status
[23:16:01.302] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:01.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:24:0) after 1m0s
[23:17:01.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:24:0)
[23:17:01.325] Timer tick, asking Buildbucket for the build status
[23:17:01.545] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:01.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:25:0) after 1m0s
[23:18:01.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:25:0)
[23:18:01.579] Timer tick, asking Buildbucket for the build status
[23:18:01.718] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:01.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:26:0) after 1m0s
[23:19:02.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:26:0)
[23:19:02.144] Timer tick, asking Buildbucket for the build status
[23:19:02.343] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:02.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:27:0) after 1m0s
[23:20:02.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:27:0)
[23:20:02.345] Timer tick, asking Buildbucket for the build status
[23:20:03.507] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:03.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:28:0) after 1m0s
[23:21:03.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:28:0)
[23:21:03.561] Timer tick, asking Buildbucket for the build status
[23:21:03.638] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:03.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:29:0) after 1m0s
[23:22:03.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:29:0)
[23:22:03.656] Timer tick, asking Buildbucket for the build status
[23:22:03.932] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:03.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:30:0) after 1m0s
[23:23:03.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:30:0)
[23:23:03.955] Timer tick, asking Buildbucket for the build status
[23:23:04.083] Build 8861713127665933136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:04.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:31:0) after 1m0s
[23:23:58.234] Received PubSub notification, asking Buildbucket for the build status
[23:23:58.527] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:04.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:31:0)
[23:24:04.106] Timer tick, asking Buildbucket for the build status
[23:24:04.291] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:04.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:33:0) after 1m0s
[23:25:04.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:33:0)
[23:25:04.371] Timer tick, asking Buildbucket for the build status
[23:25:08.018] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:34:0) after 1m0s
[23:26:08.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:34:0)
[23:26:08.039] Timer tick, asking Buildbucket for the build status
[23:26:08.281] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:08.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:35:0) after 1m0s
[23:27:08.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:35:0)
[23:27:08.311] Timer tick, asking Buildbucket for the build status
[23:27:08.530] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:08.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:36:0) after 1m0s
[23:28:08.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:36:0)
[23:28:08.551] Timer tick, asking Buildbucket for the build status
[23:28:08.749] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:08.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:37:0) after 1m0s
[23:29:08.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:37:0)
[23:29:08.819] Timer tick, asking Buildbucket for the build status
[23:29:08.930] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:08.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:38:0) after 1m0s
[23:30:08.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:38:0)
[23:30:08.982] Timer tick, asking Buildbucket for the build status
[23:30:09.068] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:09.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:39:0) after 1m0s
[23:31:09.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:39:0)
[23:31:09.117] Timer tick, asking Buildbucket for the build status
[23:31:09.212] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:09.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:40:0) after 1m0s
[23:32:09.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:40:0)
[23:32:09.247] Timer tick, asking Buildbucket for the build status
[23:32:09.453] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:09.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:41:0) after 1m0s
[23:33:09.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:41:0)
[23:33:09.473] Timer tick, asking Buildbucket for the build status
[23:33:09.675] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:42:0) after 1m0s
[23:34:09.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:42:0)
[23:34:09.671] Timer tick, asking Buildbucket for the build status
[23:34:09.893] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:43:0) after 1m0s
[23:35:09.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:43:0)
[23:35:09.918] Timer tick, asking Buildbucket for the build status
[23:35:10.128] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:10.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:44:0) after 1m0s
[23:36:10.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:44:0)
[23:36:10.180] Timer tick, asking Buildbucket for the build status
[23:36:10.339] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:10.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:45:0) after 1m0s
[23:37:10.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:45:0)
[23:37:10.436] Timer tick, asking Buildbucket for the build status
[23:37:10.529] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:46:0) after 1m0s
[23:38:10.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:46:0)
[23:38:10.681] Timer tick, asking Buildbucket for the build status
[23:38:11.731] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:11.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:47:0) after 1m0s
[23:39:11.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:47:0)
[23:39:11.776] Timer tick, asking Buildbucket for the build status
[23:39:12.390] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:12.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:48:0) after 1m0s
[23:40:12.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:48:0)
[23:40:12.448] Timer tick, asking Buildbucket for the build status
[23:40:12.880] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:12.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:49:0) after 1m0s
[23:41:12.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:49:0)
[23:41:12.872] Timer tick, asking Buildbucket for the build status
[23:41:12.941] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:12.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:50:0) after 1m0s
[23:42:12.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:50:0)
[23:42:12.962] Timer tick, asking Buildbucket for the build status
[23:42:13.027] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:13.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:51:0) after 1m0s
[23:43:13.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:51:0)
[23:43:13.221] Timer tick, asking Buildbucket for the build status
[23:43:13.413] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:13.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:52:0) after 1m0s
[23:44:13.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:52:0)
[23:44:13.540] Timer tick, asking Buildbucket for the build status
[23:44:13.775] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:13.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:53:0) after 1m0s
[23:45:13.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:53:0)
[23:45:13.836] Timer tick, asking Buildbucket for the build status
[23:45:14.055] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:14.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:54:0) after 1m0s
[23:46:14.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:54:0)
[23:46:14.138] Timer tick, asking Buildbucket for the build status
[23:46:14.201] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:14.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:55:0) after 1m0s
[23:47:14.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:55:0)
[23:47:14.194] Timer tick, asking Buildbucket for the build status
[23:47:14.630] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:14.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:56:0) after 1m0s
[23:48:14.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:56:0)
[23:48:14.698] Timer tick, asking Buildbucket for the build status
[23:48:14.775] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:14.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:57:0) after 1m0s
[23:49:14.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:57:0)
[23:49:14.820] Timer tick, asking Buildbucket for the build status
[23:49:15.629] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:15.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:58:0) after 1m0s
[23:50:15.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:58:0)
[23:50:15.663] Timer tick, asking Buildbucket for the build status
[23:50:16.025] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:59:0) after 1m0s
[23:51:16.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:59:0)
[23:51:16.057] Timer tick, asking Buildbucket for the build status
[23:51:16.122] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:16.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:60:0) after 1m0s
[23:52:16.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:60:0)
[23:52:16.163] Timer tick, asking Buildbucket for the build status
[23:52:16.234] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:16.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:61:0) after 1m0s
[23:53:16.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:61:0)
[23:53:16.357] Timer tick, asking Buildbucket for the build status
[23:53:16.480] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:16.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:62:0) after 1m0s
[23:54:16.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:62:0)
[23:54:16.506] Timer tick, asking Buildbucket for the build status
[23:54:16.886] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:16.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:63:0) after 1m0s
[23:55:16.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:63:0)
[23:55:16.909] Timer tick, asking Buildbucket for the build status
[23:55:17.170] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:64:0) after 1m0s
[23:56:17.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:64:0)
[23:56:17.300] Timer tick, asking Buildbucket for the build status
[23:56:17.456] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:17.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:65:0) after 1m0s
[23:57:17.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:65:0)
[23:57:17.523] Timer tick, asking Buildbucket for the build status
[23:57:18.156] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:18.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:66:0) after 1m0s
[23:58:21.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:66:0)
[23:58:21.683] Timer tick, asking Buildbucket for the build status
[23:58:21.746] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:21.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:67:0) after 1m0s
[23:59:21.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:67:0)
[23:59:21.838] Timer tick, asking Buildbucket for the build status
[23:59:25.174] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:25.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:68:0) after 1m0s
[00:00:25.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:68:0)
[00:00:25.225] Timer tick, asking Buildbucket for the build status
[00:00:25.361] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:25.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:69:0) after 1m0s
[00:01:25.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:69:0)
[00:01:25.418] Timer tick, asking Buildbucket for the build status
[00:01:25.509] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:25.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:70:0) after 1m0s
[00:02:25.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:70:0)
[00:02:25.531] Timer tick, asking Buildbucket for the build status
[00:02:25.932] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:25.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:71:0) after 1m0s
[00:03:25.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:71:0)
[00:03:25.954] Timer tick, asking Buildbucket for the build status
[00:03:26.035] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:72:0) after 1m0s
[00:04:26.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:72:0)
[00:04:26.055] Timer tick, asking Buildbucket for the build status
[00:04:26.252] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:26.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:73:0) after 1m0s
[00:05:26.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:73:0)
[00:05:26.286] Timer tick, asking Buildbucket for the build status
[00:05:28.400] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:28.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:74:0) after 1m0s
[00:06:28.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:74:0)
[00:06:28.436] Timer tick, asking Buildbucket for the build status
[00:06:28.514] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:28.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:75:0) after 1m0s
[00:07:28.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:75:0)
[00:07:28.536] Timer tick, asking Buildbucket for the build status
[00:07:28.660] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:28.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:76:0) after 1m0s
[00:08:28.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:76:0)
[00:08:28.701] Timer tick, asking Buildbucket for the build status
[00:08:28.809] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:28.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:77:0) after 1m0s
[00:09:28.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:77:0)
[00:09:28.810] Timer tick, asking Buildbucket for the build status
[00:09:28.948] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:28.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:78:0) after 1m0s
[00:10:29.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:78:0)
[00:10:29.038] Timer tick, asking Buildbucket for the build status
[00:10:31.745] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:31.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:79:0) after 1m0s
[00:11:31.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:79:0)
[00:11:31.779] Timer tick, asking Buildbucket for the build status
[00:11:32.353] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:80:0) after 1m0s
[00:12:32.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:80:0)
[00:12:32.389] Timer tick, asking Buildbucket for the build status
[00:12:32.579] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:32.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:81:0) after 1m0s
[00:13:32.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:81:0)
[00:13:32.671] Timer tick, asking Buildbucket for the build status
[00:13:32.928] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:32.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:82:0) after 1m0s
[00:14:32.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:82:0)
[00:14:32.970] Timer tick, asking Buildbucket for the build status
[00:14:33.235] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:33.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:83:0) after 1m0s
[00:15:33.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:83:0)
[00:15:33.300] Timer tick, asking Buildbucket for the build status
[00:15:33.420] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:33.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:84:0) after 1m0s
[00:16:33.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:84:0)
[00:16:33.473] Timer tick, asking Buildbucket for the build status
[00:16:33.577] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:33.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:85:0) after 1m0s
[00:17:33.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:85:0)
[00:17:33.664] Timer tick, asking Buildbucket for the build status
[00:17:33.932] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:33.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:86:0) after 1m0s
[00:18:33.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:86:0)
[00:18:33.952] Timer tick, asking Buildbucket for the build status
[00:18:34.200] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:34.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:87:0) after 1m0s
[00:19:34.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:87:0)
[00:19:34.257] Timer tick, asking Buildbucket for the build status
[00:19:34.562] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:34.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:88:0) after 1m0s
[00:20:34.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:88:0)
[00:20:34.640] Timer tick, asking Buildbucket for the build status
[00:20:34.741] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:34.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:89:0) after 1m0s
[00:21:34.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:89:0)
[00:21:34.823] Timer tick, asking Buildbucket for the build status
[00:21:34.924] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:34.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:90:0) after 1m0s
[00:22:35.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:90:0)
[00:22:35.046] Timer tick, asking Buildbucket for the build status
[00:22:35.253] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:35.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:91:0) after 1m0s
[00:23:35.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:91:0)
[00:23:35.433] Timer tick, asking Buildbucket for the build status
[00:23:35.525] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:35.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:92:0) after 1m0s
[00:24:35.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:92:0)
[00:24:35.576] Timer tick, asking Buildbucket for the build status
[00:24:37.662] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:37.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:93:0) after 1m0s
[00:25:37.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:93:0)
[00:25:37.717] Timer tick, asking Buildbucket for the build status
[00:25:38.623] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:38.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:94:0) after 1m0s
[00:26:38.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:94:0)
[00:26:38.645] Timer tick, asking Buildbucket for the build status
[00:26:38.710] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:95:0) after 1m0s
[00:27:38.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:95:0)
[00:27:38.766] Timer tick, asking Buildbucket for the build status
[00:27:38.969] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:38.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:96:0) after 1m0s
[00:28:39.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:96:0)
[00:28:39.048] Timer tick, asking Buildbucket for the build status
[00:28:39.112] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:39.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:97:0) after 1m0s
[00:29:39.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:97:0)
[00:29:39.134] Timer tick, asking Buildbucket for the build status
[00:29:40.321] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:40.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:98:0) after 1m0s
[00:30:40.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:98:0)
[00:30:40.319] Timer tick, asking Buildbucket for the build status
[00:30:40.379] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:40.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:99:0) after 1m0s
[00:31:40.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:99:0)
[00:31:40.443] Timer tick, asking Buildbucket for the build status
[00:31:40.560] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:40.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:100:0) after 1m0s
[00:32:40.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:100:0)
[00:32:40.562] Timer tick, asking Buildbucket for the build status
[00:32:41.176] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:41.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:101:0) after 1m0s
[00:33:41.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:101:0)
[00:33:41.203] Timer tick, asking Buildbucket for the build status
[00:33:41.436] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:41.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:102:0) after 1m0s
[00:34:41.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:102:0)
[00:34:41.470] Timer tick, asking Buildbucket for the build status
[00:34:43.094] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:43.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:103:0) after 1m0s
[00:35:43.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:103:0)
[00:35:43.143] Timer tick, asking Buildbucket for the build status
[00:35:43.348] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:104:0) after 1m0s
[00:36:43.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:104:0)
[00:36:43.416] Timer tick, asking Buildbucket for the build status
[00:36:43.656] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:43.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:105:0) after 1m0s
[00:37:43.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:105:0)
[00:37:43.684] Timer tick, asking Buildbucket for the build status
[00:37:43.787] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:43.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:106:0) after 1m0s
[00:38:43.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:106:0)
[00:38:43.842] Timer tick, asking Buildbucket for the build status
[00:38:44.298] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:44.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:107:0) after 1m0s
[00:39:44.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:107:0)
[00:39:44.337] Timer tick, asking Buildbucket for the build status
[00:39:49.575] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:108:0) after 1m0s
[00:40:49.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:108:0)
[00:40:49.729] Timer tick, asking Buildbucket for the build status
[00:40:49.803] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:49.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:109:0) after 1m0s
[00:41:49.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:109:0)
[00:41:49.953] Timer tick, asking Buildbucket for the build status
[00:41:50.084] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:50.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:110:0) after 1m0s
[00:42:50.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:110:0)
[00:42:50.515] Timer tick, asking Buildbucket for the build status
[00:42:50.674] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:50.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:111:0) after 1m0s
[00:43:50.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:111:0)
[00:43:50.817] Timer tick, asking Buildbucket for the build status
[00:43:51.138] Build 8861713127665933136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:51.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027143189792595568:112:0) after 1m0s
[00:44:25.016] Received PubSub notification, asking Buildbucket for the build status
[00:44:27.115] Build 8861713127665933136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:44:27.115] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607215463082121",
"created_by": "project:chromium",
"created_ts": "1607208812992911",
"id": "8861713127665933136",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\"}}",
"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\": \"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\", \"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-central1-b-8-13-sihq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178372, \"got_angle_revision\": \"251ba5cb119ff2fed0e861cbc9b096c45004c1fa\", \"got_dawn_revision\": \"d63d562d1b26e01b369d9a58eddeaccfaa688a02\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\", \"got_revision_cp\": \"refs/heads/master@{#834043}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"f36e874ade1dbc6f5ddfc857753a892a8bb358c3\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"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\": \"4dc4006889bb8ffd93ed7e36da4e51b624e010b9\", \"swarm_hashes_refs/heads/master(at){#834043}_without_patch\": {\"absl_hardening_tests\": \"238ca27efdf621f4e62cd57e9e676cee479f38da\", \"accessibility_unittests\": \"92ede7aa329ea06132805f43f8b3b74bb60f44cd\", \"angle_unittests\": \"388192734850856fc108f0fb2a1c93195831390f\", \"app_shell_unittests\": \"fd79eeaf534bc36dc420b8157457ac89d3d33845\", \"aura_unittests\": \"f5de94e5899553c21a55510c625852839fe2a7ac\", \"base_unittests\": \"4956db36b4e4ce99f70a819016469c2a13e42421\", \"base_util_unittests\": \"8b21b4568088ce9db4c1be04260e0ba20651ab51\", \"blink_common_unittests\": \"ad63a5618d986af48b8bb8f22128b96f20b52182\", \"blink_fuzzer_unittests\": \"b479f1699a9a52ce8e87492d2bf627f0608a8c73\", \"blink_heap_unittests\": \"3426a3b6aef3b03acbb2b2bd9fd532c6ad43cce3\", \"blink_platform_unittests\": \"33a3ce68bbd8b3a1376abfefe4732a2998283952\", \"blink_python_tests\": \"8353bbe91fdd0b963399afde7ac7d50024483bae\", \"blink_unittests\": \"9b591ec220aa69372d96c381aa4a04719b0c5e62\", \"blink_web_tests\": \"20bcde33bc2b4164c2d1011bb0bb84ec340b7dc9\", \"boringssl_crypto_tests\": \"bda32cc67aaf423f84c9b02bb7160123410397e6\", \"boringssl_ssl_tests\": \"7c6106b525615055e0f434a61e09f72899db9eb6\", \"browser_tests\": \"7f5f40505ee941a834ee0a49daf2b9e321152a3a\", \"capture_unittests\": \"b98ae8c5e38476c1c7ace0162f9c6aa46b73ec35\", \"cast_unittests\": \"555a34732ca2e954c2178e03421204fab1344083\", \"cc_unittests\": \"ca2637d500c8abab44a8358910d110e4406321f9\", \"chrome_app_unittests\": \"25b64b14037b31c5bfc7692c81855042419585d6\", \"chromedriver_unittests\": \"402ab7f77e7a29b4e3d7cede7f314e03a37c01a2\", \"components_browsertests\": \"18a5f4e0fd259a1fe179149afdb8ab49c470a1bb\", \"components_unittests\": \"05e39d14fec7e706060802c516776758936d96ed\", \"compositor_unittests\": \"7cae6ed4fa111957806922175dee0c4ff600ec60\", \"content_browsertests\": \"05232f71fdc5bbbb372ee423a1cd0bd41692ef1d\", \"content_shell_crash_test\": \"f6a15e15af753e136934e0ab9868fed4545f9d93\", \"content_unittests\": \"5d2b2da0730061b449d6e5ee08690685def84cfe\", \"crashpad_tests\": \"db29f86f398cf3bdc2132dcb3d8551dbe2dea20c\", \"cronet_tests\": \"d8c653dec1c72556bc0aa1d3d765b7afff3d44fc\", \"cronet_unittests\": \"22022f44eecfbfd3bb8373db1c25bd46fe355242\", \"crypto_unittests\": \"0e33e18f3621face7df67c35f44e464c49ec9b2c\", \"dbus_unittests\": \"5878dcbd07d58397f47403382d8a9fe4f1be3308\", \"device_unittests\": \"5f9fe8f0e503fc003916216236eda8f299e273cc\", \"display_unittests\": \"10e5b79f621c6e0f259887d02ce985133cb211d6\", \"events_unittests\": \"b643d8a079e3f2967a8cbf17978565db40020a6c\", \"extension_docserver_python_unittests\": \"640200954e19da01f5575567052aad76d7996cd1\", \"extensions_browsertests\": \"2286357c79c8fc484a7fed6ad426825170fbef0b\", \"extensions_unittests\": \"03aab70c37a0022f77aec659e5e34d7b791619b6\", \"filesystem_service_unittests\": \"7b4b4889e58e841adf3636fd4f1dc6081f3beed2\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"f99d9ef96fe9f3a2d31afab77564690f6ae4ebe1\", \"gfx_unittests\": \"40f5bbd3056c10f6dba9561b117c57405c612123\", \"gin_unittests\": \"e7c2049fabe7dbb3df58057f0ff7dfc3d6a25b98\", \"google_apis_unittests\": \"2bacd59561462c22032c1085d027e27ed485c477\", \"gpu_unittests\": \"560da1454f8f25790c1d437d3d9ed5c06d9332e0\", \"grit_python_unittests\": \"1664d3ab1c9a0d4f1b2faad9f251fabed51abe36\", \"gwp_asan_unittests\": \"e8cadb91162595a8231c0f2a04a4f03bad527624\", \"headless_browsertests\": \"a7521e5ffc50a1d51156e8b147f93e998246fbba\", \"headless_unittests\": \"8610aa06b4fdb8d634b9d8ff3d796fee739c9e46\", \"interactive_ui_tests\": \"99a3e58a224407d9ea9223d0204ca9be3c41876b\", \"ipc_tests\": \"d598fe7b573bd8cf77b868ffc9f7678ede4605fb\", \"jingle_unittests\": \"cce43874754e9de9655095950fa5a4f7f7fac63e\", \"latency_unittests\": \"37f500140d326d3c90043f71ea58fd46e6e80509\", \"libjingle_xmpp_unittests\": \"8008915ab013e76777850bbfa4887ae4c9c52a4f\", \"liburlpattern_unittests\": \"4a100bfc66ecba25c9b869afd604f1a5ea8fe5d7\", \"media_blink_unittests\": \"1963e3acc2b9484a7cd271fd95684c036b6e860f\", \"media_unittests\": \"5476d488023d9ce1fce97bdca8b509714a06248b\", \"message_center_unittests\": \"43df6148a7235c5b39812862afb8e149e6c198e3\", \"metrics_python_tests\": \"30fa10e7e3f1de47a0b541e8402d60c2b055f589\", \"midi_unittests\": \"6dbec6081692c7d290dd3fca3065b333a0e96b99\", \"mojo_core_unittests\": \"f36fb726376cce7e0fd87fde8ce94c57528ba419\", \"mojo_unittests\": \"60035cd9db0f7c3c7db9eb53fe3779d31981b002\", \"nacl_helper_nonsfi_unittests\": \"c8e1faf1003ebf6cb0a563d2456c77ffaf94160d\", \"nacl_loader_unittests\": \"58d68ffcf4bb9f8beb824e9290a8db463107ce69\", \"native_theme_unittests\": \"62101f78ae81ee1b90a48fd630023cf5d33d8110\", \"net_unittests\": \"926fd1247bce3f88ca48407dc64bcdefe83fa3e0\", \"openscreen_unittests\": \"fa518b0c1b3c0e3b3161f49a30a02cd4b56dbef9\", \"pdf_unittests\": \"ec333c95c70945da91821cb72d8136d6d42047d0\", \"perfetto_unittests\": \"bc8c71f1c9c5efbdd34e2d00a204edce23e7b229\", \"ppapi_unittests\": \"c7293da52a9348caec5ec0dea2796782081af85b\", \"printing_unittests\": \"b598851ffcb0cd59d05e06c53f4c24efef60f9f9\", \"remoting_unittests\": \"9bef529f9e1250be374c62eab4b661120e554218\", \"sandbox_linux_unittests\": \"b25c70486424d3a8a8a116c5796706abe6d2a6c4\", \"service_manager_unittests\": \"bb26e9cc1d66d99446e69a1eee8e847dcb03a229\", \"services_unittests\": \"5b77851d4b30c78eecaab83bc42355899a797c7b\", \"shell_dialogs_unittests\": \"53e5f9a46a483c91d30731f21268a0593f7034f6\", \"skia_unittests\": \"920673b117b0ee6808f97af5a9c092ec2d797d2c\", \"snapshot_unittests\": \"cbab69199354b51a73f1a8331061b8f93ad2277a\", \"sql_unittests\": \"17c307d405ae5c8e234294391d119e6ee2e7bbdc\", \"storage_unittests\": \"db3baf75703240bc7b8d74b0fad095a0af39f852\", \"sync_integration_tests\": \"05417b9795bb108577b7ab8665894d076d1fa542\", \"telemetry_gpu_unittests\": \"932a5fd54883127c0ede50e6ee74da922d88dc78\", \"telemetry_perf_unittests\": \"14b39a95c0e036494d4e723b2823914fa1d09b5a\", \"telemetry_unittests\": \"8a3a048c06768a8684509fe2741084a745a7d76c\", \"traffic_annotation_auditor_unittests\": \"51a5cd1476900396d63d38677f9c3bd76743206a\", \"ui_base_unittests\": \"90138b91d72c951067844e83548386849195da0c\", \"ui_touch_selection_unittests\": \"080b2151778ed297eac39ed079126f06f003dedf\", \"unit_tests\": \"318f66f66d9c822e6b0873acb685b1aceea125b2\", \"url_unittests\": \"72c53efca72636b4e4334344a7c9005cb753025d\", \"views_perftests\": \"1f96c3159b8abea631c1e24cd67e3267ebb1708f\", \"views_unittests\": \"fa41e7f697a0994739ce558f88955c6b161d1d43\", \"viz_unittests\": \"83c5f6cdab12613d6c233c75f90404ed6acc6d8a\", \"vr_common_unittests\": \"759696bb200adea22bad9bebc69507742594c09e\", \"vr_pixeltests\": \"03848684c38fa5a479d433d6ed470a9b6cd80e5d\", \"webdriver_wpt_tests\": \"1fd241d5e4ffe108d3287c9d89ecc076ae872e39\", \"weblayer_browsertests\": \"c3a83f6ed7d6ecc33d640f92a002a326e10cac5f\", \"weblayer_unittests\": \"069aba46aceda3b62a4f0924c26e54af49194f4a\", \"wm_unittests\": \"d02e23ad6fc2a1028712b302af3c5326313ed986\", \"wtf_unittests\": \"15c8e7bb1d274fff4774ae57475aec6781d4bd55\", \"x11_unittests\": \"ecea8cba67bda1496ed35b161226cca454d839eb\", \"xr_browser_tests\": \"fe2d22bddff6be66f12cf97e5ba3e70dd0635925\", \"zlib_unittests\": \"a5f3c583698ea9ad1934e2d6f495cf930776e1d0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1143bf8a0c86d96d189f99a4f0f749b4f3d1e46c849c82cdd2c6ebe168938b3a_v2\", \"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_a849f81f6411318ca1ae7ae9de2e8d97c3f310d4dee80eb425bf1664c9af39e4_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_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-central1-b-8-13-sihq\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607210637460300",
"status": "COMPLETED",
"status_changed_ts": "1607215464728986",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178372",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4dc4006889bb8ffd93ed7e36da4e51b624e010b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027143189792595568",
"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/8861713127665933136/+/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:504dedcddb9b9710",
"user_agent:luci-scheduler"
],
"updated_ts": "1607215464733523",
"url": "https://ci.chromium.org/b/8861713127665933136",
"utcnow_ts": "1607215467098912"
}
}
[00:44:27.115] Invocation finished in 1h50m55.534375325s with status SUCCEEDED