[03:54:00.064] New invocation is queued and will start shortly
[03:54:01.575] Starting the invocation (attempt 1)
[03:54:01.634] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:54:01.634] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:54:01.634] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021054288827236400",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"43261c16faf02490a9c99d51f6b171407727ca6e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021054288827236400",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/43261c16faf02490a9c99d51f6b171407727ca6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43261c16faf02490a9c99d51f6b171407727ca6e",
"gitiles_ref:refs/heads/master"
]
}
[03:54:03.203] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613015641748128",
"id": "8855624226396500240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43261c16faf02490a9c99d51f6b171407727ca6e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613015642838042",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22577",
"builder:linux-chromeos-dbg",
"buildset:commit/git/43261c16faf02490a9c99d51f6b171407727ca6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43261c16faf02490a9c99d51f6b171407727ca6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021054288827236400",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855624226396500240/+/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": "1613015642838196",
"url": "https://ci.chromium.org/b/8855624226396500240",
"utcnow_ts": "1613015643182999"
}
}
[03:54:03.203] Task URL: https://ci.chromium.org/b/8855624226396500240
[03:54:03.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:2:0) after 1m0s
[03:55:03.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:2:0)
[03:55:03.240] Timer tick, asking Buildbucket for the build status
[03:55:03.432] Build 8855624226396500240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:03.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:3:0) after 1m0s
[03:56:03.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:3:0)
[03:56:03.452] Timer tick, asking Buildbucket for the build status
[03:56:03.528] Build 8855624226396500240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:03.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:4:0) after 1m0s
[03:57:03.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:4:0)
[03:57:03.506] Timer tick, asking Buildbucket for the build status
[03:57:03.578] Build 8855624226396500240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:03.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:5:0) after 1m0s
[03:58:03.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:5:0)
[03:58:03.594] Timer tick, asking Buildbucket for the build status
[03:58:03.789] Build 8855624226396500240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:03.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:6:0) after 1m0s
[03:58:07.930] Received PubSub notification, asking Buildbucket for the build status
[03:58:08.031] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:6:0)
[03:59:03.791] Timer tick, asking Buildbucket for the build status
[03:59:03.872] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:8:0) after 1m0s
[04:00:04.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:8:0)
[04:00:04.024] Timer tick, asking Buildbucket for the build status
[04:00:04.362] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:04.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:9:0) after 1m0s
[04:01:04.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:9:0)
[04:01:04.502] Timer tick, asking Buildbucket for the build status
[04:01:04.660] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:04.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:10:0) after 1m0s
[04:02:04.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:10:0)
[04:02:04.781] Timer tick, asking Buildbucket for the build status
[04:02:06.279] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:06.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:11:0) after 1m0s
[04:03:06.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:11:0)
[04:03:06.329] Timer tick, asking Buildbucket for the build status
[04:03:06.402] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:06.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:12:0) after 1m0s
[04:04:06.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:12:0)
[04:04:06.556] Timer tick, asking Buildbucket for the build status
[04:04:06.965] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:06.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:13:0) after 1m0s
[04:05:06.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:13:0)
[04:05:06.986] Timer tick, asking Buildbucket for the build status
[04:05:07.295] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:14:0) after 1m0s
[04:06:07.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:14:0)
[04:06:07.309] Timer tick, asking Buildbucket for the build status
[04:06:07.385] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:07.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:15:0) after 1m0s
[04:07:07.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:15:0)
[04:07:07.405] Timer tick, asking Buildbucket for the build status
[04:07:07.493] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:07.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:16:0) after 1m0s
[04:08:07.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:16:0)
[04:08:07.550] Timer tick, asking Buildbucket for the build status
[04:08:09.720] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:09.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:17:0) after 1m0s
[04:09:09.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:17:0)
[04:09:09.827] Timer tick, asking Buildbucket for the build status
[04:09:09.945] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:18:0) after 1m0s
[04:10:10.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:18:0)
[04:10:10.057] Timer tick, asking Buildbucket for the build status
[04:10:10.157] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:10.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:19:0) after 1m0s
[04:11:10.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:19:0)
[04:11:10.226] Timer tick, asking Buildbucket for the build status
[04:11:10.616] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:10.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:20:0) after 1m0s
[04:12:10.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:20:0)
[04:12:10.686] Timer tick, asking Buildbucket for the build status
[04:12:10.754] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:10.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:21:0) after 1m0s
[04:13:10.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:21:0)
[04:13:10.795] Timer tick, asking Buildbucket for the build status
[04:13:10.907] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:10.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:22:0) after 1m0s
[04:14:10.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:22:0)
[04:14:10.933] Timer tick, asking Buildbucket for the build status
[04:14:11.055] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:11.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:23:0) after 1m0s
[04:15:11.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:23:0)
[04:15:11.143] Timer tick, asking Buildbucket for the build status
[04:15:11.445] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:11.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:24:0) after 1m0s
[04:16:11.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:24:0)
[04:16:11.618] Timer tick, asking Buildbucket for the build status
[04:16:11.717] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:25:0) after 1m0s
[04:17:11.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:25:0)
[04:17:11.776] Timer tick, asking Buildbucket for the build status
[04:17:11.884] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:11.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:26:0) after 1m0s
[04:18:11.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:26:0)
[04:18:11.981] Timer tick, asking Buildbucket for the build status
[04:18:12.070] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:12.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:27:0) after 1m0s
[04:19:12.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:27:0)
[04:19:12.091] Timer tick, asking Buildbucket for the build status
[04:19:12.213] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:12.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:28:0) after 1m0s
[04:20:12.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:28:0)
[04:20:12.235] Timer tick, asking Buildbucket for the build status
[04:20:12.353] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:12.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:29:0) after 1m0s
[04:21:12.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:29:0)
[04:21:12.421] Timer tick, asking Buildbucket for the build status
[04:21:12.497] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:12.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:30:0) after 1m0s
[04:22:12.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:30:0)
[04:22:12.519] Timer tick, asking Buildbucket for the build status
[04:22:12.608] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:12.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:31:0) after 1m0s
[04:23:12.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:31:0)
[04:23:12.669] Timer tick, asking Buildbucket for the build status
[04:23:12.753] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:12.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:32:0) after 1m0s
[04:24:12.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:32:0)
[04:24:12.782] Timer tick, asking Buildbucket for the build status
[04:24:12.884] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:33:0) after 1m0s
[04:25:12.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:33:0)
[04:25:12.960] Timer tick, asking Buildbucket for the build status
[04:25:13.126] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:13.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:34:0) after 1m0s
[04:26:13.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:34:0)
[04:26:13.138] Timer tick, asking Buildbucket for the build status
[04:26:13.326] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:13.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:35:0) after 1m0s
[04:27:13.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:35:0)
[04:27:13.420] Timer tick, asking Buildbucket for the build status
[04:27:13.505] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:13.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:36:0) after 1m0s
[04:28:13.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:36:0)
[04:28:13.532] Timer tick, asking Buildbucket for the build status
[04:28:13.616] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:13.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:37:0) after 1m0s
[04:29:13.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:37:0)
[04:29:13.635] Timer tick, asking Buildbucket for the build status
[04:29:13.922] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:13.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:38:0) after 1m0s
[04:30:13.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:38:0)
[04:30:13.962] Timer tick, asking Buildbucket for the build status
[04:30:14.056] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:14.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:39:0) after 1m0s
[04:31:14.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:39:0)
[04:31:14.068] Timer tick, asking Buildbucket for the build status
[04:31:14.170] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:14.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:40:0) after 1m0s
[04:32:14.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:40:0)
[04:32:14.217] Timer tick, asking Buildbucket for the build status
[04:32:14.419] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:14.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:41:0) after 1m0s
[04:33:14.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:41:0)
[04:33:14.422] Timer tick, asking Buildbucket for the build status
[04:33:14.517] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:42:0) after 1m0s
[04:34:14.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:42:0)
[04:34:14.617] Timer tick, asking Buildbucket for the build status
[04:34:14.760] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:14.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:43:0) after 1m0s
[04:35:14.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:43:0)
[04:35:14.761] Timer tick, asking Buildbucket for the build status
[04:35:14.857] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:14.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:44:0) after 1m0s
[04:36:14.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:44:0)
[04:36:14.879] Timer tick, asking Buildbucket for the build status
[04:36:15.034] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:15.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:45:0) after 1m0s
[04:37:15.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:45:0)
[04:37:15.031] Timer tick, asking Buildbucket for the build status
[04:37:15.136] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:15.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:46:0) after 1m0s
[04:38:15.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:46:0)
[04:38:15.117] Timer tick, asking Buildbucket for the build status
[04:38:15.227] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:47:0) after 1m0s
[04:39:15.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:47:0)
[04:39:15.284] Timer tick, asking Buildbucket for the build status
[04:39:15.384] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:15.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:48:0) after 1m0s
[04:40:15.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:48:0)
[04:40:15.467] Timer tick, asking Buildbucket for the build status
[04:40:15.626] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:15.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:49:0) after 1m0s
[04:41:15.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:49:0)
[04:41:15.671] Timer tick, asking Buildbucket for the build status
[04:41:15.755] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:50:0) after 1m0s
[04:42:15.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:50:0)
[04:42:15.858] Timer tick, asking Buildbucket for the build status
[04:42:15.943] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:15.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:51:0) after 1m0s
[04:43:15.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:51:0)
[04:43:15.949] Timer tick, asking Buildbucket for the build status
[04:43:16.039] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:16.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:52:0) after 1m0s
[04:44:16.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:52:0)
[04:44:16.085] Timer tick, asking Buildbucket for the build status
[04:44:16.187] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:16.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:53:0) after 1m0s
[04:45:16.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:53:0)
[04:45:16.258] Timer tick, asking Buildbucket for the build status
[04:45:16.428] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:16.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:54:0) after 1m0s
[04:46:16.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:54:0)
[04:46:16.475] Timer tick, asking Buildbucket for the build status
[04:46:16.630] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:55:0) after 1m0s
[04:47:16.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:55:0)
[04:47:16.677] Timer tick, asking Buildbucket for the build status
[04:47:16.810] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:16.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:56:0) after 1m0s
[04:48:16.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:56:0)
[04:48:16.841] Timer tick, asking Buildbucket for the build status
[04:48:16.956] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:16.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:57:0) after 1m0s
[04:49:17.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:57:0)
[04:49:17.006] Timer tick, asking Buildbucket for the build status
[04:49:17.152] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:58:0) after 1m0s
[04:50:17.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:58:0)
[04:50:17.216] Timer tick, asking Buildbucket for the build status
[04:50:18.685] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:18.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:59:0) after 1m0s
[04:51:18.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:59:0)
[04:51:18.746] Timer tick, asking Buildbucket for the build status
[04:51:18.847] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:18.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:60:0) after 1m0s
[04:52:18.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:60:0)
[04:52:18.936] Timer tick, asking Buildbucket for the build status
[04:52:19.015] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:19.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:61:0) after 1m0s
[04:53:19.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:61:0)
[04:53:19.106] Timer tick, asking Buildbucket for the build status
[04:53:19.372] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:19.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:62:0) after 1m0s
[04:54:19.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:62:0)
[04:54:19.388] Timer tick, asking Buildbucket for the build status
[04:54:19.535] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:19.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:63:0) after 1m0s
[04:55:19.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:63:0)
[04:55:19.599] Timer tick, asking Buildbucket for the build status
[04:55:19.758] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:19.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:64:0) after 1m0s
[04:56:20.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:64:0)
[04:56:20.131] Timer tick, asking Buildbucket for the build status
[04:56:20.220] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:20.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:65:0) after 1m0s
[04:57:20.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:65:0)
[04:57:20.252] Timer tick, asking Buildbucket for the build status
[04:57:20.701] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:66:0) after 1m0s
[04:58:20.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:66:0)
[04:58:20.722] Timer tick, asking Buildbucket for the build status
[04:58:21.119] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:67:0) after 1m0s
[04:59:21.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:67:0)
[04:59:21.141] Timer tick, asking Buildbucket for the build status
[04:59:21.529] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:21.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:68:0) after 1m0s
[05:00:21.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:68:0)
[05:00:21.526] Timer tick, asking Buildbucket for the build status
[05:00:21.726] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:21.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:69:0) after 1m0s
[05:01:21.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:69:0)
[05:01:21.719] Timer tick, asking Buildbucket for the build status
[05:01:21.819] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:21.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:70:0) after 1m0s
[05:02:21.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:70:0)
[05:02:21.843] Timer tick, asking Buildbucket for the build status
[05:02:22.304] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:71:0) after 1m0s
[05:03:22.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:71:0)
[05:03:22.405] Timer tick, asking Buildbucket for the build status
[05:03:22.645] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:22.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:72:0) after 1m0s
[05:04:22.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:72:0)
[05:04:22.706] Timer tick, asking Buildbucket for the build status
[05:04:22.852] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:73:0) after 1m0s
[05:05:22.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:73:0)
[05:05:22.922] Timer tick, asking Buildbucket for the build status
[05:05:23.045] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:23.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:74:0) after 1m0s
[05:06:23.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:74:0)
[05:06:23.066] Timer tick, asking Buildbucket for the build status
[05:06:23.190] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:23.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:75:0) after 1m0s
[05:07:23.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:75:0)
[05:07:23.243] Timer tick, asking Buildbucket for the build status
[05:07:23.504] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:23.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:76:0) after 1m0s
[05:08:23.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:76:0)
[05:08:23.506] Timer tick, asking Buildbucket for the build status
[05:08:23.899] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:23.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:77:0) after 1m0s
[05:09:23.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:77:0)
[05:09:23.928] Timer tick, asking Buildbucket for the build status
[05:09:24.061] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:24.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:78:0) after 1m0s
[05:10:24.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:78:0)
[05:10:24.086] Timer tick, asking Buildbucket for the build status
[05:10:24.712] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:79:0) after 1m0s
[05:11:24.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:79:0)
[05:11:24.811] Timer tick, asking Buildbucket for the build status
[05:11:24.907] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:24.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:80:0) after 1m0s
[05:12:24.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:80:0)
[05:12:24.967] Timer tick, asking Buildbucket for the build status
[05:12:25.373] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:25.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:81:0) after 1m0s
[05:13:25.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:81:0)
[05:13:25.394] Timer tick, asking Buildbucket for the build status
[05:13:25.498] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:25.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:82:0) after 1m0s
[05:14:25.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:82:0)
[05:14:25.551] Timer tick, asking Buildbucket for the build status
[05:14:25.653] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:25.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:83:0) after 1m0s
[05:15:25.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:83:0)
[05:15:25.675] Timer tick, asking Buildbucket for the build status
[05:15:25.960] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:25.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:84:0) after 1m0s
[05:16:25.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:84:0)
[05:16:25.965] Timer tick, asking Buildbucket for the build status
[05:16:26.148] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:26.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:85:0) after 1m0s
[05:17:26.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:85:0)
[05:17:26.166] Timer tick, asking Buildbucket for the build status
[05:17:26.263] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:26.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:86:0) after 1m0s
[05:18:26.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:86:0)
[05:18:26.259] Timer tick, asking Buildbucket for the build status
[05:18:28.058] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:28.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:87:0) after 1m0s
[05:19:28.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:87:0)
[05:19:28.053] Timer tick, asking Buildbucket for the build status
[05:19:28.527] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:28.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:88:0) after 1m0s
[05:20:28.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:88:0)
[05:20:28.539] Timer tick, asking Buildbucket for the build status
[05:20:29.022] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:29.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:89:0) after 1m0s
[05:21:29.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:89:0)
[05:21:29.017] Timer tick, asking Buildbucket for the build status
[05:21:29.444] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:29.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:90:0) after 1m0s
[05:22:29.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:90:0)
[05:22:29.471] Timer tick, asking Buildbucket for the build status
[05:22:29.739] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:29.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:91:0) after 1m0s
[05:23:29.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:91:0)
[05:23:29.766] Timer tick, asking Buildbucket for the build status
[05:23:29.863] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:29.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:92:0) after 1m0s
[05:24:29.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:92:0)
[05:24:29.919] Timer tick, asking Buildbucket for the build status
[05:24:30.063] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:30.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:93:0) after 1m0s
[05:25:30.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:93:0)
[05:25:30.087] Timer tick, asking Buildbucket for the build status
[05:25:30.186] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:30.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:94:0) after 1m0s
[05:26:30.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:94:0)
[05:26:30.208] Timer tick, asking Buildbucket for the build status
[05:26:30.513] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:30.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:95:0) after 1m0s
[05:27:30.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:95:0)
[05:27:30.527] Timer tick, asking Buildbucket for the build status
[05:27:30.616] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:30.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:96:0) after 1m0s
[05:28:30.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:96:0)
[05:28:30.708] Timer tick, asking Buildbucket for the build status
[05:28:30.999] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:97:0) after 1m0s
[05:29:31.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:97:0)
[05:29:31.029] Timer tick, asking Buildbucket for the build status
[05:29:31.160] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:31.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:98:0) after 1m0s
[05:30:31.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:98:0)
[05:30:31.212] Timer tick, asking Buildbucket for the build status
[05:30:31.298] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:31.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:99:0) after 1m0s
[05:31:31.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:99:0)
[05:31:31.407] Timer tick, asking Buildbucket for the build status
[05:31:31.616] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:31.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:100:0) after 1m0s
[05:32:31.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:100:0)
[05:32:31.643] Timer tick, asking Buildbucket for the build status
[05:32:32.010] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:32.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:101:0) after 1m0s
[05:33:32.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:101:0)
[05:33:32.022] Timer tick, asking Buildbucket for the build status
[05:33:32.208] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:32.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:102:0) after 1m0s
[05:34:32.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:102:0)
[05:34:32.229] Timer tick, asking Buildbucket for the build status
[05:34:32.337] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:103:0) after 1m0s
[05:35:32.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:103:0)
[05:35:32.406] Timer tick, asking Buildbucket for the build status
[05:35:32.504] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:32.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:104:0) after 1m0s
[05:36:32.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:104:0)
[05:36:32.528] Timer tick, asking Buildbucket for the build status
[05:36:32.621] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:32.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:105:0) after 1m0s
[05:37:32.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:105:0)
[05:37:32.606] Timer tick, asking Buildbucket for the build status
[05:37:32.737] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:32.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:106:0) after 1m0s
[05:38:32.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:106:0)
[05:38:32.760] Timer tick, asking Buildbucket for the build status
[05:38:32.869] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:32.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:107:0) after 1m0s
[05:39:32.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:107:0)
[05:39:32.897] Timer tick, asking Buildbucket for the build status
[05:39:32.994] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:32.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:108:0) after 1m0s
[05:40:32.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:108:0)
[05:40:32.996] Timer tick, asking Buildbucket for the build status
[05:40:33.421] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:33.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:109:0) after 1m0s
[05:41:33.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:109:0)
[05:41:33.444] Timer tick, asking Buildbucket for the build status
[05:41:33.537] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:33.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:110:0) after 1m0s
[05:42:33.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:110:0)
[05:42:33.642] Timer tick, asking Buildbucket for the build status
[05:42:33.994] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:111:0) after 1m0s
[05:43:34.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:111:0)
[05:43:34.022] Timer tick, asking Buildbucket for the build status
[05:43:34.126] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:34.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:112:0) after 1m0s
[05:44:34.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:112:0)
[05:44:34.165] Timer tick, asking Buildbucket for the build status
[05:44:34.319] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:34.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:113:0) after 1m0s
[05:45:34.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:113:0)
[05:45:34.384] Timer tick, asking Buildbucket for the build status
[05:45:34.480] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:34.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:114:0) after 1m0s
[05:46:34.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:114:0)
[05:46:34.530] Timer tick, asking Buildbucket for the build status
[05:46:34.614] Build 8855624226396500240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:34.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021054288827236400:115:0) after 1m0s
[05:46:44.056] Received PubSub notification, asking Buildbucket for the build status
[05:46:44.153] Build 8855624226396500240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:46:44.153] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613022403231627",
"created_by": "project:chromium",
"created_ts": "1613015641748128",
"id": "8855624226396500240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43261c16faf02490a9c99d51f6b171407727ca6e\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"43261c16faf02490a9c99d51f6b171407727ca6e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-112-6q8x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22577, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"7e80cce1a9065d60522d470d24526394d642e6d5\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"43261c16faf02490a9c99d51f6b171407727ca6e\", \"got_revision_cp\": \"refs/heads/master@{#852983}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"45ea66edc82419c79bba183762142785bb5a72e2\", \"got_v8_revision_cp\": \"refs/heads/9.0.162@{#1}\", \"got_webrtc_revision\": \"8bf61a3071b7306860261eadf43c157ce3ffe4fe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33223}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43261c16faf02490a9c99d51f6b171407727ca6e\", \"swarm_hashes_refs/heads/master(at){#852983}_without_patch\": {\"absl_hardening_tests\": \"c7b028e84bb9cc2dd8dce7c96bc1efc9953cf05f\", \"accessibility_unittests\": \"df0faf261a9bd338b7743b0daa25e348ad14b2db\", \"angle_unittests\": \"c843b20cfb3321bf48149f515b9d67e99ef603ef\", \"app_list_unittests\": \"c52e94452759c67b46953fcb893cd66d77bb0e23\", \"app_shell_unittests\": \"a50db0a37411aba2aa0c5dd5484fa48da4f0dee5\", \"ash_unittests\": \"0e3ab33bc4fd47584991294c82aa3ccad4f2cc85\", \"aura_unittests\": \"9f0721f37f628ebfcd1a5da7867e45e8299505ab\", \"base_unittests\": \"9d4970490fb0787fa2237e518281c68a83ea2547\", \"base_util_unittests\": \"31dffdd79e53f9ef2169480533fb231549b5e7ac\", \"blink_common_unittests\": \"046cb3d08a016ddc895b8f17503b301e65dd37b6\", \"blink_fuzzer_unittests\": \"4ac5fd68d035120b3915a9c12369ac4447b6f240\", \"blink_heap_unittests\": \"5a6977b11f43a661cefd4256b6155fc04a7052d9\", \"blink_platform_unittests\": \"b47339a7d106d2a189edee6409d326915cc441fa\", \"blink_unittests\": \"7d0d25dc3d617f35b6e03b72db86579989863a8a\", \"boringssl_crypto_tests\": \"f69e67958b22ceffdf296d8300a6de7cad775ba4\", \"boringssl_ssl_tests\": \"728123ffaa330f0becad8392baf727d384993dc8\", \"browser_tests\": \"cc500f2a7867b6dea9741988cbdbc095453437c1\", \"capture_unittests\": \"7ab77da20dbfc973525ffc3355aeea5f893a61ef\", \"cast_unittests\": \"4658a1a57054819233f2847ebf50563d9c86023e\", \"cc_unittests\": \"0df05e2755270342537f400fb723ddc0fcec8620\", \"chrome_app_unittests\": \"db8b3668257ea355ffc5d7a67920563078779cc3\", \"chromedriver_unittests\": \"1f9c40604f5e4bca6708c5c95abe205d97dcfb7f\", \"chromeos_components_unittests\": \"ee3581d901cb6e2d02a9e784c853b040415c6ec3\", \"chromeos_unittests\": \"accda1af0dc047e7ceac4309fbf900c246e5139e\", \"components_browsertests\": \"c29333591c620c635d1e7f94d1a78ee0f869ae21\", \"components_unittests\": \"8939903e74d6d4ba732d3799508caf0d422a56dd\", \"compositor_unittests\": \"089f068bdee8bef40b8a55e4d79c5cc7c5117528\", \"content_browsertests\": \"b1d9288959c5084248f81d99e582250fb2ff6f32\", \"content_unittests\": \"8ead49906ce113b42112e6705df34dad89093392\", \"crashpad_tests\": \"a763cac5d82d1a88cbe8a84ee20027802851cefc\", \"crypto_unittests\": \"5cdb225e8e74ae4f4458615bab335cc47d273d25\", \"dbus_unittests\": \"1c2d9c38220aee519f7a79e8744cd32c98d0bd90\", \"device_unittests\": \"a958360d022afe5d105465aebfdad9781af56a1d\", \"display_unittests\": \"5795a9d3575dc40136942cee9f534ee861468be5\", \"events_unittests\": \"6548b94f578f89049e331f3ca965cad7acf0661b\", \"exo_unittests\": \"b4e63e34d66be254a908a3753f6c4b0e51d014ba\", \"extensions_browsertests\": \"ac61c7828d2970adc2cec436a2616512052625d3\", \"extensions_unittests\": \"12ab92dd552774ea9073d667552abbf3d089d7fa\", \"filesystem_service_unittests\": \"333854a1e03931b40034a3e69bb503dfdae25b1b\", \"gcm_unit_tests\": \"6fd8f0643c8dd894e2a16b0e8f2a8e36992cd05d\", \"gfx_unittests\": \"be0ef4ce2b65b2327d124506f19e11226b1e6a13\", \"gin_unittests\": \"ceb209d4c648630fe7c50bafddd6990769ac447d\", \"gl_unittests_ozone\": \"cb1d185a4c6c5202e8e2107c0284311ee40af470\", \"google_apis_unittests\": \"e6f973ad117795eb0479b05c123636ee1d036bb2\", \"gpu_unittests\": \"f4c47c97810ff05370e6b00b627a3d9513103612\", \"gwp_asan_unittests\": \"efe67137435820f666cbcd129f1ee4e9f3b61b7f\", \"interactive_ui_tests\": \"4c1166412a4b969c0bf0786cf6c92c544ee7bde2\", \"ipc_tests\": \"a74af5ade26881f708b7947ebb4d3d2c6f296b99\", \"jingle_unittests\": \"e3dd640a3adec966f4bc79979a4ccaa907f1c9f4\", \"keyboard_unittests\": \"489c391bdc70d0c6b7146c28f65421bad257b895\", \"latency_unittests\": \"85230cbc8fc5da1e80ae56e873bc42a984452f80\", \"libjingle_xmpp_unittests\": \"98dbf09cffac1779f87fc557bdf4d2dd89715541\", \"liburlpattern_unittests\": \"c2f052df196578af0ce082eceb6bf317fb21723d\", \"media_blink_unittests\": \"0b362e4f12e19eddb602dff05857c5bdd53fb928\", \"media_unittests\": \"fac8cdf410ea07380d7fa4b7e6b28fc35839a4be\", \"message_center_unittests\": \"7b9b0dc31e8eb65e1393eb73f8c9b16d0aeda9b3\", \"midi_unittests\": \"b975ed733f11e97b0373af494c61a1bb636e98d2\", \"mojo_core_unittests\": \"4a47167fb86f298e1e73f3cf2f94a5eb5ae435cc\", \"mojo_unittests\": \"bb8be25f00a122516f790a0344c71cad82034e99\", \"nacl_helper_nonsfi_unittests\": \"e95ff09be09bba8851b7ac02fd3aa453e9e33ed9\", \"nacl_loader_unittests\": \"ce73635aeb8f77d3823f74b63513f584a638f376\", \"native_theme_unittests\": \"ea9e3325df30467fcad8c22647a547cbd725ab16\", \"net_unittests\": \"f4eb520cae8f093b2ff9a9b8645d4e245265fad7\", \"ozone_gl_unittests\": \"7289d8b65995d218d89fd4df5d86fdd956966bac\", \"ozone_unittests\": \"eb364163b8b3868b91593abae92ab4538591d696\", \"ozone_x11_unittests\": \"f3b097a2352b059aa71ccb9b19b68d0deb85a517\", \"pdf_unittests\": \"af932cc17a5f2242dd7ad6259bd90c881703c73e\", \"perfetto_unittests\": \"12d3aa3f7b776406f1993002da813c8d5d2f4e07\", \"ppapi_unittests\": \"4db98ae974cc5038f6a0ad78e00c82d13908fb25\", \"printing_unittests\": \"8a600a76bf5128e5b1c88083972065b3d9b2ce7f\", \"remoting_unittests\": \"c6a5886fcd7142c02e1caf4d98c1f0829932efc8\", \"sandbox_linux_unittests\": \"27afbcd5214b58534ab3d335ed0cafd43f4c1f80\", \"service_manager_unittests\": \"78492a64777774cd91ffb12cc29921e8f3c11e67\", \"services_unittests\": \"81c2801409ef5eb99864597ebbf79fa040f5f3f3\", \"shell_dialogs_unittests\": \"cb1544a01b37b84dbd5f3b74b0662703d3015a69\", \"shell_encryption_unittests\": \"98325ebd468a00d7f5851e1409331cb7b84a2322\", \"skia_unittests\": \"5d474e82ccebd57649ec722ebe5d43c5cae86ea2\", \"snapshot_unittests\": \"1295e02eac1d49f10be9c94764523b27d611ff16\", \"sql_unittests\": \"d27323f35ef1c762fa3d4cab33ea1346e2bed1c8\", \"storage_unittests\": \"443252fc5ff5f9c85b0909c245eb85605a36cd73\", \"sync_integration_tests\": \"b43e387eddcc768cb9de65df896b7d1359b6256b\", \"traffic_annotation_auditor_unittests\": \"08cae7d4c07b1902e0d3b0b5327178a0e927fb17\", \"ui_base_unittests\": \"347625017839500ad8eaee1cf469564050b1c26c\", \"ui_chromeos_unittests\": \"bc06ab6f140979044836fae738d5cddab1980471\", \"ui_touch_selection_unittests\": \"059debc11827f3bbbf6e081a258be7f9f3cf6d26\", \"unit_tests\": \"54013b31a11363ffba088c41ecf7e232a8623b4a\", \"url_unittests\": \"d9cdc605c48cc95bb3ef0c63e9758f7f122d0cb3\", \"usage_time_limit_unittests\": \"bf99dbf3ac0b29dc16861bee36d842ba52dfbcba\", \"views_unittests\": \"92da9c0745dc0069ae49071b9d80a4060d347c87\", \"viz_unittests\": \"818b7d29ca9b2e1f3c88eff04b7fb2da3019662c\", \"wm_unittests\": \"46aa727cd6cce54029fadb8efc3905d130765547\", \"wtf_unittests\": \"c05bdd304610875f15c79c407f038e9aac3c9134\", \"zlib_unittests\": \"588b44f8eb0388934af713df095facf76b2bca5d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0cd6cf41ec42413cc9e5bdc0dde565dc7bee061bff1a52db1e25d07760950df7_v2\", \"builder_32fed5bd11a2ad829097c105a8f00e15a083b7610bf548938e25142374c8b8ba_v2\", \"builder_4107b14b7476412be0315d38f8e370eb2ac2c1b388bb8ffb59d7bdd8f08032e9_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_a3b3a06131dfa9924971b27d0acd4e18e80a2242b6d6ae41f94b770d7c996d6f_v2\", \"builder_a942695c23e0ee058ce93eb378e4719ec038e7b245f732574f7a4ff5c9d830ce_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_e0d3a8c5b74a8b9e2a6656b2b613ed1c1629c2e0335e57d66a6def72c72861a0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-112-6q8x\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613015887026111",
"status": "COMPLETED",
"status_changed_ts": "1613022403619487",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22577",
"builder:linux-chromeos-dbg",
"buildset:commit/git/43261c16faf02490a9c99d51f6b171407727ca6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43261c16faf02490a9c99d51f6b171407727ca6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021054288827236400",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855624226396500240/+/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:51a80afc4ed05b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613022403624615",
"url": "https://ci.chromium.org/b/8855624226396500240",
"utcnow_ts": "1613022404141831"
}
}
[05:46:44.153] Invocation finished in 1h52m44.105255314s with status SUCCEEDED