[18:46:39.806] New invocation is queued and will start shortly
[18:46:40.899] Starting the invocation (attempt 1)
[18:46:40.959] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:46:40.959] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:46:40.959] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018552009281113616",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03cf4023e44f0ab624f1b250295259148312286d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018552009281113616",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/03cf4023e44f0ab624f1b250295259148312286d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03cf4023e44f0ab624f1b250295259148312286d",
"gitiles_ref:refs/heads/master"
]
}
[18:46:42.619] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615402001088957",
"id": "8853121947265246720",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03cf4023e44f0ab624f1b250295259148312286d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615402001528093",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22940",
"builder:linux-chromeos-dbg",
"buildset:commit/git/03cf4023e44f0ab624f1b250295259148312286d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03cf4023e44f0ab624f1b250295259148312286d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018552009281113616",
"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/8853121947265246720/+/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": "1615402001528238",
"url": "https://ci.chromium.org/b/8853121947265246720",
"utcnow_ts": "1615402002612030"
}
}
[18:46:42.619] Task URL: https://ci.chromium.org/b/8853121947265246720
[18:46:42.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:2:0) after 1m0s
[18:47:42.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:2:0)
[18:47:42.613] Timer tick, asking Buildbucket for the build status
[18:47:42.688] Build 8853121947265246720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:42.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:3:0) after 1m0s
[18:48:42.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:3:0)
[18:48:42.726] Timer tick, asking Buildbucket for the build status
[18:48:42.781] Build 8853121947265246720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:42.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:4:0) after 1m0s
[18:49:28.893] Received PubSub notification, asking Buildbucket for the build status
[18:49:28.961] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:42.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:4:0)
[18:49:42.819] Timer tick, asking Buildbucket for the build status
[18:49:42.880] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:42.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:6:0) after 1m0s
[18:50:42.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:6:0)
[18:50:42.896] Timer tick, asking Buildbucket for the build status
[18:50:42.988] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:42.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:7:0) after 1m0s
[18:51:43.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:7:0)
[18:51:43.018] Timer tick, asking Buildbucket for the build status
[18:51:43.142] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:43.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:8:0) after 1m0s
[18:52:43.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:8:0)
[18:52:43.159] Timer tick, asking Buildbucket for the build status
[18:52:43.256] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:43.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:9:0) after 1m0s
[18:53:43.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:9:0)
[18:53:43.275] Timer tick, asking Buildbucket for the build status
[18:53:43.350] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:43.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:10:0) after 1m0s
[18:54:43.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:10:0)
[18:54:43.353] Timer tick, asking Buildbucket for the build status
[18:54:43.448] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:43.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:11:0) after 1m0s
[18:55:43.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:11:0)
[18:55:43.471] Timer tick, asking Buildbucket for the build status
[18:55:43.540] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:43.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:12:0) after 1m0s
[18:56:43.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:12:0)
[18:56:43.611] Timer tick, asking Buildbucket for the build status
[18:56:43.693] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:43.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:13:0) after 1m0s
[18:57:43.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:13:0)
[18:57:43.749] Timer tick, asking Buildbucket for the build status
[18:57:43.955] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:43.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:14:0) after 1m0s
[18:58:44.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:14:0)
[18:58:44.106] Timer tick, asking Buildbucket for the build status
[18:58:44.351] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:44.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:15:0) after 1m0s
[18:59:44.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:15:0)
[18:59:44.387] Timer tick, asking Buildbucket for the build status
[18:59:44.455] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:44.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:16:0) after 1m0s
[19:00:44.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:16:0)
[19:00:44.519] Timer tick, asking Buildbucket for the build status
[19:00:44.817] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:44.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:17:0) after 1m0s
[19:01:44.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:17:0)
[19:01:44.879] Timer tick, asking Buildbucket for the build status
[19:01:44.981] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:44.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:18:0) after 1m0s
[19:02:45.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:18:0)
[19:02:45.044] Timer tick, asking Buildbucket for the build status
[19:02:45.397] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:45.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:19:0) after 1m0s
[19:03:45.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:19:0)
[19:03:45.457] Timer tick, asking Buildbucket for the build status
[19:03:45.679] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:45.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:20:0) after 1m0s
[19:04:45.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:20:0)
[19:04:45.743] Timer tick, asking Buildbucket for the build status
[19:04:46.769] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:46.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:21:0) after 1m0s
[19:05:46.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:21:0)
[19:05:46.857] Timer tick, asking Buildbucket for the build status
[19:05:46.930] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:46.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:22:0) after 1m0s
[19:06:47.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:22:0)
[19:06:47.065] Timer tick, asking Buildbucket for the build status
[19:06:47.163] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:47.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:23:0) after 1m0s
[19:07:47.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:23:0)
[19:07:47.216] Timer tick, asking Buildbucket for the build status
[19:07:47.333] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:47.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:24:0) after 1m0s
[19:08:47.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:24:0)
[19:08:47.359] Timer tick, asking Buildbucket for the build status
[19:08:47.469] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:47.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:25:0) after 1m0s
[19:09:47.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:25:0)
[19:09:47.510] Timer tick, asking Buildbucket for the build status
[19:09:47.801] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:47.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:26:0) after 1m0s
[19:10:47.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:26:0)
[19:10:47.844] Timer tick, asking Buildbucket for the build status
[19:10:48.155] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:48.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:27:0) after 1m0s
[19:11:48.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:27:0)
[19:11:48.128] Timer tick, asking Buildbucket for the build status
[19:11:48.320] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:48.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:28:0) after 1m0s
[19:12:48.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:28:0)
[19:12:48.377] Timer tick, asking Buildbucket for the build status
[19:12:48.460] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:48.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:29:0) after 1m0s
[19:13:48.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:29:0)
[19:13:48.479] Timer tick, asking Buildbucket for the build status
[19:13:48.552] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:48.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:30:0) after 1m0s
[19:14:48.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:30:0)
[19:14:48.570] Timer tick, asking Buildbucket for the build status
[19:14:48.795] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:48.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:31:0) after 1m0s
[19:15:48.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:31:0)
[19:15:48.814] Timer tick, asking Buildbucket for the build status
[19:15:49.261] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:49.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:32:0) after 1m0s
[19:16:49.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:32:0)
[19:16:49.384] Timer tick, asking Buildbucket for the build status
[19:16:49.456] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:49.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:33:0) after 1m0s
[19:17:49.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:33:0)
[19:17:49.539] Timer tick, asking Buildbucket for the build status
[19:17:49.851] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:49.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:34:0) after 1m0s
[19:18:49.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:34:0)
[19:18:49.842] Timer tick, asking Buildbucket for the build status
[19:18:50.036] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:50.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:35:0) after 1m0s
[19:19:50.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:35:0)
[19:19:50.057] Timer tick, asking Buildbucket for the build status
[19:19:50.123] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:50.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:36:0) after 1m0s
[19:20:50.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:36:0)
[19:20:50.121] Timer tick, asking Buildbucket for the build status
[19:20:50.411] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:50.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:37:0) after 1m0s
[19:21:50.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:37:0)
[19:21:50.481] Timer tick, asking Buildbucket for the build status
[19:21:50.654] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:50.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:38:0) after 1m0s
[19:22:50.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:38:0)
[19:22:50.660] Timer tick, asking Buildbucket for the build status
[19:22:50.744] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:39:0) after 1m0s
[19:23:50.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:39:0)
[19:23:50.810] Timer tick, asking Buildbucket for the build status
[19:23:50.881] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:50.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:40:0) after 1m0s
[19:24:50.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:40:0)
[19:24:50.966] Timer tick, asking Buildbucket for the build status
[19:24:51.033] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:51.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:41:0) after 1m0s
[19:25:51.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:41:0)
[19:25:51.064] Timer tick, asking Buildbucket for the build status
[19:25:51.267] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:51.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:42:0) after 1m0s
[19:26:51.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:42:0)
[19:26:51.294] Timer tick, asking Buildbucket for the build status
[19:26:51.388] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:51.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:43:0) after 1m0s
[19:27:51.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:43:0)
[19:27:51.411] Timer tick, asking Buildbucket for the build status
[19:27:51.509] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:51.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:44:0) after 1m0s
[19:28:51.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:44:0)
[19:28:51.553] Timer tick, asking Buildbucket for the build status
[19:28:51.795] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:51.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:45:0) after 1m0s
[19:29:51.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:45:0)
[19:29:51.841] Timer tick, asking Buildbucket for the build status
[19:29:51.925] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:51.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:46:0) after 1m0s
[19:30:51.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:46:0)
[19:30:51.942] Timer tick, asking Buildbucket for the build status
[19:30:52.547] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:52.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:47:0) after 1m0s
[19:31:52.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:47:0)
[19:31:52.601] Timer tick, asking Buildbucket for the build status
[19:31:52.732] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:52.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:48:0) after 1m0s
[19:32:52.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:48:0)
[19:32:52.787] Timer tick, asking Buildbucket for the build status
[19:32:52.871] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:52.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:49:0) after 1m0s
[19:33:52.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:49:0)
[19:33:52.929] Timer tick, asking Buildbucket for the build status
[19:33:53.016] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:53.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:50:0) after 1m0s
[19:34:53.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:50:0)
[19:34:53.091] Timer tick, asking Buildbucket for the build status
[19:34:53.185] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:53.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:51:0) after 1m0s
[19:35:53.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:51:0)
[19:35:53.246] Timer tick, asking Buildbucket for the build status
[19:35:53.328] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:53.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:52:0) after 1m0s
[19:36:53.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:52:0)
[19:36:53.399] Timer tick, asking Buildbucket for the build status
[19:36:53.496] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:53.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:53:0) after 1m0s
[19:37:53.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:53:0)
[19:37:53.633] Timer tick, asking Buildbucket for the build status
[19:37:53.731] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:53.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:54:0) after 1m0s
[19:38:53.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:54:0)
[19:38:53.836] Timer tick, asking Buildbucket for the build status
[19:38:53.961] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:53.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:55:0) after 1m0s
[19:39:54.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:55:0)
[19:39:54.061] Timer tick, asking Buildbucket for the build status
[19:39:54.148] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:54.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:56:0) after 1m0s
[19:40:54.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:56:0)
[19:40:54.274] Timer tick, asking Buildbucket for the build status
[19:40:54.353] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:54.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:57:0) after 1m0s
[19:41:54.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:57:0)
[19:41:54.502] Timer tick, asking Buildbucket for the build status
[19:41:54.809] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:54.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:58:0) after 1m0s
[19:42:54.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:58:0)
[19:42:54.808] Timer tick, asking Buildbucket for the build status
[19:42:54.901] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:54.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:59:0) after 1m0s
[19:43:54.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:59:0)
[19:43:54.938] Timer tick, asking Buildbucket for the build status
[19:43:55.140] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:55.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:60:0) after 1m0s
[19:44:55.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:60:0)
[19:44:55.241] Timer tick, asking Buildbucket for the build status
[19:44:55.727] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:55.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:61:0) after 1m0s
[19:45:55.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:61:0)
[19:45:55.777] Timer tick, asking Buildbucket for the build status
[19:45:56.128] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:56.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:62:0) after 1m0s
[19:46:56.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:62:0)
[19:46:56.152] Timer tick, asking Buildbucket for the build status
[19:46:56.257] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:56.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:63:0) after 1m0s
[19:47:56.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:63:0)
[19:47:56.300] Timer tick, asking Buildbucket for the build status
[19:47:56.568] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:56.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:64:0) after 1m0s
[19:48:56.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:64:0)
[19:48:56.661] Timer tick, asking Buildbucket for the build status
[19:48:56.785] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:56.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:65:0) after 1m0s
[19:49:56.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:65:0)
[19:49:56.822] Timer tick, asking Buildbucket for the build status
[19:49:56.961] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:56.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:66:0) after 1m0s
[19:50:56.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:66:0)
[19:50:56.992] Timer tick, asking Buildbucket for the build status
[19:50:57.073] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:67:0) after 1m0s
[19:51:57.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:67:0)
[19:51:57.100] Timer tick, asking Buildbucket for the build status
[19:51:57.264] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:57.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:68:0) after 1m0s
[19:52:57.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:68:0)
[19:52:57.250] Timer tick, asking Buildbucket for the build status
[19:52:57.340] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:57.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:69:0) after 1m0s
[19:53:57.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:69:0)
[19:53:57.357] Timer tick, asking Buildbucket for the build status
[19:53:57.532] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:57.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:70:0) after 1m0s
[19:54:57.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:70:0)
[19:54:57.548] Timer tick, asking Buildbucket for the build status
[19:54:57.635] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:57.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:71:0) after 1m0s
[19:55:57.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:71:0)
[19:55:57.680] Timer tick, asking Buildbucket for the build status
[19:55:57.789] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:57.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:72:0) after 1m0s
[19:56:57.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:72:0)
[19:56:57.772] Timer tick, asking Buildbucket for the build status
[19:56:58.315] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:58.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:73:0) after 1m0s
[19:57:58.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:73:0)
[19:57:58.335] Timer tick, asking Buildbucket for the build status
[19:57:58.423] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:58.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:74:0) after 1m0s
[19:58:58.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:74:0)
[19:58:58.436] Timer tick, asking Buildbucket for the build status
[19:58:58.505] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:58.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:75:0) after 1m0s
[19:59:58.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:75:0)
[19:59:58.587] Timer tick, asking Buildbucket for the build status
[19:59:59.020] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:59.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:76:0) after 1m0s
[20:00:59.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:76:0)
[20:00:59.007] Timer tick, asking Buildbucket for the build status
[20:00:59.094] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:59.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:77:0) after 1m0s
[20:01:59.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:77:0)
[20:01:59.088] Timer tick, asking Buildbucket for the build status
[20:01:59.187] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:78:0) after 1m0s
[20:02:59.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:78:0)
[20:02:59.245] Timer tick, asking Buildbucket for the build status
[20:02:59.706] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:59.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:79:0) after 1m0s
[20:03:59.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:79:0)
[20:03:59.742] Timer tick, asking Buildbucket for the build status
[20:03:59.821] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:59.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:80:0) after 1m0s
[20:04:59.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:80:0)
[20:04:59.829] Timer tick, asking Buildbucket for the build status
[20:04:59.985] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:59.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:81:0) after 1m0s
[20:06:00.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:81:0)
[20:06:00.025] Timer tick, asking Buildbucket for the build status
[20:06:00.239] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:00.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:82:0) after 1m0s
[20:07:00.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:82:0)
[20:07:00.294] Timer tick, asking Buildbucket for the build status
[20:07:00.547] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:83:0) after 1m0s
[20:08:00.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:83:0)
[20:08:00.694] Timer tick, asking Buildbucket for the build status
[20:08:00.770] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:00.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:84:0) after 1m0s
[20:09:00.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:84:0)
[20:09:00.847] Timer tick, asking Buildbucket for the build status
[20:09:01.056] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:01.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:85:0) after 1m0s
[20:10:01.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:85:0)
[20:10:01.154] Timer tick, asking Buildbucket for the build status
[20:10:01.459] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:86:0) after 1m0s
[20:11:01.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:86:0)
[20:11:01.612] Timer tick, asking Buildbucket for the build status
[20:11:01.776] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:01.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:87:0) after 1m0s
[20:12:01.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:87:0)
[20:12:01.845] Timer tick, asking Buildbucket for the build status
[20:12:02.057] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:02.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:88:0) after 1m0s
[20:13:02.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:88:0)
[20:13:02.177] Timer tick, asking Buildbucket for the build status
[20:13:02.261] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:02.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:89:0) after 1m0s
[20:14:02.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:89:0)
[20:14:02.355] Timer tick, asking Buildbucket for the build status
[20:14:05.883] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:05.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:90:0) after 1m0s
[20:15:06.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:90:0)
[20:15:06.026] Timer tick, asking Buildbucket for the build status
[20:15:06.112] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:06.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:91:0) after 1m0s
[20:16:06.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:91:0)
[20:16:06.103] Timer tick, asking Buildbucket for the build status
[20:16:06.242] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:92:0) after 1m0s
[20:17:06.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:92:0)
[20:17:06.371] Timer tick, asking Buildbucket for the build status
[20:17:06.826] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:06.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:93:0) after 1m0s
[20:18:06.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:93:0)
[20:18:06.833] Timer tick, asking Buildbucket for the build status
[20:18:07.015] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:94:0) after 1m0s
[20:19:07.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:94:0)
[20:19:07.062] Timer tick, asking Buildbucket for the build status
[20:19:07.158] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:95:0) after 1m0s
[20:20:07.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:95:0)
[20:20:07.204] Timer tick, asking Buildbucket for the build status
[20:20:07.289] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:07.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:96:0) after 1m0s
[20:21:07.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:96:0)
[20:21:07.400] Timer tick, asking Buildbucket for the build status
[20:21:07.483] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:97:0) after 1m0s
[20:22:07.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:97:0)
[20:22:07.530] Timer tick, asking Buildbucket for the build status
[20:22:07.700] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:07.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:98:0) after 1m0s
[20:23:07.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:98:0)
[20:23:07.742] Timer tick, asking Buildbucket for the build status
[20:23:10.524] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:10.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:99:0) after 1m0s
[20:24:10.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:99:0)
[20:24:10.657] Timer tick, asking Buildbucket for the build status
[20:24:10.790] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:10.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:100:0) after 1m0s
[20:25:10.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:100:0)
[20:25:10.826] Timer tick, asking Buildbucket for the build status
[20:25:10.922] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:10.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:101:0) after 1m0s
[20:26:11.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:101:0)
[20:26:11.057] Timer tick, asking Buildbucket for the build status
[20:26:11.148] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:11.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:102:0) after 1m0s
[20:27:11.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:102:0)
[20:27:11.205] Timer tick, asking Buildbucket for the build status
[20:27:11.325] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:103:0) after 1m0s
[20:28:11.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:103:0)
[20:28:11.404] Timer tick, asking Buildbucket for the build status
[20:28:11.549] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:11.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:104:0) after 1m0s
[20:29:11.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:104:0)
[20:29:11.537] Timer tick, asking Buildbucket for the build status
[20:29:11.621] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:11.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:105:0) after 1m0s
[20:30:11.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:105:0)
[20:30:11.661] Timer tick, asking Buildbucket for the build status
[20:30:12.021] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:106:0) after 1m0s
[20:31:12.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:106:0)
[20:31:12.069] Timer tick, asking Buildbucket for the build status
[20:31:12.155] Build 8853121947265246720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:12.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018552009281113616:107:0) after 1m0s
[20:31:21.578] Received PubSub notification, asking Buildbucket for the build status
[20:31:21.828] Build 8853121947265246720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:31:21.828] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615408279775371",
"created_by": "project:chromium",
"created_ts": "1615402001088957",
"id": "8853121947265246720",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03cf4023e44f0ab624f1b250295259148312286d\"}}",
"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\": \"03cf4023e44f0ab624f1b250295259148312286d\", \"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-86-up21\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22940, \"got_angle_revision\": \"b2f547f4f423f492c4483d901d1b3ad5f3ad8798\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"03cf4023e44f0ab624f1b250295259148312286d\", \"got_revision_cp\": \"refs/heads/master@{#861634}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"de5df026428a7e343abb139064e99eac24cd2404\", \"got_v8_revision_cp\": \"refs/heads/9.1.90@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"03cf4023e44f0ab624f1b250295259148312286d\", \"swarm_hashes_refs/heads/master(at){#861634}_without_patch\": {\"absl_hardening_tests\": \"46b8fe3ea773e78fc228b328b74f05049aa9aaff\", \"accessibility_unittests\": \"a09d5fae25fb5667ef6616cb33f4609909feeb32\", \"angle_unittests\": \"18911675b1938ca7ecc78e465066c090d6d4dea6\", \"app_list_unittests\": \"2f6ea0b4f9d35c3ea6183f64e0842e2af5d15789\", \"app_shell_unittests\": \"e6780684b97811dcaae1841e67ab77b1d4ebb333\", \"ash_unittests\": \"b10c9547835ee75f4fc1870ff9c5238cde9ed585\", \"aura_unittests\": \"173eff63eaa7f6493b654d5c3c7562389f9e3675\", \"base_unittests\": \"4d31505157286ab609806309b5e289b347831b13\", \"base_util_unittests\": \"e70d3fa70290e08d777f4ffa9b4104de7538e776\", \"blink_common_unittests\": \"5f8d0eafd60a409f8f3179eca1624d310be86c01\", \"blink_fuzzer_unittests\": \"0730567a80185d0a92c6a8e47bd174eb62eac28c\", \"blink_heap_unittests\": \"78de033ae0b68c26e6697c5971f4259f86fdb8b2\", \"blink_platform_unittests\": \"3b5398b658ad580f82d40a66ad0270f4a6b4a436\", \"blink_unittests\": \"87f84d78bd76ddfdeec9bd258d0df8874499adfb\", \"boringssl_crypto_tests\": \"5c893703333ab6f7ad99acfe28fbcd0e88e974f0\", \"boringssl_ssl_tests\": \"eb8984bf7610068ed08a9f99a3d658c731c186df\", \"browser_tests\": \"283017d19d68cb64e47036ec3ca2bd01dcfa2bbc\", \"capture_unittests\": \"828a5485792c937b2ebbda8ce25e40ad3ea964ea\", \"cast_unittests\": \"2510b9a5358e990a5c62bc72eb7f1f0b839adbc7\", \"cc_unittests\": \"c9127716eecaca9c1c247bb2c8cdc271232d3b7d\", \"chrome_app_unittests\": \"c6832ef13317f7267d48696e7c200fa026946898\", \"chromedriver_unittests\": \"a6c97ded549f0619aff45d30eee8aa904a30d7ce\", \"chromeos_components_unittests\": \"1a9c6ff62e2d448d3cd403fa153d40ab59798516\", \"chromeos_unittests\": \"ede43d48e590641c2564f7e6c060c06257415dd3\", \"color_unittests\": \"914dd0daf87e5b24b045afd00c062add55f87dae\", \"components_browsertests\": \"38da506aa8605b54fafb3de3ee626e2f7ffa4f33\", \"components_unittests\": \"7605626db5c641221a61387d180a84663397afa7\", \"compositor_unittests\": \"218b95bdb15a8c663e7c9d904cfa5487a9d53d8b\", \"content_browsertests\": \"1f60b9824218c36c9425be486720c9282920f18d\", \"content_unittests\": \"30ca51b10695a99aa9e890849911517688b16467\", \"crashpad_tests\": \"f569cb1328c2e087e1ff9a204bc86ff5374fc463\", \"crypto_unittests\": \"215a5872a5fafd81551cebd4e6a710d507841384\", \"dbus_unittests\": \"f917e82d1b0a33b2b1666df3d09d510a6d26a069\", \"device_unittests\": \"2dbc3bbaffe251a772bc056ad567860227e8ffde\", \"display_unittests\": \"83526e848713530833afecca881c7454e83d9569\", \"events_unittests\": \"fac04764287e254a09a961703e5dc58ea0e2a5ac\", \"exo_unittests\": \"ec0529309b951d9ab298978dd01a7f3aa70fe1d3\", \"extensions_browsertests\": \"a38c076ac58d7f8aaf187972916ba7dc5fe3b212\", \"extensions_unittests\": \"e7531a7ee67ddb19c264840600de9ed7f5731a6c\", \"filesystem_service_unittests\": \"e0aa26703b97cb2dda369938f015128318092296\", \"gcm_unit_tests\": \"fdcbdb17f7f2deb813cd555f8ad2f1d113f968e1\", \"gfx_unittests\": \"e2613822b59fb88c8ff80f81687b6d55075b5a8e\", \"gin_unittests\": \"d29239bfe49cc5876f1c2a60ec7632bdb16a38d3\", \"gl_unittests_ozone\": \"5584bba4b05f8c64ea636b0c02bdc71755f6eacc\", \"google_apis_unittests\": \"02ba620d7f5a033e11995bb7d8ca586f8c478415\", \"gpu_unittests\": \"1dadf559340ac497296b0a202f085556e5b66761\", \"gwp_asan_unittests\": \"9a1954d65ed80fc05c7eec27b45ba7c1dfb3ca8e\", \"interactive_ui_tests\": \"08918fbaf64ba00e8f7c253f513a94cc73dd9afa\", \"ipc_tests\": \"fe632d194f46c4e9b483bd123c3649ae2e8d0932\", \"jingle_unittests\": \"f707fc98c8ac6affc2414351792890f3f7487b85\", \"keyboard_unittests\": \"b178c27b195247f20403d6f764d7c908fa2f9464\", \"latency_unittests\": \"aa672a561726dafd3ca1c53d65fd068547b8d143\", \"libjingle_xmpp_unittests\": \"3274f525dad3a05f733326b8486c8848ac8d1dd0\", \"liburlpattern_unittests\": \"977501a0e473997230b8960e369f4b0d1c840736\", \"media_blink_unittests\": \"4d18b5b326a407871cb4a02b95d8a2e12fd002da\", \"media_unittests\": \"138b08d3d1e5636639aaa7ce6948716c2c5526e1\", \"message_center_unittests\": \"c1d76fbe11c01b1ae28c9bc9368da515cfd40b53\", \"midi_unittests\": \"a7ed6f7970b085aae1a2b66df0d1d912940e1642\", \"mojo_core_unittests\": \"8e3f705b164e481e5971f8eba4167cb8e3d68153\", \"mojo_unittests\": \"0de7caf14c30905bd316b65a36dff66455e4fa9d\", \"nacl_helper_nonsfi_unittests\": \"3155c5545d0b78cc32a3b88b7dfc44288cee28cf\", \"nacl_loader_unittests\": \"62658b4d5d342f1a3bc8f80f56b8d7625dfb96ab\", \"native_theme_unittests\": \"543f66a451a1a080eadb54746c530465c6cafe5e\", \"net_unittests\": \"c43a4f66a56ed04a767894a5330507770179c43d\", \"ozone_gl_unittests\": \"fbc05abf9ae8d37ece6ebb85a3786f25ca3e1a5f\", \"ozone_unittests\": \"402c6a68253d3a08d1214f7fc4b07d6a6e4f2310\", \"ozone_x11_unittests\": \"b9db989643869377166dd2fc0f6b5036a0039078\", \"pdf_unittests\": \"a38382e98f6fcc16354a50f2593fedede0cf4110\", \"perfetto_unittests\": \"e17573e61bc9a1177ac555c691226ace4fd8d767\", \"ppapi_unittests\": \"40b0a750d6876aabfd839a0e4e007dedb3e4f05f\", \"printing_unittests\": \"c563f935d4e6167c2638b360eecf242b7c15e3d4\", \"remoting_unittests\": \"c29db636c35b325e6f3969bf7211be449e610beb\", \"sandbox_linux_unittests\": \"de1aa17efa423e8ab0eb1be3703e88bad5b24752\", \"service_manager_unittests\": \"4f1d5dea1d223346ee448b3af5cf27391fac6854\", \"services_unittests\": \"269773d2b3bbaf0da86b203f15915a0c168cfad6\", \"shell_dialogs_unittests\": \"7c433b0b2e0298b8c4fbcd102157cd233f8ebcc3\", \"shell_encryption_unittests\": \"34b4070d94eb6fc4120b735a452bc9f8710c979d\", \"skia_unittests\": \"2b8e74d4596a6e60347e6483a8777f8144f92afd\", \"snapshot_unittests\": \"69f8a3f3223ab09320f6f1ae4f07f099a100ffd3\", \"sql_unittests\": \"518baaf46df1964a288c08a012225b7f6c0ef9af\", \"storage_unittests\": \"b80328b79af82df14639c0e7b7e613c0432afabd\", \"sync_integration_tests\": \"b6d1e027952a5e53c184742069f7f36931ec33a8\", \"traffic_annotation_auditor_unittests\": \"7bdbbe3d465b8e2ed297a29a401e8a480c741036\", \"ui_base_unittests\": \"92831ea1cb6cbab5d4a8850c0f42ab6d74a7ef21\", \"ui_chromeos_unittests\": \"552750ee1085336077713975948b7b06a0b5f28a\", \"ui_touch_selection_unittests\": \"1ce3f009ff402b120f92385ea55de9a746d43168\", \"unit_tests\": \"e82cf4c706b703e6060020d228535e5dab43ba6d\", \"url_unittests\": \"5e93dc34afe60bac886fcf3ed8b24d9628d0f33b\", \"usage_time_limit_unittests\": \"d12b29eedf99cc1a5384af8dd1f50ba70ed3a89e\", \"views_unittests\": \"239abd92a0fdafef1316ad7e746da69402d9e45a\", \"viz_unittests\": \"8b792cc709fdb745066eeb5307f176822393bdc5\", \"wayland_client_tests\": \"05baaa45c93b3898b5b603a1ede498135c13af34\", \"wm_unittests\": \"4f4a2bb9f253337c2b700871f7bab9a242d34b09\", \"wtf_unittests\": \"cdec98884aee0bf15e1c43911758731bfe8c626f\", \"zlib_unittests\": \"62c760b135e567d50944cbc8b9d38bc58557e2d4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_75bb63162a23d4b1c0ff37321417ec47e6c57c7535580350abbb418df2b18732_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_d3fe653fa02e678f703fbad4f78e35ab8fe92cd792b6bec3c883269900c0c087_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-86-up21\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615402167975202",
"status": "COMPLETED",
"status_changed_ts": "1615408280378336",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22940",
"builder:linux-chromeos-dbg",
"buildset:commit/git/03cf4023e44f0ab624f1b250295259148312286d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03cf4023e44f0ab624f1b250295259148312286d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018552009281113616",
"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/8853121947265246720/+/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:523647f1ca210d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615408280388132",
"url": "https://ci.chromium.org/b/8853121947265246720",
"utcnow_ts": "1615408281813037"
}
}
[20:31:21.828] Invocation finished in 1h44m42.045831056s with status SUCCEEDED