[02:28:20.920] New invocation is queued and will start shortly
[02:28:22.213] Starting the invocation (attempt 1)
[02:28:22.247] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:28:22.247] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:28:22.247] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023868183565874128",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"42a72ddb0dd990c210f9e1ff5a05843778548769\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023868183565874128",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/42a72ddb0dd990c210f9e1ff5a05843778548769",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a72ddb0dd990c210f9e1ff5a05843778548769",
"gitiles_ref:refs/heads/master"
]
}
[02:28:23.009] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610332102320340",
"id": "8858438121435727648",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42a72ddb0dd990c210f9e1ff5a05843778548769\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610332102755677",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22145",
"builder:linux-chromeos-dbg",
"buildset:commit/git/42a72ddb0dd990c210f9e1ff5a05843778548769",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a72ddb0dd990c210f9e1ff5a05843778548769",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023868183565874128",
"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/8858438121435727648/+/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": "1610332102755792",
"url": "https://ci.chromium.org/b/8858438121435727648",
"utcnow_ts": "1610332102994957"
}
}
[02:28:23.009] Task URL: https://ci.chromium.org/b/8858438121435727648
[02:28:23.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:2:0) after 1m0s
[02:29:23.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:2:0)
[02:29:23.077] Timer tick, asking Buildbucket for the build status
[02:29:23.178] Build 8858438121435727648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:23.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:3:0) after 1m0s
[02:30:23.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:3:0)
[02:30:23.295] Timer tick, asking Buildbucket for the build status
[02:30:23.381] Build 8858438121435727648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:23.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:4:0) after 1m0s
[02:31:23.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:4:0)
[02:31:23.396] Timer tick, asking Buildbucket for the build status
[02:31:23.474] Build 8858438121435727648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:23.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:5:0) after 1m0s
[02:32:23.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:5:0)
[02:32:23.499] Timer tick, asking Buildbucket for the build status
[02:32:23.624] Build 8858438121435727648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:23.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:6:0) after 1m0s
[02:33:02.332] Received PubSub notification, asking Buildbucket for the build status
[02:33:02.451] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:23.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:6:0)
[02:33:23.640] Timer tick, asking Buildbucket for the build status
[02:33:23.736] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:23.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:8:0) after 1m0s
[02:34:23.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:8:0)
[02:34:23.804] Timer tick, asking Buildbucket for the build status
[02:34:24.244] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:9:0) after 1m0s
[02:35:24.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:9:0)
[02:35:24.371] Timer tick, asking Buildbucket for the build status
[02:35:24.438] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:24.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:10:0) after 1m0s
[02:36:24.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:10:0)
[02:36:24.614] Timer tick, asking Buildbucket for the build status
[02:36:24.690] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:24.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:11:0) after 1m0s
[02:37:24.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:11:0)
[02:37:24.839] Timer tick, asking Buildbucket for the build status
[02:37:25.155] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:25.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:12:0) after 1m0s
[02:38:25.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:12:0)
[02:38:25.247] Timer tick, asking Buildbucket for the build status
[02:38:25.340] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:25.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:13:0) after 1m0s
[02:39:25.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:13:0)
[02:39:25.489] Timer tick, asking Buildbucket for the build status
[02:39:25.590] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:25.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:14:0) after 1m0s
[02:40:25.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:14:0)
[02:40:25.665] Timer tick, asking Buildbucket for the build status
[02:40:26.117] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:26.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:15:0) after 1m0s
[02:41:26.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:15:0)
[02:41:26.122] Timer tick, asking Buildbucket for the build status
[02:41:26.194] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:26.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:16:0) after 1m0s
[02:42:26.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:16:0)
[02:42:26.238] Timer tick, asking Buildbucket for the build status
[02:42:26.298] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:26.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:17:0) after 1m0s
[02:43:26.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:17:0)
[02:43:26.327] Timer tick, asking Buildbucket for the build status
[02:43:26.449] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:26.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:18:0) after 1m0s
[02:44:26.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:18:0)
[02:44:26.467] Timer tick, asking Buildbucket for the build status
[02:44:26.545] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:26.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:19:0) after 1m0s
[02:45:26.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:19:0)
[02:45:26.603] Timer tick, asking Buildbucket for the build status
[02:45:26.702] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:26.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:20:0) after 1m0s
[02:46:26.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:20:0)
[02:46:26.713] Timer tick, asking Buildbucket for the build status
[02:46:26.892] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:26.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:21:0) after 1m0s
[02:47:26.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:21:0)
[02:47:26.908] Timer tick, asking Buildbucket for the build status
[02:47:27.444] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:27.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:22:0) after 1m0s
[02:48:27.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:22:0)
[02:48:27.610] Timer tick, asking Buildbucket for the build status
[02:48:27.813] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:27.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:23:0) after 1m0s
[02:49:27.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:23:0)
[02:49:27.854] Timer tick, asking Buildbucket for the build status
[02:49:27.922] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:27.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:24:0) after 1m0s
[02:50:27.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:24:0)
[02:50:27.916] Timer tick, asking Buildbucket for the build status
[02:50:27.987] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:27.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:25:0) after 1m0s
[02:51:28.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:25:0)
[02:51:28.232] Timer tick, asking Buildbucket for the build status
[02:51:28.292] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:28.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:26:0) after 1m0s
[02:52:28.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:26:0)
[02:52:28.359] Timer tick, asking Buildbucket for the build status
[02:52:28.409] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:28.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:27:0) after 1m0s
[02:53:28.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:27:0)
[02:53:28.421] Timer tick, asking Buildbucket for the build status
[02:53:28.707] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:28.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:28:0) after 1m0s
[02:54:28.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:28:0)
[02:54:28.813] Timer tick, asking Buildbucket for the build status
[02:54:29.084] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:29.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:29:0) after 1m0s
[02:55:29.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:29:0)
[02:55:29.105] Timer tick, asking Buildbucket for the build status
[02:55:29.195] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:29.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:30:0) after 1m0s
[02:56:29.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:30:0)
[02:56:29.257] Timer tick, asking Buildbucket for the build status
[02:56:29.328] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:29.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:31:0) after 1m0s
[02:57:29.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:31:0)
[02:57:29.341] Timer tick, asking Buildbucket for the build status
[02:57:29.401] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:29.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:32:0) after 1m0s
[02:58:29.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:32:0)
[02:58:29.505] Timer tick, asking Buildbucket for the build status
[02:58:29.611] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:29.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:33:0) after 1m0s
[02:59:29.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:33:0)
[02:59:29.639] Timer tick, asking Buildbucket for the build status
[02:59:29.715] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:29.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:34:0) after 1m0s
[03:00:29.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:34:0)
[03:00:29.741] Timer tick, asking Buildbucket for the build status
[03:00:29.837] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:29.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:35:0) after 1m0s
[03:01:29.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:35:0)
[03:01:29.856] Timer tick, asking Buildbucket for the build status
[03:01:29.918] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:36:0) after 1m0s
[03:02:29.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:36:0)
[03:02:29.919] Timer tick, asking Buildbucket for the build status
[03:02:29.985] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:29.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:37:0) after 1m0s
[03:03:30.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:37:0)
[03:03:30.007] Timer tick, asking Buildbucket for the build status
[03:03:30.252] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:30.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:38:0) after 1m0s
[03:04:30.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:38:0)
[03:04:30.490] Timer tick, asking Buildbucket for the build status
[03:04:30.771] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:30.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:39:0) after 1m0s
[03:05:30.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:39:0)
[03:05:30.792] Timer tick, asking Buildbucket for the build status
[03:05:30.861] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:40:0) after 1m0s
[03:06:30.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:40:0)
[03:06:30.882] Timer tick, asking Buildbucket for the build status
[03:06:30.947] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:30.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:41:0) after 1m0s
[03:07:31.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:41:0)
[03:07:31.002] Timer tick, asking Buildbucket for the build status
[03:07:31.068] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:31.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:42:0) after 1m0s
[03:08:31.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:42:0)
[03:08:31.084] Timer tick, asking Buildbucket for the build status
[03:08:31.212] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:31.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:43:0) after 1m0s
[03:09:31.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:43:0)
[03:09:31.281] Timer tick, asking Buildbucket for the build status
[03:09:31.352] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:31.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:44:0) after 1m0s
[03:10:31.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:44:0)
[03:10:31.407] Timer tick, asking Buildbucket for the build status
[03:10:31.465] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:31.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:45:0) after 1m0s
[03:11:31.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:45:0)
[03:11:31.484] Timer tick, asking Buildbucket for the build status
[03:11:31.623] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:31.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:46:0) after 1m0s
[03:12:31.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:46:0)
[03:12:31.674] Timer tick, asking Buildbucket for the build status
[03:12:31.749] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:31.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:47:0) after 1m0s
[03:13:31.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:47:0)
[03:13:31.768] Timer tick, asking Buildbucket for the build status
[03:13:31.950] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:31.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:48:0) after 1m0s
[03:14:31.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:48:0)
[03:14:31.978] Timer tick, asking Buildbucket for the build status
[03:14:32.215] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:32.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:49:0) after 1m0s
[03:15:32.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:49:0)
[03:15:32.265] Timer tick, asking Buildbucket for the build status
[03:15:32.345] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:32.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:50:0) after 1m0s
[03:16:32.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:50:0)
[03:16:32.393] Timer tick, asking Buildbucket for the build status
[03:16:32.634] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:32.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:51:0) after 1m0s
[03:17:32.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:51:0)
[03:17:32.718] Timer tick, asking Buildbucket for the build status
[03:17:32.914] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:32.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:52:0) after 1m0s
[03:18:32.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:52:0)
[03:18:32.934] Timer tick, asking Buildbucket for the build status
[03:18:33.220] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:33.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:53:0) after 1m0s
[03:19:33.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:53:0)
[03:19:33.277] Timer tick, asking Buildbucket for the build status
[03:19:33.371] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:33.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:54:0) after 1m0s
[03:20:33.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:54:0)
[03:20:33.395] Timer tick, asking Buildbucket for the build status
[03:20:33.953] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:33.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:55:0) after 1m0s
[03:21:33.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:55:0)
[03:21:33.981] Timer tick, asking Buildbucket for the build status
[03:21:34.101] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:34.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:56:0) after 1m0s
[03:22:34.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:56:0)
[03:22:34.170] Timer tick, asking Buildbucket for the build status
[03:22:34.306] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:34.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:57:0) after 1m0s
[03:23:34.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:57:0)
[03:23:34.351] Timer tick, asking Buildbucket for the build status
[03:23:34.469] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:34.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:58:0) after 1m0s
[03:24:34.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:58:0)
[03:24:34.511] Timer tick, asking Buildbucket for the build status
[03:24:34.915] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:34.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:59:0) after 1m0s
[03:25:34.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:59:0)
[03:25:34.936] Timer tick, asking Buildbucket for the build status
[03:25:35.006] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:35.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:60:0) after 1m0s
[03:26:35.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:60:0)
[03:26:35.027] Timer tick, asking Buildbucket for the build status
[03:26:35.212] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:35.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:61:0) after 1m0s
[03:27:35.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:61:0)
[03:27:35.286] Timer tick, asking Buildbucket for the build status
[03:27:35.411] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:35.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:62:0) after 1m0s
[03:28:35.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:62:0)
[03:28:35.454] Timer tick, asking Buildbucket for the build status
[03:28:35.586] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:35.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:63:0) after 1m0s
[03:29:35.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:63:0)
[03:29:35.607] Timer tick, asking Buildbucket for the build status
[03:29:35.735] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:35.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:64:0) after 1m0s
[03:30:35.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:64:0)
[03:30:35.761] Timer tick, asking Buildbucket for the build status
[03:30:36.076] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:36.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:65:0) after 1m0s
[03:31:36.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:65:0)
[03:31:36.127] Timer tick, asking Buildbucket for the build status
[03:31:36.382] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:36.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:66:0) after 1m0s
[03:32:36.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:66:0)
[03:32:36.414] Timer tick, asking Buildbucket for the build status
[03:32:36.521] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:36.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:67:0) after 1m0s
[03:33:36.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:67:0)
[03:33:36.596] Timer tick, asking Buildbucket for the build status
[03:33:36.703] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:36.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:68:0) after 1m0s
[03:34:36.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:68:0)
[03:34:36.730] Timer tick, asking Buildbucket for the build status
[03:34:36.796] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:36.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:69:0) after 1m0s
[03:35:36.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:69:0)
[03:35:36.830] Timer tick, asking Buildbucket for the build status
[03:35:37.000] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:37.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:70:0) after 1m0s
[03:36:37.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:70:0)
[03:36:37.092] Timer tick, asking Buildbucket for the build status
[03:36:37.208] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:71:0) after 1m0s
[03:37:37.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:71:0)
[03:37:37.231] Timer tick, asking Buildbucket for the build status
[03:37:37.712] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:37.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:72:0) after 1m0s
[03:38:37.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:72:0)
[03:38:37.779] Timer tick, asking Buildbucket for the build status
[03:38:38.218] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:38.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:73:0) after 1m0s
[03:39:38.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:73:0)
[03:39:38.289] Timer tick, asking Buildbucket for the build status
[03:39:38.430] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:38.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:74:0) after 1m0s
[03:40:38.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:74:0)
[03:40:38.468] Timer tick, asking Buildbucket for the build status
[03:40:38.737] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:38.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:75:0) after 1m0s
[03:41:38.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:75:0)
[03:41:38.790] Timer tick, asking Buildbucket for the build status
[03:41:39.224] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:39.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:76:0) after 1m0s
[03:42:39.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:76:0)
[03:42:39.243] Timer tick, asking Buildbucket for the build status
[03:42:39.313] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:39.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:77:0) after 1m0s
[03:43:39.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:77:0)
[03:43:39.452] Timer tick, asking Buildbucket for the build status
[03:43:39.898] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:39.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:78:0) after 1m0s
[03:44:39.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:78:0)
[03:44:39.917] Timer tick, asking Buildbucket for the build status
[03:44:40.117] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:40.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:79:0) after 1m0s
[03:45:40.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:79:0)
[03:45:40.172] Timer tick, asking Buildbucket for the build status
[03:45:40.951] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:40.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:80:0) after 1m0s
[03:46:40.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:80:0)
[03:46:40.980] Timer tick, asking Buildbucket for the build status
[03:46:41.145] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:41.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:81:0) after 1m0s
[03:47:41.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:81:0)
[03:47:41.205] Timer tick, asking Buildbucket for the build status
[03:47:41.345] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:41.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:82:0) after 1m0s
[03:48:41.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:82:0)
[03:48:41.419] Timer tick, asking Buildbucket for the build status
[03:48:41.516] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:41.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:83:0) after 1m0s
[03:49:41.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:83:0)
[03:49:41.588] Timer tick, asking Buildbucket for the build status
[03:49:41.682] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:41.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:84:0) after 1m0s
[03:50:41.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:84:0)
[03:50:41.702] Timer tick, asking Buildbucket for the build status
[03:50:41.782] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:41.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:85:0) after 1m0s
[03:51:41.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:85:0)
[03:51:41.803] Timer tick, asking Buildbucket for the build status
[03:51:41.886] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:41.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:86:0) after 1m0s
[03:52:42.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:86:0)
[03:52:42.019] Timer tick, asking Buildbucket for the build status
[03:52:42.086] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:42.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:87:0) after 1m0s
[03:53:42.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:87:0)
[03:53:42.109] Timer tick, asking Buildbucket for the build status
[03:53:42.243] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:42.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:88:0) after 1m0s
[03:54:42.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:88:0)
[03:54:42.265] Timer tick, asking Buildbucket for the build status
[03:54:42.349] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:42.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:89:0) after 1m0s
[03:55:42.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:89:0)
[03:55:42.371] Timer tick, asking Buildbucket for the build status
[03:55:42.447] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:42.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:90:0) after 1m0s
[03:56:42.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:90:0)
[03:56:42.477] Timer tick, asking Buildbucket for the build status
[03:56:42.557] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:42.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:91:0) after 1m0s
[03:57:42.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:91:0)
[03:57:42.584] Timer tick, asking Buildbucket for the build status
[03:57:42.675] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:42.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:92:0) after 1m0s
[03:58:42.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:92:0)
[03:58:42.696] Timer tick, asking Buildbucket for the build status
[03:58:43.601] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:43.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:93:0) after 1m0s
[03:59:47.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:93:0)
[03:59:47.077] Timer tick, asking Buildbucket for the build status
[03:59:47.248] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:47.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:94:0) after 1m0s
[04:00:47.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:94:0)
[04:00:47.315] Timer tick, asking Buildbucket for the build status
[04:00:48.722] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:48.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:95:0) after 1m0s
[04:01:48.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:95:0)
[04:01:48.755] Timer tick, asking Buildbucket for the build status
[04:01:48.866] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:48.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:96:0) after 1m0s
[04:02:48.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:96:0)
[04:02:48.958] Timer tick, asking Buildbucket for the build status
[04:02:49.079] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:49.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:97:0) after 1m0s
[04:03:49.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:97:0)
[04:03:49.195] Timer tick, asking Buildbucket for the build status
[04:03:49.329] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:98:0) after 1m0s
[04:04:49.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:98:0)
[04:04:49.356] Timer tick, asking Buildbucket for the build status
[04:04:49.451] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:49.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:99:0) after 1m0s
[04:05:49.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:99:0)
[04:05:49.476] Timer tick, asking Buildbucket for the build status
[04:05:49.952] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:49.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:100:0) after 1m0s
[04:06:49.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:100:0)
[04:06:49.947] Timer tick, asking Buildbucket for the build status
[04:06:50.035] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:50.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:101:0) after 1m0s
[04:07:50.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:101:0)
[04:07:50.081] Timer tick, asking Buildbucket for the build status
[04:07:50.188] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:50.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:102:0) after 1m0s
[04:08:50.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:102:0)
[04:08:50.279] Timer tick, asking Buildbucket for the build status
[04:08:50.404] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:50.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:103:0) after 1m0s
[04:09:50.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:103:0)
[04:09:50.435] Timer tick, asking Buildbucket for the build status
[04:09:50.505] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:50.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:104:0) after 1m0s
[04:10:50.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:104:0)
[04:10:50.531] Timer tick, asking Buildbucket for the build status
[04:10:51.034] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:51.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:105:0) after 1m0s
[04:11:51.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:105:0)
[04:11:51.136] Timer tick, asking Buildbucket for the build status
[04:11:51.208] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:51.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:106:0) after 1m0s
[04:12:51.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:106:0)
[04:12:51.280] Timer tick, asking Buildbucket for the build status
[04:12:51.355] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:51.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:107:0) after 1m0s
[04:13:51.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:107:0)
[04:13:51.331] Timer tick, asking Buildbucket for the build status
[04:13:51.456] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:51.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:108:0) after 1m0s
[04:14:51.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:108:0)
[04:14:51.460] Timer tick, asking Buildbucket for the build status
[04:14:51.812] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:51.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:109:0) after 1m0s
[04:15:51.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:109:0)
[04:15:51.888] Timer tick, asking Buildbucket for the build status
[04:15:51.968] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:51.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:110:0) after 1m0s
[04:16:52.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:110:0)
[04:16:52.037] Timer tick, asking Buildbucket for the build status
[04:16:52.154] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:52.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:111:0) after 1m0s
[04:17:52.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:111:0)
[04:17:52.222] Timer tick, asking Buildbucket for the build status
[04:17:52.328] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:52.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:112:0) after 1m0s
[04:18:52.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:112:0)
[04:18:52.335] Timer tick, asking Buildbucket for the build status
[04:18:52.454] Build 8858438121435727648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:52.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023868183565874128:113:0) after 1m0s
[04:19:32.313] Received PubSub notification, asking Buildbucket for the build status
[04:19:32.384] Build 8858438121435727648: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:19:32.384] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610338771377338",
"created_by": "project:chromium",
"created_ts": "1610332102320340",
"id": "8858438121435727648",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42a72ddb0dd990c210f9e1ff5a05843778548769\"}}",
"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\": \"42a72ddb0dd990c210f9e1ff5a05843778548769\", \"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-159-iph3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22145, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"42a72ddb0dd990c210f9e1ff5a05843778548769\", \"got_revision_cp\": \"refs/heads/master@{#841916}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"42082f9045e74e65b9e3a66b51093e0dc2f9375a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32929}\", \"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\": \"42a72ddb0dd990c210f9e1ff5a05843778548769\", \"swarm_hashes_refs/heads/master(at){#841916}_without_patch\": {\"absl_hardening_tests\": \"44fc57ec55baf0c5dd4f92897124fb9183359132\", \"accessibility_unittests\": \"dade46de349070c270624ab786b59d99c7efaf0e\", \"angle_unittests\": \"990e7ff84167edf4e3d72d69b02e024298d35536\", \"app_list_unittests\": \"a9d246339d54d33bdc771fac78b50d2f03b7ce4c\", \"app_shell_unittests\": \"61bf4ac31198fd0b61aa723ece14d9bd3a7858c6\", \"ash_unittests\": \"dd4f44a521cf9bf44220700d6d9a3652ae46db52\", \"aura_unittests\": \"9c02d2c02aae7b8031497be9c8c97703a3f79f2c\", \"base_unittests\": \"3c024ddbc0c784e494e829819776a5ec1a4dddb7\", \"base_util_unittests\": \"5490b51f3b0baed440540a57687d2d3b4472da25\", \"blink_common_unittests\": \"5ca8e59681c2e5620cb71636a71752cc5fae4e34\", \"blink_fuzzer_unittests\": \"3d14566943a7cf9ca4b73fb20ba274f4bf914139\", \"blink_heap_unittests\": \"d48336b6a7848a96b7ef7b5ff97889a684cc0728\", \"blink_platform_unittests\": \"49f0dbead1389e1b46b6c53146a9e47e3cfaf4b7\", \"blink_unittests\": \"6ab1ab8ba8ae6d3d2b86ef6a2ad259714e9dbbe7\", \"boringssl_crypto_tests\": \"286e5bba7ece62068f3af244c56b6131332fb1ef\", \"boringssl_ssl_tests\": \"b44e6eb080e4d6f73f513fe122cd436a638429aa\", \"browser_tests\": \"75418b2c372c334237835cce1a5d4abb6d1f22f9\", \"capture_unittests\": \"c6bccf76ae9c4ab863eb48e538f903e646fdd858\", \"cast_unittests\": \"6ec5bb6828aad815769e34ac380ded8a619860f3\", \"cc_unittests\": \"71f4bcf50a5800d8580a52630438236696198595\", \"chrome_app_unittests\": \"9c4a90edc321336c58818ee4fe991d29d81da694\", \"chromedriver_unittests\": \"b49109f4797920ef49dc99f5a36ce0ce6cf5e357\", \"chromeos_components_unittests\": \"23fe945caddd8b6b47293f34d289145a53ad2d86\", \"chromeos_unittests\": \"f1308dce1dc674e72794082257ea90e49cb2f5f2\", \"components_browsertests\": \"d2bfa04e2f156d524a2b1828afbf1d3dea3f6a5c\", \"components_unittests\": \"5cead73b84ae0c8857b3bbfd81db290f93b6f101\", \"compositor_unittests\": \"1c2282ac89d244f1587208b0cb8638d3511822a1\", \"content_browsertests\": \"af3aceb5e2c312c09ddc08c33a51e72f13f1b9f1\", \"content_unittests\": \"3c5e1206a42242ce1258b39119078c8028e832fe\", \"crashpad_tests\": \"7ba89622f0b3d8a200b9cac87ae1a1ec284d64e1\", \"crypto_unittests\": \"026911c2875ed226ca2a0790cc81642cb81e7df6\", \"dbus_unittests\": \"659f6b6c761ef02e79a85ca8f8444d263cae0ff0\", \"device_unittests\": \"fc80cd43f3b05c1c9f69672bee3e9c347d14351f\", \"display_unittests\": \"eacb6df92fcd034d8c6fd7b72ca17328b00017a3\", \"events_unittests\": \"1a9739f3cbb85132850ffc73487107db903c5e56\", \"exo_unittests\": \"e9defed70fac83c6e390321dec652cd8e2bd2b1e\", \"extensions_browsertests\": \"b1de7cc530d39722935e1b61a907fdd95bb13634\", \"extensions_unittests\": \"d19fd1ff33994bdfb07eb8f6d48ea0617637c26c\", \"filesystem_service_unittests\": \"535704a5e01f0b4dc42dd25c0a07f090a68d7c4f\", \"gcm_unit_tests\": \"4934797efb0ae45a576af0f9bebaceaf0aec0785\", \"gfx_unittests\": \"3079632f9402996888921af9e843e8a6b508c28a\", \"gin_unittests\": \"6b276f7859435ae4f13a2c652b5727f9b6639922\", \"gl_unittests_ozone\": \"e18d67cc24f67d6452e162b3a6be247fc6a771d6\", \"google_apis_unittests\": \"c863fd5ff78f9ab1b244cf58bd1729e93daf6ac7\", \"gpu_unittests\": \"d0efd10ed74cbcb6acab77aaa2242fb363b311b8\", \"gwp_asan_unittests\": \"e8796f591c73912fce9bec8d86cac00633ebd623\", \"interactive_ui_tests\": \"c77651a8215303a60d6579805697aec8934c21a9\", \"ipc_tests\": \"a3eeada68512c57dfa0850d85074cceda4baf818\", \"jingle_unittests\": \"89827577b1a290311cfa1c5119b0df4da81378b7\", \"keyboard_unittests\": \"f783e23aee852fe390857345b537a43bde7dd56c\", \"latency_unittests\": \"0361473c934b199669bccdafa231ad40f46a5ce3\", \"libjingle_xmpp_unittests\": \"f7348af02e7a91a1b606d949d93bbb8e8da97b52\", \"liburlpattern_unittests\": \"75ef4e41d67919594f703792ee74c1201e4d2175\", \"media_blink_unittests\": \"58890c9ac16bb696d306a728d10204d03fcc4944\", \"media_unittests\": \"b6626e7d8b488d4a4d8b4d4962b3db43137dbcb2\", \"message_center_unittests\": \"dbca891d664b93da27d70d0087a58002680a760a\", \"midi_unittests\": \"148ad0ed7ff8831f22d7e6557fe001a6f5e31a7b\", \"mojo_core_unittests\": \"01fbfc653851a70e0efc826e452a744908ba9882\", \"mojo_unittests\": \"edf06d172c706df5052bc37da03a3f6021be6c9b\", \"nacl_helper_nonsfi_unittests\": \"7afe5f4ab6a1decf3358920a803e8985eeee9cc8\", \"nacl_loader_unittests\": \"ca24f1a0f26813c0fd9aa9e2744cc43773fc149d\", \"native_theme_unittests\": \"6fbbfffc2e78ea7e640a4b6b7092c2c32b16c3b6\", \"net_unittests\": \"20aa9813a9e566403572456db915bc069b69d0fa\", \"ozone_gl_unittests\": \"8a293ae6610b860ce9b7b4f4389e3aeea72bc481\", \"ozone_unittests\": \"c494caa9c3e9a69942ed22f57d2d9481878bb75f\", \"ozone_x11_unittests\": \"257c8d7fa098bdaa14ba68b1580ac930153a9677\", \"pdf_unittests\": \"79c3d5e0a43179d70932de878cecbbfd96968a91\", \"perfetto_unittests\": \"c141ad8e959e87fbb1b9167fe5739711385c7507\", \"ppapi_unittests\": \"f93628f4ea2d32fc49c0676ecc2d3b5577242725\", \"printing_unittests\": \"1b1a370e4a043ed01dc9d54aa7a73ad0206449ff\", \"remoting_unittests\": \"a678f18ed414dcd7a2f322ab7b6dfdf2eaceb789\", \"sandbox_linux_unittests\": \"f146eaa2113754448e5c98a5be0b33b2f918a503\", \"service_manager_unittests\": \"5ddcb501ba76aa75fd646b18f45a81f2857a3773\", \"services_unittests\": \"ff2510aaa6494b176f4f18debc1987b769a63c06\", \"shell_dialogs_unittests\": \"1fe6a59d8aefede1c89ef7abbe62c8b391472d8d\", \"shell_encryption_unittests\": \"dbec24febddb2d76ffc00d1066b8b4137611d335\", \"skia_unittests\": \"6b062e7b7e1cf088936be79f3eaaa6363eb550e9\", \"snapshot_unittests\": \"b5078d5644990bfbf84e50e328f1d0c478cf913a\", \"sql_unittests\": \"4714595228179a83d99ef8cbe298b0b30f262a28\", \"storage_unittests\": \"2b44049c84cbb4bafca6a8c279dc1b1726355f1b\", \"sync_integration_tests\": \"6a1390d92b7978f07d7aad17a0258d54b3d48cb0\", \"traffic_annotation_auditor_unittests\": \"ce4d3448b446a6ee103c19197f20fa9f0935124e\", \"ui_base_unittests\": \"7c2b1e784f04bd0e00173bde7916933a78c48c0c\", \"ui_chromeos_unittests\": \"81f2b2e1d93e96088c3ec767b2c7eac95ab16bdf\", \"ui_touch_selection_unittests\": \"67c3a1841fb56347bd0a997fec8418981010308a\", \"unit_tests\": \"e794d207fc80f7d0802c2dbf1d1a2c50954cb56c\", \"url_unittests\": \"a39c30bb6aed39a4771f332f845e2139b87d644a\", \"usage_time_limit_unittests\": \"de4520a88283767ea6e35ede605f09133d36887b\", \"views_unittests\": \"fde232aaa5e1d44ed3cbc96315b76d5857333aae\", \"viz_unittests\": \"f08a9267eb9d2fea010343390d606d2cfd8b211c\", \"wm_unittests\": \"8bf52afbb7c01f1842f03ac58eb24f629ef5b419\", \"wtf_unittests\": \"bee55339f2cd54a674a00e33bb62f157fd28e160\", \"zlib_unittests\": \"d7ff0bb7b6662bdfc53d542ff270dc8fba274e31\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_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-159-iph3\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610332381563103",
"status": "COMPLETED",
"status_changed_ts": "1610338771766058",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22145",
"builder:linux-chromeos-dbg",
"buildset:commit/git/42a72ddb0dd990c210f9e1ff5a05843778548769",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a72ddb0dd990c210f9e1ff5a05843778548769",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023868183565874128",
"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/8858438121435727648/+/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:5108176b32e84510",
"user_agent:luci-scheduler"
],
"updated_ts": "1610338771770871",
"url": "https://ci.chromium.org/b/8858438121435727648",
"utcnow_ts": "1610338772373338"
}
}
[04:19:32.384] Invocation finished in 1h51m11.478873591s with status SUCCEEDED