[03:33:52.303] New invocation is queued and will start shortly
[03:33:53.435] Starting the invocation (attempt 1)
[03:33:53.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:33:53.480] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:33:53.480] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027216148975709936",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9027216148975709936",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"gitiles_ref:refs/heads/master"
]
}
[03:33:54.546] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607139233595601",
"id": "8861786086951966256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607139234304809",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178361",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027216148975709936",
"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/8861786086951966256/+/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": "1607139234305125",
"url": "https://ci.chromium.org/b/8861786086951966256",
"utcnow_ts": "1607139234535406"
}
}
[03:33:54.546] Task URL: https://ci.chromium.org/b/8861786086951966256
[03:33:54.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:2:0) after 1m0s
[03:34:54.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:2:0)
[03:34:54.547] Timer tick, asking Buildbucket for the build status
[03:34:54.696] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:54.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:3:0) after 1m0s
[03:35:54.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:3:0)
[03:35:54.946] Timer tick, asking Buildbucket for the build status
[03:35:55.127] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:55.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:4:0) after 1m0s
[03:36:55.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:4:0)
[03:36:55.208] Timer tick, asking Buildbucket for the build status
[03:36:55.483] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:55.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:5:0) after 1m0s
[03:37:56.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:5:0)
[03:37:56.076] Timer tick, asking Buildbucket for the build status
[03:37:56.132] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:56.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:6:0) after 1m0s
[03:38:56.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:6:0)
[03:38:56.354] Timer tick, asking Buildbucket for the build status
[03:38:56.499] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:56.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:7:0) after 1m0s
[03:39:56.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:7:0)
[03:39:56.674] Timer tick, asking Buildbucket for the build status
[03:39:56.809] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:8:0) after 1m0s
[03:40:56.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:8:0)
[03:40:56.891] Timer tick, asking Buildbucket for the build status
[03:40:56.972] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:56.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:9:0) after 1m0s
[03:41:57.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:9:0)
[03:41:57.116] Timer tick, asking Buildbucket for the build status
[03:41:57.210] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:57.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:10:0) after 1m0s
[03:42:57.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:10:0)
[03:42:57.279] Timer tick, asking Buildbucket for the build status
[03:42:57.368] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:57.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:11:0) after 1m0s
[03:43:57.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:11:0)
[03:43:57.459] Timer tick, asking Buildbucket for the build status
[03:43:57.551] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:57.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:12:0) after 1m0s
[03:44:57.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:12:0)
[03:44:57.615] Timer tick, asking Buildbucket for the build status
[03:44:57.694] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:57.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:13:0) after 1m0s
[03:45:57.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:13:0)
[03:45:57.802] Timer tick, asking Buildbucket for the build status
[03:45:57.899] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:57.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:14:0) after 1m0s
[03:46:57.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:14:0)
[03:46:57.970] Timer tick, asking Buildbucket for the build status
[03:46:58.062] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:58.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:15:0) after 1m0s
[03:47:58.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:15:0)
[03:47:58.149] Timer tick, asking Buildbucket for the build status
[03:47:58.592] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:16:0) after 1m0s
[03:48:58.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:16:0)
[03:48:58.657] Timer tick, asking Buildbucket for the build status
[03:48:59.759] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:59.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:17:0) after 1m0s
[03:49:59.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:17:0)
[03:49:59.834] Timer tick, asking Buildbucket for the build status
[03:49:59.930] Build 8861786086951966256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:59.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:18:0) after 1m0s
[03:50:32.618] Received PubSub notification, asking Buildbucket for the build status
[03:50:32.706] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:59.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:18:0)
[03:50:59.953] Timer tick, asking Buildbucket for the build status
[03:51:00.164] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:00.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:20:0) after 1m0s
[03:52:00.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:20:0)
[03:52:00.164] Timer tick, asking Buildbucket for the build status
[03:52:00.258] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:00.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:21:0) after 1m0s
[03:53:00.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:21:0)
[03:53:00.289] Timer tick, asking Buildbucket for the build status
[03:53:00.645] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:00.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:22:0) after 1m0s
[03:54:01.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:22:0)
[03:54:01.158] Timer tick, asking Buildbucket for the build status
[03:54:01.269] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:01.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:23:0) after 1m0s
[03:55:01.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:23:0)
[03:55:01.511] Timer tick, asking Buildbucket for the build status
[03:55:02.052] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:24:0) after 1m0s
[03:56:02.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:24:0)
[03:56:02.079] Timer tick, asking Buildbucket for the build status
[03:56:02.140] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:02.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:25:0) after 1m0s
[03:57:02.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:25:0)
[03:57:02.168] Timer tick, asking Buildbucket for the build status
[03:57:02.352] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:02.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:26:0) after 1m0s
[03:58:02.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:26:0)
[03:58:02.466] Timer tick, asking Buildbucket for the build status
[03:58:02.568] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:02.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:27:0) after 1m0s
[03:59:02.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:27:0)
[03:59:02.591] Timer tick, asking Buildbucket for the build status
[03:59:02.768] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:02.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:28:0) after 1m0s
[04:00:02.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:28:0)
[04:00:02.791] Timer tick, asking Buildbucket for the build status
[04:00:02.910] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:02.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:29:0) after 1m0s
[04:01:02.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:29:0)
[04:01:02.931] Timer tick, asking Buildbucket for the build status
[04:01:03.129] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:03.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:30:0) after 1m0s
[04:02:03.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:30:0)
[04:02:03.153] Timer tick, asking Buildbucket for the build status
[04:02:03.226] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:03.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:31:0) after 1m0s
[04:03:03.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:31:0)
[04:03:03.255] Timer tick, asking Buildbucket for the build status
[04:03:03.364] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:03.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:32:0) after 1m0s
[04:04:03.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:32:0)
[04:04:03.375] Timer tick, asking Buildbucket for the build status
[04:04:03.597] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:03.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:33:0) after 1m0s
[04:05:03.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:33:0)
[04:05:03.576] Timer tick, asking Buildbucket for the build status
[04:05:03.679] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:03.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:34:0) after 1m0s
[04:06:03.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:34:0)
[04:06:03.749] Timer tick, asking Buildbucket for the build status
[04:06:03.855] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:03.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:35:0) after 1m0s
[04:07:03.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:35:0)
[04:07:03.918] Timer tick, asking Buildbucket for the build status
[04:07:03.991] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:03.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:36:0) after 1m0s
[04:08:04.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:36:0)
[04:08:04.122] Timer tick, asking Buildbucket for the build status
[04:08:04.204] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:04.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:37:0) after 1m0s
[04:09:04.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:37:0)
[04:09:04.439] Timer tick, asking Buildbucket for the build status
[04:09:05.152] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:38:0) after 1m0s
[04:10:05.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:38:0)
[04:10:05.182] Timer tick, asking Buildbucket for the build status
[04:10:05.512] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:05.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:39:0) after 1m0s
[04:11:05.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:39:0)
[04:11:05.805] Timer tick, asking Buildbucket for the build status
[04:11:05.911] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:05.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:40:0) after 1m0s
[04:12:06.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:40:0)
[04:12:06.014] Timer tick, asking Buildbucket for the build status
[04:12:06.102] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:06.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:41:0) after 1m0s
[04:13:06.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:41:0)
[04:13:06.190] Timer tick, asking Buildbucket for the build status
[04:13:06.260] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:42:0) after 1m0s
[04:14:06.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:42:0)
[04:14:06.325] Timer tick, asking Buildbucket for the build status
[04:14:06.440] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:06.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:43:0) after 1m0s
[04:15:06.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:43:0)
[04:15:06.491] Timer tick, asking Buildbucket for the build status
[04:15:06.557] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:06.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:44:0) after 1m0s
[04:16:06.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:44:0)
[04:16:06.657] Timer tick, asking Buildbucket for the build status
[04:16:06.754] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:06.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:45:0) after 1m0s
[04:17:06.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:45:0)
[04:17:06.796] Timer tick, asking Buildbucket for the build status
[04:17:06.851] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:06.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:46:0) after 1m0s
[04:18:06.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:46:0)
[04:18:06.888] Timer tick, asking Buildbucket for the build status
[04:18:07.016] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:07.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:47:0) after 1m0s
[04:19:07.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:47:0)
[04:19:07.173] Timer tick, asking Buildbucket for the build status
[04:19:07.586] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:07.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:48:0) after 1m0s
[04:20:08.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:48:0)
[04:20:08.341] Timer tick, asking Buildbucket for the build status
[04:20:08.426] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:08.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:49:0) after 1m0s
[04:21:09.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:49:0)
[04:21:09.725] Timer tick, asking Buildbucket for the build status
[04:21:10.021] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:10.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:50:0) after 1m0s
[04:22:10.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:50:0)
[04:22:10.292] Timer tick, asking Buildbucket for the build status
[04:22:10.355] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:10.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:51:0) after 1m0s
[04:23:10.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:51:0)
[04:23:10.521] Timer tick, asking Buildbucket for the build status
[04:23:10.595] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:10.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:52:0) after 1m0s
[04:24:10.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:52:0)
[04:24:10.861] Timer tick, asking Buildbucket for the build status
[04:24:11.054] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:11.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:53:0) after 1m0s
[04:25:11.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:53:0)
[04:25:11.149] Timer tick, asking Buildbucket for the build status
[04:25:11.205] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:11.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:54:0) after 1m0s
[04:26:11.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:54:0)
[04:26:11.305] Timer tick, asking Buildbucket for the build status
[04:26:11.936] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:11.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:55:0) after 1m0s
[04:27:11.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:55:0)
[04:27:11.992] Timer tick, asking Buildbucket for the build status
[04:27:12.064] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:12.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:56:0) after 1m0s
[04:28:12.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:56:0)
[04:28:12.281] Timer tick, asking Buildbucket for the build status
[04:28:12.576] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:12.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:57:0) after 1m0s
[04:29:12.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:57:0)
[04:29:12.835] Timer tick, asking Buildbucket for the build status
[04:29:13.000] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:13.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:58:0) after 1m0s
[04:30:13.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:58:0)
[04:30:13.071] Timer tick, asking Buildbucket for the build status
[04:30:13.199] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:13.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:59:0) after 1m0s
[04:31:13.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:59:0)
[04:31:13.192] Timer tick, asking Buildbucket for the build status
[04:31:13.635] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:13.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:60:0) after 1m0s
[04:32:13.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:60:0)
[04:32:13.743] Timer tick, asking Buildbucket for the build status
[04:32:13.901] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:61:0) after 1m0s
[04:33:13.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:61:0)
[04:33:13.956] Timer tick, asking Buildbucket for the build status
[04:33:14.234] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:14.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:62:0) after 1m0s
[04:34:14.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:62:0)
[04:34:14.372] Timer tick, asking Buildbucket for the build status
[04:34:14.629] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:14.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:63:0) after 1m0s
[04:35:14.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:63:0)
[04:35:14.702] Timer tick, asking Buildbucket for the build status
[04:35:14.765] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:14.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:64:0) after 1m0s
[04:36:14.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:64:0)
[04:36:14.807] Timer tick, asking Buildbucket for the build status
[04:36:14.871] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:14.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:65:0) after 1m0s
[04:37:14.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:65:0)
[04:37:14.956] Timer tick, asking Buildbucket for the build status
[04:37:15.022] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:15.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:66:0) after 1m0s
[04:38:15.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:66:0)
[04:38:15.226] Timer tick, asking Buildbucket for the build status
[04:38:15.645] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:15.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:67:0) after 1m0s
[04:39:15.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:67:0)
[04:39:15.854] Timer tick, asking Buildbucket for the build status
[04:39:16.013] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:16.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:68:0) after 1m0s
[04:40:16.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:68:0)
[04:40:16.108] Timer tick, asking Buildbucket for the build status
[04:40:16.308] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:69:0) after 1m0s
[04:41:16.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:69:0)
[04:41:16.340] Timer tick, asking Buildbucket for the build status
[04:41:16.409] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:70:0) after 1m0s
[04:42:16.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:70:0)
[04:42:16.658] Timer tick, asking Buildbucket for the build status
[04:42:16.721] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:16.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:71:0) after 1m0s
[04:43:16.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:71:0)
[04:43:16.782] Timer tick, asking Buildbucket for the build status
[04:43:16.849] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:16.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:72:0) after 1m0s
[04:44:16.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:72:0)
[04:44:16.895] Timer tick, asking Buildbucket for the build status
[04:44:17.000] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:17.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:73:0) after 1m0s
[04:45:17.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:73:0)
[04:45:17.260] Timer tick, asking Buildbucket for the build status
[04:45:17.348] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:74:0) after 1m0s
[04:46:17.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:74:0)
[04:46:17.339] Timer tick, asking Buildbucket for the build status
[04:46:17.414] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:17.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:75:0) after 1m0s
[04:47:17.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:75:0)
[04:47:17.513] Timer tick, asking Buildbucket for the build status
[04:47:17.933] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:17.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:76:0) after 1m0s
[04:48:17.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:76:0)
[04:48:17.984] Timer tick, asking Buildbucket for the build status
[04:48:18.091] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:18.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:77:0) after 1m0s
[04:49:18.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:77:0)
[04:49:18.083] Timer tick, asking Buildbucket for the build status
[04:49:18.182] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:78:0) after 1m0s
[04:50:18.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:78:0)
[04:50:18.272] Timer tick, asking Buildbucket for the build status
[04:50:18.926] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:18.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:79:0) after 1m0s
[04:51:18.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:79:0)
[04:51:18.957] Timer tick, asking Buildbucket for the build status
[04:51:19.028] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:19.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:80:0) after 1m0s
[04:52:19.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:80:0)
[04:52:19.064] Timer tick, asking Buildbucket for the build status
[04:52:19.220] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:19.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:81:0) after 1m0s
[04:53:19.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:81:0)
[04:53:19.292] Timer tick, asking Buildbucket for the build status
[04:53:19.598] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:19.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:82:0) after 1m0s
[04:54:19.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:82:0)
[04:54:19.629] Timer tick, asking Buildbucket for the build status
[04:54:19.900] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:19.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:83:0) after 1m0s
[04:55:19.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:83:0)
[04:55:19.973] Timer tick, asking Buildbucket for the build status
[04:55:20.029] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:20.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:84:0) after 1m0s
[04:56:20.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:84:0)
[04:56:20.055] Timer tick, asking Buildbucket for the build status
[04:56:20.133] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:20.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:85:0) after 1m0s
[04:57:20.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:85:0)
[04:57:20.292] Timer tick, asking Buildbucket for the build status
[04:57:20.362] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:20.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:86:0) after 1m0s
[04:58:20.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:86:0)
[04:58:20.508] Timer tick, asking Buildbucket for the build status
[04:58:20.590] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:20.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:87:0) after 1m0s
[04:59:20.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:87:0)
[04:59:20.645] Timer tick, asking Buildbucket for the build status
[04:59:20.841] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:20.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:88:0) after 1m0s
[05:00:20.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:88:0)
[05:00:20.882] Timer tick, asking Buildbucket for the build status
[05:00:21.009] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:21.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:89:0) after 1m0s
[05:01:21.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:89:0)
[05:01:21.049] Timer tick, asking Buildbucket for the build status
[05:01:21.151] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:21.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:90:0) after 1m0s
[05:02:21.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:90:0)
[05:02:21.176] Timer tick, asking Buildbucket for the build status
[05:02:21.238] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:21.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:91:0) after 1m0s
[05:03:21.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:91:0)
[05:03:21.277] Timer tick, asking Buildbucket for the build status
[05:03:21.378] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:21.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:92:0) after 1m0s
[05:04:21.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:92:0)
[05:04:21.406] Timer tick, asking Buildbucket for the build status
[05:04:21.521] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:21.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:93:0) after 1m0s
[05:05:21.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:93:0)
[05:05:21.545] Timer tick, asking Buildbucket for the build status
[05:05:21.634] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:21.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:94:0) after 1m0s
[05:06:21.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:94:0)
[05:06:21.672] Timer tick, asking Buildbucket for the build status
[05:06:21.916] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:21.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:95:0) after 1m0s
[05:07:21.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:95:0)
[05:07:21.957] Timer tick, asking Buildbucket for the build status
[05:07:22.051] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:22.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:96:0) after 1m0s
[05:08:22.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:96:0)
[05:08:22.136] Timer tick, asking Buildbucket for the build status
[05:08:22.206] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:22.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:97:0) after 1m0s
[05:09:22.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:97:0)
[05:09:22.265] Timer tick, asking Buildbucket for the build status
[05:09:22.445] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:22.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:98:0) after 1m0s
[05:10:22.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:98:0)
[05:10:22.472] Timer tick, asking Buildbucket for the build status
[05:10:22.617] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:22.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:99:0) after 1m0s
[05:11:22.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:99:0)
[05:11:22.723] Timer tick, asking Buildbucket for the build status
[05:11:22.918] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:22.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:100:0) after 1m0s
[05:12:22.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:100:0)
[05:12:22.963] Timer tick, asking Buildbucket for the build status
[05:12:23.083] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:23.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:101:0) after 1m0s
[05:13:23.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:101:0)
[05:13:23.165] Timer tick, asking Buildbucket for the build status
[05:13:23.379] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:23.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:102:0) after 1m0s
[05:14:23.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:102:0)
[05:14:23.409] Timer tick, asking Buildbucket for the build status
[05:14:23.542] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:23.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:103:0) after 1m0s
[05:15:23.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:103:0)
[05:15:23.580] Timer tick, asking Buildbucket for the build status
[05:15:24.106] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:24.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:104:0) after 1m0s
[05:16:24.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:104:0)
[05:16:24.109] Timer tick, asking Buildbucket for the build status
[05:16:24.244] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:105:0) after 1m0s
[05:17:24.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:105:0)
[05:17:24.264] Timer tick, asking Buildbucket for the build status
[05:17:24.437] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:24.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:106:0) after 1m0s
[05:18:24.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:106:0)
[05:18:24.471] Timer tick, asking Buildbucket for the build status
[05:18:24.531] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:24.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:107:0) after 1m0s
[05:19:24.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:107:0)
[05:19:24.632] Timer tick, asking Buildbucket for the build status
[05:19:24.743] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:24.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:108:0) after 1m0s
[05:20:24.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:108:0)
[05:20:24.935] Timer tick, asking Buildbucket for the build status
[05:20:25.310] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:25.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:109:0) after 1m0s
[05:21:25.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:109:0)
[05:21:25.410] Timer tick, asking Buildbucket for the build status
[05:21:25.609] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:110:0) after 1m0s
[05:22:25.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:110:0)
[05:22:25.742] Timer tick, asking Buildbucket for the build status
[05:22:25.841] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:25.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:111:0) after 1m0s
[05:23:25.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:111:0)
[05:23:25.994] Timer tick, asking Buildbucket for the build status
[05:23:26.072] Build 8861786086951966256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:26.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027216148975709936:112:0) after 1m0s
[05:23:48.875] Received PubSub notification, asking Buildbucket for the build status
[05:23:49.161] Build 8861786086951966256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:23:49.162] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607145828064822",
"created_by": "project:chromium",
"created_ts": "1607139233595601",
"id": "8861786086951966256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\"}}",
"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\": \"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\", \"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-59-wg9m\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178361, \"got_angle_revision\": \"c859c0ac81bbca2066fcaeb6efa48eece5c10103\", \"got_dawn_revision\": \"c532048062befdee8bb57d18f01d3a3c403d49de\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\", \"got_revision_cp\": \"refs/heads/master@{#833985}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"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\": \"3d4ee79d1ea70298b30ca01edcee149e666f1e1d\", \"swarm_hashes_refs/heads/master(at){#833985}_without_patch\": {\"absl_hardening_tests\": \"0a4519df8934417010cf018194b441b6c53df1be\", \"accessibility_unittests\": \"813bbd891c5d6908353229c8ab42748b6b1cc3d4\", \"angle_unittests\": \"05c071de6c58e2b36b35d1bd97237782628e5aa6\", \"app_shell_unittests\": \"8a6f89e76b96a0dd9d1a623dcbeeb3302ab11e8f\", \"aura_unittests\": \"06ebc1ea662f7409038839de768e5d3ea5f88bb5\", \"base_unittests\": \"11b8d817b91e4e72b68fc002b8a3e24c6d932f15\", \"base_util_unittests\": \"a3362fc4122b002d2dacc138bd13c6533431211f\", \"blink_common_unittests\": \"9931ccbe9d5b533e74eee538824c52927370d685\", \"blink_fuzzer_unittests\": \"d3b1904f09585da93299fc60fa5630f8b33ba9ff\", \"blink_heap_unittests\": \"53aef9689f3cf6f93a039b91a9c9966b68be9018\", \"blink_platform_unittests\": \"662c57ca2f31a26a7f8ff25c0e1af416f22f98e9\", \"blink_python_tests\": \"8353bbe91fdd0b963399afde7ac7d50024483bae\", \"blink_unittests\": \"0ecf5349a61121496a30f7d6c5e629409d8b5a96\", \"blink_web_tests\": \"b082edbb66edda4892d02bb6a7bb5775629298f5\", \"boringssl_crypto_tests\": \"54adb277ed44410fd74a142942d5b1c2d4b7f30c\", \"boringssl_ssl_tests\": \"cee3514dd5f20bb68fc9bab1552fbdcb141d52b6\", \"browser_tests\": \"0d360290949aed98baccd9b94696b0d5f56ff6e8\", \"capture_unittests\": \"06e5c33c77121b26939afef29b97b641ec743c69\", \"cast_unittests\": \"9794501fa8a4f334c6af6942f1fda38500279c79\", \"cc_unittests\": \"bfc0330b5a121cfdd09c7b2e5a9f717fabcaa117\", \"chrome_app_unittests\": \"1f58efaf943a90c6163b72621ec918a0482932ef\", \"chromedriver_unittests\": \"3b6df6f62edf48311563d3a0e28f3a58dcb57cda\", \"components_browsertests\": \"598b04191629668a707798ec8df4773605c1a57c\", \"components_unittests\": \"40c9cf3af5090d8a986d60aac6197745be7fd90f\", \"compositor_unittests\": \"276d1e9da103d8b7c654ed57c5e832f8be448471\", \"content_browsertests\": \"e346fc5905c171452248c934f7dfdd1b5f0aca43\", \"content_shell_crash_test\": \"d3ab59a8e72109f85c47d785b44a693acc99577d\", \"content_unittests\": \"4be13192cfa531e309deb20fa196c913c0fe6c87\", \"crashpad_tests\": \"03407dca38465ebb6c215cd33fbc70577f7ea3cd\", \"cronet_tests\": \"c61b18e95756f5510c7b8fd206403c48ca2d1f58\", \"cronet_unittests\": \"3474f983edb6fa72fb27e81b6d4e646c0c388e37\", \"crypto_unittests\": \"f3f9e5705a85fdaa7852dfc1981bc9ae60a4c05b\", \"dbus_unittests\": \"1f638ffac2e0748f882e2522f41da2996b00e457\", \"device_unittests\": \"9f8b7d252508e8871d8865a45af9853b3ac7fbf9\", \"display_unittests\": \"31d78362165a8dc803cb08ab16e0263e659b440b\", \"events_unittests\": \"cd4fe0976377c7209e8be9963b0715c6806cd2ed\", \"extension_docserver_python_unittests\": \"640200954e19da01f5575567052aad76d7996cd1\", \"extensions_browsertests\": \"6da5b135f10e963d9aff5c0cbd795eae4b9c56aa\", \"extensions_unittests\": \"31c77c118dd49a90856291128825ddb84b0614d3\", \"filesystem_service_unittests\": \"1b43e1ee9bcd961d8be0e0cde689066ad18c320b\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"6cf00b3c1bea528a80ed04685843994e020790fa\", \"gfx_unittests\": \"77e6787b0e43c4d06351b2835dc7499280e26b2f\", \"gin_unittests\": \"6a4e3e9b355dd217eff5b7d221f8e65df7960d80\", \"google_apis_unittests\": \"0d7724dceafbdb5b279f72417b38910d8b007c57\", \"gpu_unittests\": \"4b946e7f9855be36c77946fe2eb012a84cd97148\", \"grit_python_unittests\": \"1664d3ab1c9a0d4f1b2faad9f251fabed51abe36\", \"gwp_asan_unittests\": \"06d98bcd5f08b075d79c8398836edde5278287d5\", \"headless_browsertests\": \"32ea2ebf2ad5fbc5b962c10bd49b3b7113363c20\", \"headless_unittests\": \"31b9a9c36daa4b64ead58fe436c75f67be95d3ca\", \"interactive_ui_tests\": \"265fd6cddf6a51b466dbc18f89f662b248aa833a\", \"ipc_tests\": \"e399c96b476d4145e29be0b5b9c739da060ec19b\", \"jingle_unittests\": \"86d205526e513373a816f59e352d52baa7b96459\", \"latency_unittests\": \"02a64c85e6b46c7a6f4fbbd6c7cfa918e2684b93\", \"libjingle_xmpp_unittests\": \"9ffdf371ed1c3f0f0b2a4ebff3af914733fbd67b\", \"liburlpattern_unittests\": \"ab522eea4992272b63b9d4f816c45f420c11ea86\", \"media_blink_unittests\": \"f0be3a450f183e4240d38e0e233e7713fdbba2ad\", \"media_unittests\": \"996215a4c61e65b206734af7bb786c4b39ae9c02\", \"message_center_unittests\": \"b77043ac719dc75fcabd8b6087eefaa3a2ab01da\", \"metrics_python_tests\": \"30fa10e7e3f1de47a0b541e8402d60c2b055f589\", \"midi_unittests\": \"9acc68b624f7f9e40cac9cb911ac71e06d013d29\", \"mojo_core_unittests\": \"a54a05e9197b3737a9af94d266ea35ac601c2576\", \"mojo_unittests\": \"3c73d25032d8731abf9b8dc187eaf4076b81365a\", \"nacl_helper_nonsfi_unittests\": \"edfb98901353ee53224efe436365e7165cb4fc40\", \"nacl_loader_unittests\": \"4c52e77320b51c2a0e2e25e25c8cb768e47a9bee\", \"native_theme_unittests\": \"0afde4ea485226cb758aafe71a258bbe4e1e336d\", \"net_unittests\": \"96454b98de6b3f385edf51f245eba68321fa2a57\", \"openscreen_unittests\": \"07990b7ac72c8b16dcb3e5d9c808ef2ec0bdf4da\", \"pdf_unittests\": \"ca40c9b1452c74a6b68b5c6daefaa24e4b625240\", \"perfetto_unittests\": \"0717d834893ebcf6b8dea80b098c06383ee8766c\", \"ppapi_unittests\": \"a4c482c61901d9109a436d61b49259775ab8b8a0\", \"printing_unittests\": \"6db29fab9e53393ca55bdd3bc8a7e82f81ff4ff2\", \"remoting_unittests\": \"3bedffdb1201fade93ce79d45127207d803cf12a\", \"sandbox_linux_unittests\": \"ee3a2807f54fd81947bd5d00601b520ca1b13ffb\", \"service_manager_unittests\": \"a1b69c2d411abd7f50b7e8febde55c572b8e85c6\", \"services_unittests\": \"bacb34ddadcaed5d2fb5c8b13691e8bde5933c2c\", \"shell_dialogs_unittests\": \"bd96f0aa6318fd08e5dd752f61c60a41381f019c\", \"skia_unittests\": \"1919368fc99f101b964154bb70afb22a5df8c0c6\", \"snapshot_unittests\": \"f46d13f83c81e517c4a229f136e3f780c607cd6a\", \"sql_unittests\": \"962a1638590b4789f6cbec86534c0b87d7178154\", \"storage_unittests\": \"0a85d12db198bad735b4ad6927bcf992c7a07567\", \"sync_integration_tests\": \"7845e2ce1eacbc8b572ca294efd40943bc88a604\", \"telemetry_gpu_unittests\": \"932a5fd54883127c0ede50e6ee74da922d88dc78\", \"telemetry_perf_unittests\": \"d54f3262b777a23510e119f384f0268ba214adcb\", \"telemetry_unittests\": \"4448b9e61be844b53da6b1c7c1901cbabfe913e2\", \"traffic_annotation_auditor_unittests\": \"dbb21cb0d5b68bf1054bc2857af33aab80394cca\", \"ui_base_unittests\": \"71b6e7785a413297ca3a7cd8ab2cf6aa3851ef9b\", \"ui_touch_selection_unittests\": \"a735c98cad6727082f584b3b3f97149ebe34175f\", \"unit_tests\": \"233be1a82ed0612e880ec585abc3d346ca0dd8b6\", \"url_unittests\": \"021f480f54dd831bf4473302053ee0121e16c83f\", \"views_perftests\": \"6d64f7970be7cf295926b23a11d0f9ccca12e050\", \"views_unittests\": \"2a030815559b68ed17cbd68efec5e4036546014b\", \"viz_unittests\": \"3b7e06b3fc80b18e7584c2a4eef8683b869e1c60\", \"vr_common_unittests\": \"854e5ac67846b5d9ed8a318a40f0bfd81decb2f7\", \"vr_pixeltests\": \"4712e74e5a16f1f88c44f617eae0a5eb3dc004ab\", \"webdriver_wpt_tests\": \"c4cd83d7dcb5a0c73a56885502aaabd520b31c97\", \"weblayer_browsertests\": \"b6463af0795580f39542c62a75df312a47e281b0\", \"weblayer_unittests\": \"2063382136e0ac03ce87b59a800c0d2535c60327\", \"wm_unittests\": \"97c53c4004e8c6f94eb8b40b629608791ec6ed6b\", \"wtf_unittests\": \"8e07b68089d991045536d67b4dcc1889cf1df556\", \"x11_unittests\": \"ccb149de13b9ac25d0203bbf0bb33fbc9c808f98\", \"xr_browser_tests\": \"6dd3a3aa4402f2f697d5fc0192393788b87fc48b\", \"zlib_unittests\": \"994059ad273d6d67d481f66b444a1020e49852c6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02faf20e857a95e089f85681f3a573ea5341e1d0e2ee123c756bb8827a7a2b5a_v2\", \"builder_dd549fc6a716e6a939fbd3a419c5738d31929c905615e3b6decc21ab2a48e41b_v2\", \"builder_eb9e31050ddbebce4ba6cbaea9a0445903ee5f3e90bdb319e3517a7851b1b7f7_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-59-wg9m\"], \"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": "1607140231429009",
"status": "COMPLETED",
"status_changed_ts": "1607145828492254",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178361",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d4ee79d1ea70298b30ca01edcee149e666f1e1d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027216148975709936",
"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/8861786086951966256/+/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:5049c81afa6e6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1607145828499235",
"url": "https://ci.chromium.org/b/8861786086951966256",
"utcnow_ts": "1607145829131159"
}
}
[05:23:49.162] Invocation finished in 1h49m56.879782071s with status SUCCEEDED