[03:40:18.763] New invocation is queued and will start shortly
[03:40:20.000] Starting the invocation (attempt 1)
[03:40:20.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:40:20.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:40:20.083] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018427837998975664",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018427837998975664",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"gitiles_ref:refs/heads/master"
]
}
[03:40:20.830] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615520420223424",
"id": "8852997775802236752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615520420717948",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22959",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018427837998975664",
"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/8852997775802236752/+/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": "1615520420718062",
"url": "https://ci.chromium.org/b/8852997775802236752",
"utcnow_ts": "1615520420822787"
}
}
[03:40:20.830] Task URL: https://ci.chromium.org/b/8852997775802236752
[03:40:20.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:2:0) after 1m0s
[03:40:31.163] Received PubSub notification, asking Buildbucket for the build status
[03:40:31.245] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:20.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:2:0)
[03:41:20.836] Timer tick, asking Buildbucket for the build status
[03:41:20.935] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:20.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:4:0) after 1m0s
[03:42:20.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:4:0)
[03:42:20.940] Timer tick, asking Buildbucket for the build status
[03:42:21.004] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:5:0) after 1m0s
[03:43:21.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:5:0)
[03:43:21.051] Timer tick, asking Buildbucket for the build status
[03:43:21.130] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:21.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:6:0) after 1m0s
[03:44:21.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:6:0)
[03:44:21.155] Timer tick, asking Buildbucket for the build status
[03:44:21.232] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:21.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:7:0) after 1m0s
[03:45:21.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:7:0)
[03:45:21.242] Timer tick, asking Buildbucket for the build status
[03:45:21.316] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:21.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:8:0) after 1m0s
[03:46:21.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:8:0)
[03:46:21.385] Timer tick, asking Buildbucket for the build status
[03:46:21.465] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:21.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:9:0) after 1m0s
[03:47:21.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:9:0)
[03:47:21.449] Timer tick, asking Buildbucket for the build status
[03:47:21.720] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:10:0) after 1m0s
[03:48:21.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:10:0)
[03:48:21.767] Timer tick, asking Buildbucket for the build status
[03:48:21.860] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:21.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:11:0) after 1m0s
[03:49:21.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:11:0)
[03:49:21.911] Timer tick, asking Buildbucket for the build status
[03:49:22.147] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:22.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:12:0) after 1m0s
[03:50:22.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:12:0)
[03:50:22.140] Timer tick, asking Buildbucket for the build status
[03:50:22.395] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:22.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:13:0) after 1m0s
[03:51:22.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:13:0)
[03:51:22.411] Timer tick, asking Buildbucket for the build status
[03:51:22.680] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:22.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:14:0) after 1m0s
[03:52:22.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:14:0)
[03:52:22.676] Timer tick, asking Buildbucket for the build status
[03:52:22.794] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:15:0) after 1m0s
[03:53:22.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:15:0)
[03:53:22.807] Timer tick, asking Buildbucket for the build status
[03:53:22.997] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:22.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:16:0) after 1m0s
[03:54:23.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:16:0)
[03:54:23.035] Timer tick, asking Buildbucket for the build status
[03:54:23.202] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:23.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:17:0) after 1m0s
[03:55:23.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:17:0)
[03:55:23.266] Timer tick, asking Buildbucket for the build status
[03:55:23.361] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:23.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:18:0) after 1m0s
[03:56:23.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:18:0)
[03:56:23.381] Timer tick, asking Buildbucket for the build status
[03:56:23.467] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:23.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:19:0) after 1m0s
[03:57:23.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:19:0)
[03:57:23.491] Timer tick, asking Buildbucket for the build status
[03:57:23.568] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:23.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:20:0) after 1m0s
[03:58:23.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:20:0)
[03:58:23.649] Timer tick, asking Buildbucket for the build status
[03:58:23.715] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:21:0) after 1m0s
[03:59:23.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:21:0)
[03:59:23.780] Timer tick, asking Buildbucket for the build status
[03:59:23.849] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:23.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:22:0) after 1m0s
[04:00:23.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:22:0)
[04:00:23.940] Timer tick, asking Buildbucket for the build status
[04:00:24.045] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:24.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:23:0) after 1m0s
[04:01:24.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:23:0)
[04:01:24.278] Timer tick, asking Buildbucket for the build status
[04:01:24.345] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:24.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:24:0) after 1m0s
[04:02:24.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:24:0)
[04:02:24.427] Timer tick, asking Buildbucket for the build status
[04:02:24.490] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:24.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:25:0) after 1m0s
[04:03:24.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:25:0)
[04:03:24.539] Timer tick, asking Buildbucket for the build status
[04:03:24.871] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:24.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:26:0) after 1m0s
[04:04:24.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:26:0)
[04:04:24.892] Timer tick, asking Buildbucket for the build status
[04:04:24.978] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:24.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:27:0) after 1m0s
[04:05:25.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:27:0)
[04:05:25.098] Timer tick, asking Buildbucket for the build status
[04:05:25.191] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:25.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:28:0) after 1m0s
[04:06:25.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:28:0)
[04:06:25.212] Timer tick, asking Buildbucket for the build status
[04:06:25.420] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:25.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:29:0) after 1m0s
[04:07:25.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:29:0)
[04:07:25.636] Timer tick, asking Buildbucket for the build status
[04:07:25.724] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:25.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:30:0) after 1m0s
[04:08:25.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:30:0)
[04:08:25.798] Timer tick, asking Buildbucket for the build status
[04:08:25.934] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:25.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:31:0) after 1m0s
[04:09:26.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:31:0)
[04:09:26.003] Timer tick, asking Buildbucket for the build status
[04:09:26.068] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:26.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:32:0) after 1m0s
[04:10:26.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:32:0)
[04:10:26.118] Timer tick, asking Buildbucket for the build status
[04:10:26.207] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:26.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:33:0) after 1m0s
[04:11:26.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:33:0)
[04:11:26.353] Timer tick, asking Buildbucket for the build status
[04:11:26.556] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:26.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:34:0) after 1m0s
[04:12:26.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:34:0)
[04:12:26.714] Timer tick, asking Buildbucket for the build status
[04:12:26.786] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:26.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:35:0) after 1m0s
[04:13:26.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:35:0)
[04:13:26.799] Timer tick, asking Buildbucket for the build status
[04:13:27.038] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:27.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:36:0) after 1m0s
[04:14:27.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:36:0)
[04:14:27.183] Timer tick, asking Buildbucket for the build status
[04:14:27.268] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:37:0) after 1m0s
[04:15:27.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:37:0)
[04:15:27.329] Timer tick, asking Buildbucket for the build status
[04:15:27.633] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:27.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:38:0) after 1m0s
[04:16:27.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:38:0)
[04:16:27.702] Timer tick, asking Buildbucket for the build status
[04:16:27.779] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:27.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:39:0) after 1m0s
[04:17:27.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:39:0)
[04:17:27.773] Timer tick, asking Buildbucket for the build status
[04:17:27.853] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:27.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:40:0) after 1m0s
[04:18:27.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:40:0)
[04:18:27.887] Timer tick, asking Buildbucket for the build status
[04:18:27.955] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:27.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:41:0) after 1m0s
[04:19:27.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:41:0)
[04:19:27.973] Timer tick, asking Buildbucket for the build status
[04:19:28.122] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:28.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:42:0) after 1m0s
[04:20:28.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:42:0)
[04:20:28.121] Timer tick, asking Buildbucket for the build status
[04:20:28.202] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:28.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:43:0) after 1m0s
[04:21:28.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:43:0)
[04:21:28.224] Timer tick, asking Buildbucket for the build status
[04:21:28.619] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:28.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:44:0) after 1m0s
[04:22:28.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:44:0)
[04:22:28.707] Timer tick, asking Buildbucket for the build status
[04:22:28.814] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:28.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:45:0) after 1m0s
[04:23:28.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:45:0)
[04:23:28.822] Timer tick, asking Buildbucket for the build status
[04:23:28.948] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:28.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:46:0) after 1m0s
[04:24:28.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:46:0)
[04:24:28.956] Timer tick, asking Buildbucket for the build status
[04:24:29.306] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:29.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:47:0) after 1m0s
[04:25:29.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:47:0)
[04:25:29.384] Timer tick, asking Buildbucket for the build status
[04:25:29.788] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:29.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:48:0) after 1m0s
[04:26:29.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:48:0)
[04:26:29.820] Timer tick, asking Buildbucket for the build status
[04:26:29.896] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:29.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:49:0) after 1m0s
[04:27:29.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:49:0)
[04:27:29.920] Timer tick, asking Buildbucket for the build status
[04:27:29.995] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:29.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:50:0) after 1m0s
[04:28:30.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:50:0)
[04:28:30.069] Timer tick, asking Buildbucket for the build status
[04:28:30.362] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:30.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:51:0) after 1m0s
[04:29:30.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:51:0)
[04:29:30.443] Timer tick, asking Buildbucket for the build status
[04:29:30.555] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:30.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:52:0) after 1m0s
[04:30:30.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:52:0)
[04:30:30.600] Timer tick, asking Buildbucket for the build status
[04:30:30.927] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:53:0) after 1m0s
[04:31:30.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:53:0)
[04:31:30.973] Timer tick, asking Buildbucket for the build status
[04:31:31.070] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:31.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:54:0) after 1m0s
[04:32:31.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:54:0)
[04:32:31.147] Timer tick, asking Buildbucket for the build status
[04:32:31.229] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:31.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:55:0) after 1m0s
[04:33:31.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:55:0)
[04:33:31.392] Timer tick, asking Buildbucket for the build status
[04:33:31.623] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:31.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:56:0) after 1m0s
[04:34:31.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:56:0)
[04:34:31.718] Timer tick, asking Buildbucket for the build status
[04:34:31.830] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:31.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:57:0) after 1m0s
[04:35:31.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:57:0)
[04:35:31.913] Timer tick, asking Buildbucket for the build status
[04:35:32.020] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:32.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:58:0) after 1m0s
[04:36:32.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:58:0)
[04:36:32.101] Timer tick, asking Buildbucket for the build status
[04:36:32.188] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:32.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:59:0) after 1m0s
[04:37:32.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:59:0)
[04:37:32.252] Timer tick, asking Buildbucket for the build status
[04:37:32.506] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:32.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:60:0) after 1m0s
[04:38:32.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:60:0)
[04:38:32.527] Timer tick, asking Buildbucket for the build status
[04:38:32.597] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:32.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:61:0) after 1m0s
[04:39:32.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:61:0)
[04:39:32.649] Timer tick, asking Buildbucket for the build status
[04:39:32.721] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:62:0) after 1m0s
[04:40:32.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:62:0)
[04:40:32.812] Timer tick, asking Buildbucket for the build status
[04:40:32.911] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:32.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:63:0) after 1m0s
[04:41:32.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:63:0)
[04:41:32.975] Timer tick, asking Buildbucket for the build status
[04:41:33.271] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:33.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:64:0) after 1m0s
[04:42:33.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:64:0)
[04:42:33.312] Timer tick, asking Buildbucket for the build status
[04:42:33.818] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:33.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:65:0) after 1m0s
[04:43:33.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:65:0)
[04:43:33.840] Timer tick, asking Buildbucket for the build status
[04:43:33.921] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:33.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:66:0) after 1m0s
[04:44:33.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:66:0)
[04:44:33.935] Timer tick, asking Buildbucket for the build status
[04:44:34.058] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:34.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:67:0) after 1m0s
[04:45:34.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:67:0)
[04:45:34.041] Timer tick, asking Buildbucket for the build status
[04:45:34.139] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:68:0) after 1m0s
[04:46:34.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:68:0)
[04:46:34.131] Timer tick, asking Buildbucket for the build status
[04:46:34.252] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:34.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:69:0) after 1m0s
[04:47:34.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:69:0)
[04:47:34.299] Timer tick, asking Buildbucket for the build status
[04:47:34.490] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:34.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:70:0) after 1m0s
[04:48:34.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:70:0)
[04:48:34.603] Timer tick, asking Buildbucket for the build status
[04:48:36.418] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:36.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:71:0) after 1m0s
[04:49:36.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:71:0)
[04:49:36.468] Timer tick, asking Buildbucket for the build status
[04:49:36.583] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:36.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:72:0) after 1m0s
[04:50:36.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:72:0)
[04:50:36.712] Timer tick, asking Buildbucket for the build status
[04:50:36.804] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:36.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:73:0) after 1m0s
[04:51:36.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:73:0)
[04:51:36.880] Timer tick, asking Buildbucket for the build status
[04:51:36.961] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:36.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:74:0) after 1m0s
[04:52:37.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:74:0)
[04:52:37.008] Timer tick, asking Buildbucket for the build status
[04:52:37.255] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:37.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:75:0) after 1m0s
[04:53:37.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:75:0)
[04:53:37.328] Timer tick, asking Buildbucket for the build status
[04:53:37.415] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:76:0) after 1m0s
[04:54:37.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:76:0)
[04:54:37.417] Timer tick, asking Buildbucket for the build status
[04:54:37.546] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:37.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:77:0) after 1m0s
[04:55:37.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:77:0)
[04:55:37.626] Timer tick, asking Buildbucket for the build status
[04:55:37.724] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:37.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:78:0) after 1m0s
[04:56:37.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:78:0)
[04:56:37.727] Timer tick, asking Buildbucket for the build status
[04:56:37.818] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:37.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:79:0) after 1m0s
[04:57:37.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:79:0)
[04:57:37.852] Timer tick, asking Buildbucket for the build status
[04:57:37.936] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:37.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:80:0) after 1m0s
[04:58:38.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:80:0)
[04:58:38.012] Timer tick, asking Buildbucket for the build status
[04:58:38.092] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:38.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:81:0) after 1m0s
[04:59:38.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:81:0)
[04:59:38.148] Timer tick, asking Buildbucket for the build status
[04:59:38.224] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:82:0) after 1m0s
[05:00:38.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:82:0)
[05:00:38.315] Timer tick, asking Buildbucket for the build status
[05:00:38.407] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:38.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:83:0) after 1m0s
[05:01:38.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:83:0)
[05:01:38.438] Timer tick, asking Buildbucket for the build status
[05:01:38.524] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:38.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:84:0) after 1m0s
[05:02:38.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:84:0)
[05:02:38.549] Timer tick, asking Buildbucket for the build status
[05:02:38.648] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:38.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:85:0) after 1m0s
[05:03:38.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:85:0)
[05:03:38.668] Timer tick, asking Buildbucket for the build status
[05:03:38.783] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:38.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:86:0) after 1m0s
[05:04:38.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:86:0)
[05:04:38.830] Timer tick, asking Buildbucket for the build status
[05:04:38.906] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:38.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:87:0) after 1m0s
[05:05:39.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:87:0)
[05:05:39.013] Timer tick, asking Buildbucket for the build status
[05:05:39.105] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:88:0) after 1m0s
[05:06:39.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:88:0)
[05:06:39.242] Timer tick, asking Buildbucket for the build status
[05:06:39.325] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:39.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:89:0) after 1m0s
[05:07:39.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:89:0)
[05:07:39.417] Timer tick, asking Buildbucket for the build status
[05:07:39.509] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:39.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:90:0) after 1m0s
[05:08:39.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:90:0)
[05:08:39.615] Timer tick, asking Buildbucket for the build status
[05:08:39.695] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:39.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:91:0) after 1m0s
[05:09:40.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:91:0)
[05:09:40.007] Timer tick, asking Buildbucket for the build status
[05:09:40.091] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:40.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:92:0) after 1m0s
[05:10:40.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:92:0)
[05:10:40.128] Timer tick, asking Buildbucket for the build status
[05:10:40.231] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:40.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:93:0) after 1m0s
[05:11:40.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:93:0)
[05:11:40.310] Timer tick, asking Buildbucket for the build status
[05:11:40.512] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:94:0) after 1m0s
[05:12:40.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:94:0)
[05:12:40.533] Timer tick, asking Buildbucket for the build status
[05:12:40.629] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:40.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:95:0) after 1m0s
[05:13:40.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:95:0)
[05:13:40.672] Timer tick, asking Buildbucket for the build status
[05:13:41.083] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:41.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:96:0) after 1m0s
[05:14:41.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:96:0)
[05:14:41.160] Timer tick, asking Buildbucket for the build status
[05:14:41.463] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:41.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:97:0) after 1m0s
[05:15:41.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:97:0)
[05:15:41.538] Timer tick, asking Buildbucket for the build status
[05:15:41.618] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:41.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:98:0) after 1m0s
[05:16:41.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:98:0)
[05:16:41.737] Timer tick, asking Buildbucket for the build status
[05:16:41.809] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:41.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:99:0) after 1m0s
[05:17:41.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:99:0)
[05:17:41.915] Timer tick, asking Buildbucket for the build status
[05:17:41.996] Build 8852997775802236752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:41.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018427837998975664:100:0) after 1m0s
[05:18:02.024] Received PubSub notification, asking Buildbucket for the build status
[05:18:02.411] Build 8852997775802236752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:18:02.411] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615526281177327",
"created_by": "project:chromium",
"created_ts": "1615520420223424",
"id": "8852997775802236752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\"}}",
"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\": \"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\", \"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-44-4rk7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22959, \"got_angle_revision\": \"cb5441ed17ae58ccec9562a1ffe4eed2351c5c60\", \"got_dawn_revision\": \"0702b704697ca0c9d4b41faeb1d3f80e10f07278\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\", \"got_revision_cp\": \"refs/heads/master@{#862284}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3c4fd15fb075ab3a8eb5809f9a42b5faa9ac63ae\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"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\": \"f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3\", \"swarm_hashes_refs/heads/master(at){#862284}_without_patch\": {\"absl_hardening_tests\": \"e173691b9fc44c40a239a63f397aeb2bb7dc270c\", \"accessibility_unittests\": \"f7b1dee2c533a26cdbfa0244253f5ad9b3446aa5\", \"angle_unittests\": \"afcf2f86c8ef42d2faa418dc76d18c45d0065ec8\", \"app_list_unittests\": \"5c035f0ee187557f6ce3b70a90aebcf700026739\", \"app_shell_unittests\": \"487340dfb47ffb4c652f25d3eda2c8fd03068a4e\", \"ash_unittests\": \"25f3b8acbf2733a539a375b02e48d3ae7d812b1d\", \"aura_unittests\": \"15f2be5a4c265e806ffeef72b7ae0834a7807873\", \"base_unittests\": \"0787a3709a303dddba7d45c0f54f4b0740440187\", \"base_util_unittests\": \"6809b9e0079b00f693fb70d67e328b6945252cc7\", \"blink_common_unittests\": \"be99775ecc7ae4f3d1d9596ea4309658999146d1\", \"blink_fuzzer_unittests\": \"a5b0ea75f6a2af3673557431efc97b72b7af4158\", \"blink_heap_unittests\": \"bf42e6cb573bcc075804b42d8af1db62ed70dbf6\", \"blink_platform_unittests\": \"d846db586c2877117b525fe988dc194e51ab94d8\", \"blink_unittests\": \"3321e36005d9872ef0ad4d17ff395faecb918e58\", \"boringssl_crypto_tests\": \"22ada858a3b0c1be2e1160a3885227dccd6f9b50\", \"boringssl_ssl_tests\": \"854f02621210a1b211e61d2bdf0bc21c772cafda\", \"browser_tests\": \"0018cd686e0f592c50f712716f7db4d80b08b0f1\", \"capture_unittests\": \"8a81b204f6bb1334bf7fb4ce91023bbddd439630\", \"cast_unittests\": \"3967dee907266a526597c49a66bda9be10c85f66\", \"cc_unittests\": \"dbc2af48c03afbc8940a8a7d41a6c3dd0a67e70d\", \"chrome_app_unittests\": \"967c165bffafee8ca6beaf86d14f561e65b282ff\", \"chromedriver_unittests\": \"7130380eec086ffb44abef208c63b34f7edc2255\", \"chromeos_components_unittests\": \"ebb7b42abb0169491753debc8775a6978372fb18\", \"chromeos_unittests\": \"569a82ca1f8493c6dfd98a726ff226ab0b34ea50\", \"color_unittests\": \"65cc9b83ec9c0eb7655368d5ecc94893028e3343\", \"components_browsertests\": \"e21d5036aac20ee1335333c899a9c1b68f37e443\", \"components_unittests\": \"cc5f717262c2d57ca62b565e469b036a405a160c\", \"compositor_unittests\": \"c7ecf6c6a81a72cfbbe42ec169fff9aef3239e13\", \"content_browsertests\": \"fa9decc3d008fb0969fa605de76275f95806d2d7\", \"content_unittests\": \"8f753d2a97f2105c6306446ce700be68f777e1b7\", \"crashpad_tests\": \"4b6691b86617025d7d5c81e8d8e11b0bfb701f4c\", \"crypto_unittests\": \"be71fa6c6d422e0368858baede2502be88ffff2d\", \"dbus_unittests\": \"058e8885efa3ec364226ed4099bc33777baccc4f\", \"device_unittests\": \"45084d646aa936cd0ae46f602584ad14d36b4509\", \"display_unittests\": \"24697f26615e33d3c464baa50981984d39627272\", \"events_unittests\": \"5f6e2ee2fd145bd73b5b288fff0ff8d473c6f097\", \"exo_unittests\": \"0c54a1b0e90a8a7aa4676007cc0c129cd639b5ad\", \"extensions_browsertests\": \"f869c3baa63f972973f8fa51d436f08e5505d458\", \"extensions_unittests\": \"725c4787f4d849812c2a38c9aa7555abc9b6297d\", \"filesystem_service_unittests\": \"d30ca3679bda3eeb19f072a1bf0607521696c7a0\", \"gcm_unit_tests\": \"e90bac008163df25a4afbf4fbe9172ae79287f85\", \"gfx_unittests\": \"6111686dfb60050f92330e5698288cf027991616\", \"gin_unittests\": \"bdd88ba92a0c3651edcf3ce50bed4a35b8713a72\", \"gl_unittests_ozone\": \"0eabefed1d63a7a8c7f97705d9b8a226e70063e4\", \"google_apis_unittests\": \"7a4d62e5903c36baea2266fe524d09d7a94907af\", \"gpu_unittests\": \"f08ee2cb41cf673f7d2cfb9f4ad441b594bff76a\", \"gwp_asan_unittests\": \"0e8095faecbe7f44f5035406b850c57e5ffc220c\", \"interactive_ui_tests\": \"73605f673a57c5449cadfc179ed75fc2d5d2a0e3\", \"ipc_tests\": \"a3030c2ea928da86a82768e313732a334b9e2c64\", \"jingle_unittests\": \"fe8b1fa81847b19777854a7db68ee841ec6fb693\", \"keyboard_unittests\": \"9bfd3edc52f3f5a18d3daff73a317e1e8e714f8f\", \"latency_unittests\": \"57f5be433da6cb5e31fc070275bb57cb56c50959\", \"libjingle_xmpp_unittests\": \"18325c6814ffe4dd3792ff9928ebcb876bab7eb8\", \"liburlpattern_unittests\": \"4c3ef8a4250cf7f84b0451487963a9249be0539f\", \"media_blink_unittests\": \"266b693ae464dcd988fb5333a24acc0e33fa16c1\", \"media_unittests\": \"e016a964335b8e4b9cc7e0df76f3d5ada6660550\", \"message_center_unittests\": \"ac53af75641f91d182e65579cb265d2c6b46fc4e\", \"midi_unittests\": \"ff541d75d36e4cd0027b659f04bcd92e293bd216\", \"mojo_core_unittests\": \"f301aa4c515ba1c34b9cd5b2e4b3161958fd138e\", \"mojo_unittests\": \"b29f800a0c4f2be22b304732165959d631bc0f2b\", \"nacl_helper_nonsfi_unittests\": \"6a36f4e9e28a14305e4d2d8a33bca175bcd34fb7\", \"nacl_loader_unittests\": \"f53e56ba247e11de5ec469b475cde1b7159dd0e6\", \"native_theme_unittests\": \"af193cc4d58699a6e79bc1c9b87cd78b71480f91\", \"net_unittests\": \"56867eb54ad2b7b7a92be5fe67d621b24a54131d\", \"ozone_gl_unittests\": \"0013ab098be22133fcab1baa461d5a977d964790\", \"ozone_unittests\": \"dbdf4f760357a4f26f812f92c12414fd18fcd092\", \"ozone_x11_unittests\": \"82b5f586306de08b1f836d9be1afe052e562b062\", \"pdf_unittests\": \"41370a768dbd48a42cf8a2444fe7e8a2a36c546f\", \"perfetto_unittests\": \"dc3fd748543250e12d8c6dd6ede92c4236c2fd25\", \"ppapi_unittests\": \"4f592fa415b7dac000bf659d063dd6d5e08ef1ae\", \"printing_unittests\": \"289e2621876fd44c408028a2344b19471d7b3fcd\", \"remoting_unittests\": \"35a23f902142ce3f831e5ced68ad9141d5ea70c7\", \"sandbox_linux_unittests\": \"fdde25d30ab0ae8ad6e09384845956ab90540c8f\", \"service_manager_unittests\": \"3ba5571357c5bd45092cdc5a82c52f1826f6a7fa\", \"services_unittests\": \"10814cf0c2f8c338d4cf1069a7c0c2a1b6bf8cff\", \"shell_dialogs_unittests\": \"f684bde8ab91fa74bb001d508f881aeb30ad01c0\", \"shell_encryption_unittests\": \"e02a9c0df06d471fc52f70af9b78f1aacc6a5719\", \"skia_unittests\": \"0db005d2ff5452898802974020ffa3ef05338882\", \"snapshot_unittests\": \"b5614506183defc642dad05404d1ab5e9a208ca2\", \"sql_unittests\": \"b0df161a6595247caaf7deb17cf5435bfedbc970\", \"storage_unittests\": \"85e187338d65f35a37b7f58cc112cdf0fe7b1f3b\", \"sync_integration_tests\": \"4166d23052899301845fc5aab3ba2a3fa9775400\", \"traffic_annotation_auditor_unittests\": \"fd2f469508fc5bbed18b4aa8cb165d1ed6629839\", \"ui_base_unittests\": \"0f76c97c5e72bb584945b65a4bf40c722926a553\", \"ui_chromeos_unittests\": \"bac18943496cc8bfb09e18b6d1894025af062ccc\", \"ui_touch_selection_unittests\": \"25a509f2d40112b67f9f22118521798091f65494\", \"unit_tests\": \"62080ac31f5642042990060aaf5838aeb096f6ad\", \"url_unittests\": \"8fd668f0bc72f039cd3b6ed913b21479e1ce866d\", \"usage_time_limit_unittests\": \"339e7c333374157e43b2bc4665975cd26793833b\", \"views_unittests\": \"5353c9cb099626abc78b73d55fdeed92330fb378\", \"viz_unittests\": \"4ba49b384a3366eefbc4e0fafa91ca530b650c0b\", \"wayland_client_tests\": \"c35d617f4ce0019a5e817af5679d5e6a205054e2\", \"wm_unittests\": \"216b91eed587f1519222a213cb8cab42a3b34a6e\", \"wtf_unittests\": \"0c197e7da328ae38bc0138d3c71656bacd441995\", \"zlib_unittests\": \"fa0c301f8b68a73fd52ed69359a4e96fa2a2dc14\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_b145c774831c5c42cee51952606378f966ad001ff04e0282f5dbcc16172748d9_v2\", \"builder_d4fdaf58b7947408531076283e0e8baf90c29d26a4447be7804b77c871ea449a_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"builder_fbb3d50a702ddd064319c35d96f4b89f6e7a29ba4c11145a49be75e11fea82c5_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-44-4rk7\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615520430064547",
"status": "COMPLETED",
"status_changed_ts": "1615526281490721",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22959",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f183ea234a1b3bbfd79b8cd2c1cb822abe5599b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018427837998975664",
"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/8852997775802236752/+/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:523d56e216b77410",
"user_agent:luci-scheduler"
],
"updated_ts": "1615526281495733",
"url": "https://ci.chromium.org/b/8852997775802236752",
"utcnow_ts": "1615526282396008"
}
}
[05:18:02.411] Invocation finished in 1h37m43.66573286s with status SUCCEEDED