[04:09:28.371] New invocation is queued and will start shortly
[04:09:29.503] Starting the invocation (attempt 1)
[04:09:29.540] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:09:29.540] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:09:29.540] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023590030484469520",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"54253913786d16850c0ccf469ca9820cbf2c499d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023590030484469520",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/54253913786d16850c0ccf469ca9820cbf2c499d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54253913786d16850c0ccf469ca9820cbf2c499d",
"gitiles_ref:refs/heads/master"
]
}
[04:09:30.450] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1610597369625723",
"id": "8858159968506177472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54253913786d16850c0ccf469ca9820cbf2c499d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610597370085970",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22192",
"builder:linux-chromeos-dbg",
"buildset:commit/git/54253913786d16850c0ccf469ca9820cbf2c499d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54253913786d16850c0ccf469ca9820cbf2c499d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023590030484469520",
"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/8858159968506177472/+/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": "1610597370086102",
"url": "https://ci.chromium.org/b/8858159968506177472",
"utcnow_ts": "1610597370374290"
}
}
[04:09:30.450] Task URL: https://ci.chromium.org/b/8858159968506177472
[04:09:30.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:2:0) after 1m0s
[04:10:08.174] Received PubSub notification, asking Buildbucket for the build status
[04:10:08.512] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:30.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:2:0)
[04:10:30.843] Timer tick, asking Buildbucket for the build status
[04:10:31.145] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:31.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:4:0) after 1m0s
[04:11:31.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:4:0)
[04:11:31.453] Timer tick, asking Buildbucket for the build status
[04:11:31.723] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:31.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:5:0) after 1m0s
[04:12:31.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:5:0)
[04:12:31.760] Timer tick, asking Buildbucket for the build status
[04:12:31.829] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:31.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:6:0) after 1m0s
[04:13:31.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:6:0)
[04:13:31.988] Timer tick, asking Buildbucket for the build status
[04:13:32.168] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:32.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:7:0) after 1m0s
[04:14:32.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:7:0)
[04:14:32.230] Timer tick, asking Buildbucket for the build status
[04:14:32.400] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:32.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:8:0) after 1m0s
[04:15:32.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:8:0)
[04:15:32.470] Timer tick, asking Buildbucket for the build status
[04:15:33.042] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:33.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:9:0) after 1m0s
[04:16:33.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:9:0)
[04:16:33.079] Timer tick, asking Buildbucket for the build status
[04:16:33.199] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:33.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:10:0) after 1m0s
[04:17:33.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:10:0)
[04:17:33.235] Timer tick, asking Buildbucket for the build status
[04:17:33.342] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:33.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:11:0) after 1m0s
[04:18:33.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:11:0)
[04:18:33.395] Timer tick, asking Buildbucket for the build status
[04:18:33.518] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:33.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:12:0) after 1m0s
[04:19:33.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:12:0)
[04:19:33.546] Timer tick, asking Buildbucket for the build status
[04:19:33.640] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:33.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:13:0) after 1m0s
[04:20:33.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:13:0)
[04:20:33.691] Timer tick, asking Buildbucket for the build status
[04:20:33.997] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:33.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:14:0) after 1m0s
[04:21:34.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:14:0)
[04:21:34.026] Timer tick, asking Buildbucket for the build status
[04:21:34.510] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:34.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:15:0) after 1m0s
[04:22:34.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:15:0)
[04:22:34.599] Timer tick, asking Buildbucket for the build status
[04:22:34.669] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:34.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:16:0) after 1m0s
[04:23:34.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:16:0)
[04:23:34.735] Timer tick, asking Buildbucket for the build status
[04:23:34.801] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:34.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:17:0) after 1m0s
[04:24:34.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:17:0)
[04:24:34.920] Timer tick, asking Buildbucket for the build status
[04:24:35.072] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:35.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:18:0) after 1m0s
[04:25:35.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:18:0)
[04:25:35.206] Timer tick, asking Buildbucket for the build status
[04:25:35.288] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:35.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:19:0) after 1m0s
[04:26:35.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:19:0)
[04:26:35.332] Timer tick, asking Buildbucket for the build status
[04:26:35.710] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:35.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:20:0) after 1m0s
[04:27:35.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:20:0)
[04:27:35.743] Timer tick, asking Buildbucket for the build status
[04:27:35.812] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:35.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:21:0) after 1m0s
[04:28:36.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:21:0)
[04:28:36.005] Timer tick, asking Buildbucket for the build status
[04:28:36.319] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:36.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:22:0) after 1m0s
[04:29:36.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:22:0)
[04:29:36.340] Timer tick, asking Buildbucket for the build status
[04:29:36.505] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:36.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:23:0) after 1m0s
[04:30:36.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:23:0)
[04:30:36.530] Timer tick, asking Buildbucket for the build status
[04:30:36.897] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:36.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:24:0) after 1m0s
[04:31:36.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:24:0)
[04:31:36.905] Timer tick, asking Buildbucket for the build status
[04:31:36.961] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:36.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:25:0) after 1m0s
[04:32:37.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:25:0)
[04:32:37.010] Timer tick, asking Buildbucket for the build status
[04:32:37.074] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:37.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:26:0) after 1m0s
[04:33:37.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:26:0)
[04:33:37.178] Timer tick, asking Buildbucket for the build status
[04:33:37.241] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:37.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:27:0) after 1m0s
[04:34:37.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:27:0)
[04:34:37.408] Timer tick, asking Buildbucket for the build status
[04:34:37.566] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:37.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:28:0) after 1m0s
[04:35:37.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:28:0)
[04:35:37.628] Timer tick, asking Buildbucket for the build status
[04:35:38.108] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:38.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:29:0) after 1m0s
[04:36:38.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:29:0)
[04:36:38.225] Timer tick, asking Buildbucket for the build status
[04:36:38.276] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:38.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:30:0) after 1m0s
[04:37:38.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:30:0)
[04:37:38.385] Timer tick, asking Buildbucket for the build status
[04:37:38.451] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:38.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:31:0) after 1m0s
[04:38:38.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:31:0)
[04:38:38.454] Timer tick, asking Buildbucket for the build status
[04:38:38.517] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:38.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:32:0) after 1m0s
[04:39:38.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:32:0)
[04:39:38.536] Timer tick, asking Buildbucket for the build status
[04:39:38.997] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:38.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:33:0) after 1m0s
[04:40:39.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:33:0)
[04:40:39.063] Timer tick, asking Buildbucket for the build status
[04:40:39.156] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:39.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:34:0) after 1m0s
[04:41:39.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:34:0)
[04:41:39.148] Timer tick, asking Buildbucket for the build status
[04:41:39.223] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:39.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:35:0) after 1m0s
[04:42:39.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:35:0)
[04:42:39.299] Timer tick, asking Buildbucket for the build status
[04:42:39.407] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:39.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:36:0) after 1m0s
[04:43:39.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:36:0)
[04:43:39.434] Timer tick, asking Buildbucket for the build status
[04:43:39.521] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:39.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:37:0) after 1m0s
[04:44:39.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:37:0)
[04:44:39.578] Timer tick, asking Buildbucket for the build status
[04:44:39.696] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:39.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:38:0) after 1m0s
[04:45:39.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:38:0)
[04:45:39.759] Timer tick, asking Buildbucket for the build status
[04:45:39.849] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:39.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:39:0) after 1m0s
[04:46:39.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:39:0)
[04:46:39.853] Timer tick, asking Buildbucket for the build status
[04:46:40.100] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:40.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:40:0) after 1m0s
[04:47:40.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:40:0)
[04:47:40.152] Timer tick, asking Buildbucket for the build status
[04:47:40.224] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:40.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:41:0) after 1m0s
[04:48:40.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:41:0)
[04:48:40.195] Timer tick, asking Buildbucket for the build status
[04:48:40.278] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:40.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:42:0) after 1m0s
[04:49:40.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:42:0)
[04:49:40.306] Timer tick, asking Buildbucket for the build status
[04:49:40.440] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:40.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:43:0) after 1m0s
[04:50:40.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:43:0)
[04:50:40.504] Timer tick, asking Buildbucket for the build status
[04:50:40.672] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:40.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:44:0) after 1m0s
[04:51:40.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:44:0)
[04:51:40.694] Timer tick, asking Buildbucket for the build status
[04:51:40.910] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:40.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:45:0) after 1m0s
[04:52:40.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:45:0)
[04:52:40.975] Timer tick, asking Buildbucket for the build status
[04:52:41.115] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:41.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:46:0) after 1m0s
[04:53:41.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:46:0)
[04:53:41.253] Timer tick, asking Buildbucket for the build status
[04:53:41.387] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:41.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:47:0) after 1m0s
[04:54:41.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:47:0)
[04:54:41.417] Timer tick, asking Buildbucket for the build status
[04:54:41.587] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:41.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:48:0) after 1m0s
[04:55:41.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:48:0)
[04:55:41.635] Timer tick, asking Buildbucket for the build status
[04:55:41.733] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:41.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:49:0) after 1m0s
[04:56:41.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:49:0)
[04:56:41.760] Timer tick, asking Buildbucket for the build status
[04:56:41.857] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:41.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:50:0) after 1m0s
[04:57:42.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:50:0)
[04:57:42.006] Timer tick, asking Buildbucket for the build status
[04:57:42.116] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:42.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:51:0) after 1m0s
[04:58:42.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:51:0)
[04:58:42.247] Timer tick, asking Buildbucket for the build status
[04:58:42.543] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:42.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:52:0) after 1m0s
[04:59:42.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:52:0)
[04:59:42.706] Timer tick, asking Buildbucket for the build status
[04:59:42.799] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:42.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:53:0) after 1m0s
[05:00:42.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:53:0)
[05:00:42.871] Timer tick, asking Buildbucket for the build status
[05:00:44.044] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:44.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:54:0) after 1m0s
[05:01:44.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:54:0)
[05:01:44.174] Timer tick, asking Buildbucket for the build status
[05:01:44.810] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:44.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:55:0) after 1m0s
[05:02:44.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:55:0)
[05:02:44.810] Timer tick, asking Buildbucket for the build status
[05:02:44.872] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:44.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:56:0) after 1m0s
[05:03:44.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:56:0)
[05:03:44.899] Timer tick, asking Buildbucket for the build status
[05:03:45.009] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:57:0) after 1m0s
[05:04:45.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:57:0)
[05:04:45.069] Timer tick, asking Buildbucket for the build status
[05:04:45.232] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:45.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:58:0) after 1m0s
[05:05:45.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:58:0)
[05:05:45.219] Timer tick, asking Buildbucket for the build status
[05:05:45.283] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:45.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:59:0) after 1m0s
[05:06:45.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:59:0)
[05:06:45.384] Timer tick, asking Buildbucket for the build status
[05:06:45.528] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:45.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:60:0) after 1m0s
[05:07:45.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:60:0)
[05:07:45.549] Timer tick, asking Buildbucket for the build status
[05:07:45.655] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:45.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:61:0) after 1m0s
[05:08:45.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:61:0)
[05:08:45.759] Timer tick, asking Buildbucket for the build status
[05:08:46.009] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:46.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:62:0) after 1m0s
[05:09:46.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:62:0)
[05:09:46.106] Timer tick, asking Buildbucket for the build status
[05:09:46.306] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:46.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:63:0) after 1m0s
[05:10:46.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:63:0)
[05:10:46.353] Timer tick, asking Buildbucket for the build status
[05:10:46.421] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:46.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:64:0) after 1m0s
[05:11:46.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:64:0)
[05:11:46.446] Timer tick, asking Buildbucket for the build status
[05:11:46.640] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:46.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:65:0) after 1m0s
[05:12:46.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:65:0)
[05:12:46.706] Timer tick, asking Buildbucket for the build status
[05:12:46.788] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:46.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:66:0) after 1m0s
[05:13:46.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:66:0)
[05:13:46.845] Timer tick, asking Buildbucket for the build status
[05:13:46.972] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:46.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:67:0) after 1m0s
[05:14:47.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:67:0)
[05:14:47.027] Timer tick, asking Buildbucket for the build status
[05:14:47.166] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:47.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:68:0) after 1m0s
[05:15:47.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:68:0)
[05:15:47.226] Timer tick, asking Buildbucket for the build status
[05:15:48.012] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:48.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:69:0) after 1m0s
[05:16:48.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:69:0)
[05:16:48.073] Timer tick, asking Buildbucket for the build status
[05:16:48.204] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:48.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:70:0) after 1m0s
[05:17:48.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:70:0)
[05:17:48.255] Timer tick, asking Buildbucket for the build status
[05:17:48.327] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:48.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:71:0) after 1m0s
[05:18:48.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:71:0)
[05:18:48.412] Timer tick, asking Buildbucket for the build status
[05:18:48.559] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:48.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:72:0) after 1m0s
[05:19:48.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:72:0)
[05:19:48.670] Timer tick, asking Buildbucket for the build status
[05:19:48.775] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:48.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:73:0) after 1m0s
[05:20:48.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:73:0)
[05:20:48.860] Timer tick, asking Buildbucket for the build status
[05:20:49.088] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:49.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:74:0) after 1m0s
[05:21:49.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:74:0)
[05:21:49.115] Timer tick, asking Buildbucket for the build status
[05:21:49.181] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:49.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:75:0) after 1m0s
[05:22:49.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:75:0)
[05:22:49.238] Timer tick, asking Buildbucket for the build status
[05:22:49.500] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:49.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:76:0) after 1m0s
[05:23:49.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:76:0)
[05:23:49.533] Timer tick, asking Buildbucket for the build status
[05:23:50.010] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:50.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:77:0) after 1m0s
[05:24:50.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:77:0)
[05:24:50.069] Timer tick, asking Buildbucket for the build status
[05:24:50.240] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:50.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:78:0) after 1m0s
[05:25:50.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:78:0)
[05:25:50.279] Timer tick, asking Buildbucket for the build status
[05:25:50.544] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:50.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:79:0) after 1m0s
[05:26:50.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:79:0)
[05:26:50.556] Timer tick, asking Buildbucket for the build status
[05:26:50.915] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:50.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:80:0) after 1m0s
[05:27:51.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:80:0)
[05:27:51.023] Timer tick, asking Buildbucket for the build status
[05:27:51.226] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:81:0) after 1m0s
[05:28:51.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:81:0)
[05:28:51.275] Timer tick, asking Buildbucket for the build status
[05:28:51.614] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:82:0) after 1m0s
[05:29:51.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:82:0)
[05:29:51.719] Timer tick, asking Buildbucket for the build status
[05:29:51.835] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:51.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:83:0) after 1m0s
[05:30:51.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:83:0)
[05:30:51.866] Timer tick, asking Buildbucket for the build status
[05:30:52.193] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:52.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:84:0) after 1m0s
[05:31:52.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:84:0)
[05:31:52.221] Timer tick, asking Buildbucket for the build status
[05:31:52.313] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:52.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:85:0) after 1m0s
[05:32:52.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:85:0)
[05:32:52.402] Timer tick, asking Buildbucket for the build status
[05:32:52.592] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:52.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:86:0) after 1m0s
[05:33:52.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:86:0)
[05:33:52.637] Timer tick, asking Buildbucket for the build status
[05:33:52.826] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:52.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:87:0) after 1m0s
[05:34:52.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:87:0)
[05:34:52.874] Timer tick, asking Buildbucket for the build status
[05:34:52.980] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:52.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:88:0) after 1m0s
[05:35:53.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:88:0)
[05:35:53.058] Timer tick, asking Buildbucket for the build status
[05:35:53.129] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:53.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:89:0) after 1m0s
[05:36:53.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:89:0)
[05:36:53.152] Timer tick, asking Buildbucket for the build status
[05:36:53.233] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:53.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:90:0) after 1m0s
[05:37:53.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:90:0)
[05:37:53.266] Timer tick, asking Buildbucket for the build status
[05:37:53.591] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:53.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:91:0) after 1m0s
[05:38:53.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:91:0)
[05:38:53.723] Timer tick, asking Buildbucket for the build status
[05:38:54.629] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:54.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:92:0) after 1m0s
[05:39:54.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:92:0)
[05:39:54.645] Timer tick, asking Buildbucket for the build status
[05:39:55.159] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:55.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:93:0) after 1m0s
[05:40:55.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:93:0)
[05:40:55.203] Timer tick, asking Buildbucket for the build status
[05:40:55.314] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:55.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:94:0) after 1m0s
[05:41:55.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:94:0)
[05:41:55.401] Timer tick, asking Buildbucket for the build status
[05:41:55.824] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:55.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:95:0) after 1m0s
[05:42:55.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:95:0)
[05:42:55.942] Timer tick, asking Buildbucket for the build status
[05:42:56.051] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:56.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:96:0) after 1m0s
[05:43:56.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:96:0)
[05:43:56.135] Timer tick, asking Buildbucket for the build status
[05:43:56.205] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:56.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:97:0) after 1m0s
[05:44:56.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:97:0)
[05:44:56.218] Timer tick, asking Buildbucket for the build status
[05:44:56.314] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:56.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:98:0) after 1m0s
[05:45:56.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:98:0)
[05:45:56.327] Timer tick, asking Buildbucket for the build status
[05:45:56.522] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:56.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:99:0) after 1m0s
[05:46:56.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:99:0)
[05:46:56.643] Timer tick, asking Buildbucket for the build status
[05:46:56.710] Build 8858159968506177472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:56.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023590030484469520:100:0) after 1m0s
[05:47:52.064] Received PubSub notification, asking Buildbucket for the build status
[05:47:52.260] Build 8858159968506177472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:47:52.260] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610603270547984",
"created_by": "project:chromium",
"created_ts": "1610597369625723",
"id": "8858159968506177472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54253913786d16850c0ccf469ca9820cbf2c499d\"}}",
"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\": \"54253913786d16850c0ccf469ca9820cbf2c499d\", \"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-72-w0e6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22192, \"got_angle_revision\": \"6c79df687e098972d3fcc861f5231f8f582379b8\", \"got_dawn_revision\": \"8ba0a01d1e59d21d7db6ea4396a0f951fff3c2d0\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"54253913786d16850c0ccf469ca9820cbf2c499d\", \"got_revision_cp\": \"refs/heads/master@{#843378}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c4a1bd4553ff61f771ce240a2b7033a02d4e5325\", \"got_v8_revision\": \"712b239be61d29c242052c85f927da5291648e41\", \"got_v8_revision_cp\": \"refs/heads/8.9.272@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"54253913786d16850c0ccf469ca9820cbf2c499d\", \"swarm_hashes_refs/heads/master(at){#843378}_without_patch\": {\"absl_hardening_tests\": \"1c39a9e070aa8afaa3a567677a3aad1a8a86d758\", \"accessibility_unittests\": \"f0103b2af879493e724662c62aaacec195a8222a\", \"angle_unittests\": \"b8475c578444a1253a0ddaab2ab78db8bd64bdc0\", \"app_list_unittests\": \"862bce43bab0d980fa9619be72d56d58f78847a3\", \"app_shell_unittests\": \"db924d5211953cf449b2e5465037ed62dd4be526\", \"ash_unittests\": \"a0caf54e3dabddba66bcfaca407903ba3807df1a\", \"aura_unittests\": \"2bd4d8dfce8c0cc80f8ddae50fd478ef15e19770\", \"base_unittests\": \"f3829e0707260d132910f744d8fc946736bd8779\", \"base_util_unittests\": \"85f5a02b918dcbba4de4a9eda4c9d1c8aa7bf05b\", \"blink_common_unittests\": \"a3c99327264930669fd8b9de617e20579a84a9d6\", \"blink_fuzzer_unittests\": \"ce17a80338b6f8fbe0b40a0d88b02aca65e32c8b\", \"blink_heap_unittests\": \"9c509539df32981a084d35d1a81782cfffa6b9c1\", \"blink_platform_unittests\": \"eef65f5ef1d60e9fc118933624bbf02f24e24171\", \"blink_unittests\": \"2b6ba20e4821eb6df257b2813311fa00a0f45382\", \"boringssl_crypto_tests\": \"b283c428fa6a2f2a7b5a08ddf5b63e10f8750327\", \"boringssl_ssl_tests\": \"5a4d15505f4fa944c12ceb267539426845e8edae\", \"browser_tests\": \"e27f920405b51840b713372e4f23c59ff6f38d4e\", \"capture_unittests\": \"f11bafa2db4d386a1499cac1dc30c5f378b86eb5\", \"cast_unittests\": \"64097cf9b55b17bbc3cb61faef81f5618dc692a9\", \"cc_unittests\": \"07a38c512a950e24319fd5e60364c8a06452609d\", \"chrome_app_unittests\": \"f2206a010b55ac077d275a0a9ae0f6d9dc563ff5\", \"chromedriver_unittests\": \"4aa760c0d606b854d18ec02945086511fa0852c2\", \"chromeos_components_unittests\": \"6c23a7a46c0ee7a78b2591958139b6933d2ff3c0\", \"chromeos_unittests\": \"b167516d41a4e36072c347adc15ebfc91ea60270\", \"components_browsertests\": \"32d161fa9122ee11fd8353404776a224c1aa9dfb\", \"components_unittests\": \"9211ff129e19b25b3ed7b9c471c8760f3bb0c366\", \"compositor_unittests\": \"c1664fba8051b10f0657a5271ccedb7980107e3e\", \"content_browsertests\": \"c8a7f9f37105ae3963cfdd92c48a85e1da0fc16b\", \"content_unittests\": \"fb1b31c45eaa71c60a2bc4cd9ddfe3594f4a05d7\", \"crashpad_tests\": \"65208879a8efd06c677ec4acdd229cad476e9a5f\", \"crypto_unittests\": \"17bff5e012295b9939c56028bcf080ad0b6e8f68\", \"dbus_unittests\": \"9011774c73b039c9c6468026487201af6544c9b8\", \"device_unittests\": \"0db4b3f9b64c7e9b14165a9a1a50b9116dd1fed2\", \"display_unittests\": \"c7b023ed34eeebb7f7d98e625bda5ab6acb5dfed\", \"events_unittests\": \"c634c58d9d1d73173fd9862727a088ab41502d98\", \"exo_unittests\": \"44120e943d212fa7f43172d254af8101cdee54e6\", \"extensions_browsertests\": \"1338a017431f1d2009feb3be9bae8b7917daa3c7\", \"extensions_unittests\": \"176fab2422340fa3cb2c7b187d8900b7fc4b4457\", \"filesystem_service_unittests\": \"8488d6f81eea2bb46b4b0e8c9da019da371575a0\", \"gcm_unit_tests\": \"b99398a1577f9b148be9f2e33097000e124b7585\", \"gfx_unittests\": \"fe7dcaaad5ad4e91e087dfbfa9656ace8a0945d9\", \"gin_unittests\": \"b61148e7b70a3977947146ba74ed437a53e1a3eb\", \"gl_unittests_ozone\": \"9e84b1ce80b6295dc668877fc2c263fbe49df496\", \"google_apis_unittests\": \"a2a32f838491baf2be054a84cde50d4f4d2a09d6\", \"gpu_unittests\": \"18e654f6ba154d3b2a49b3f2b49fef9f368837bf\", \"gwp_asan_unittests\": \"046f99f6e292bdcf6c12ea94dc010bb6e5bd10a5\", \"interactive_ui_tests\": \"f8e1b0ce6bdc8bff73299df3a907c2fbd4f288d2\", \"ipc_tests\": \"ea74ec131f78d5962c302069bb3af87bd9b2bd10\", \"jingle_unittests\": \"e2628ca6c58e7679de2931b88426231c7b05e720\", \"keyboard_unittests\": \"1462db4b5227544e5c638185aa3ff8322dc04a6e\", \"latency_unittests\": \"1a1df3a784f370da3f2e858af47e4bceba42d23c\", \"libjingle_xmpp_unittests\": \"3acc35395474c306be63b0810a94fd2710b90e80\", \"liburlpattern_unittests\": \"f2bd060e1927ad656af65a800a59eed0075b3c43\", \"media_blink_unittests\": \"c873c67d451e0a061a04642f33eceeec3ea5837d\", \"media_unittests\": \"b83ee44589c15dbb416b97f9282bc08419c8a8fa\", \"message_center_unittests\": \"73e733d4ab71363c3ab4fd54ad670a79f88dfa4f\", \"midi_unittests\": \"8858b3ea7b1191e433cd7707bc98adf0dc30744a\", \"mojo_core_unittests\": \"9d1d01f223f8de96bb5bfb1885d069ff37ae391d\", \"mojo_unittests\": \"7289b30ede0dbcbebaa3bd43872458d627fd8c2b\", \"nacl_helper_nonsfi_unittests\": \"c1eadd4f180e8231cb689888d77f6dee3b6558f1\", \"nacl_loader_unittests\": \"3ec9233afe438de6ce498275e769bfb58acf21d8\", \"native_theme_unittests\": \"b6e4b9e3eb3688e940a35caf8dd8b43b0cc0edf1\", \"net_unittests\": \"9eb47df39bac8cf1148a95a7f06c545e38e0d289\", \"ozone_gl_unittests\": \"45f3c1730975692ffc7e82ca5ab1d8395d24a80a\", \"ozone_unittests\": \"28b8b7fe5ee885b550b63cd5d3d09fac8a4cb6b1\", \"ozone_x11_unittests\": \"3da4db838be18519b474c932f268a8eb6f48c05e\", \"pdf_unittests\": \"6b713fc45fce7459cce472cd99fcbf4829614acf\", \"perfetto_unittests\": \"ad2682207278a60311bff0e9dbeeb632dfc5e9c3\", \"ppapi_unittests\": \"0c35ff51e2931437fd6637e49948501a8e568d71\", \"printing_unittests\": \"28954d24dfb9a8726f5b014aa479fae303451b1c\", \"remoting_unittests\": \"06140a63e3ef5b2e6bab5d11c5bdc29b1ef14240\", \"sandbox_linux_unittests\": \"c00400bcf74aa899c0d492e2ee1f640d3eb53422\", \"service_manager_unittests\": \"49203a47c5e35fcc9fcd10cba0108752f5a11514\", \"services_unittests\": \"ce19fe4a097d5a9996e572b522a49a31f7b8c11f\", \"shell_dialogs_unittests\": \"c52a0ec27f3520f01941b337b9e4360bc0931b9f\", \"shell_encryption_unittests\": \"473edefce1a53cb7b0ab6f032b43a0566281cb14\", \"skia_unittests\": \"765cd02df23844b14e045cf0c3004c5bdab4ebe8\", \"snapshot_unittests\": \"d505cd7ea17607de0c87a48c72f69d33255d8b54\", \"sql_unittests\": \"ed10067beca69755374f87eb2cebb12b7e3cae12\", \"storage_unittests\": \"3e500e4ebdab965903522ed5b2ef48a0fef0b404\", \"sync_integration_tests\": \"10e93da2bd056254f40289e3fc48d4ba0cc0c99d\", \"traffic_annotation_auditor_unittests\": \"e79a2a5a75e01340feb24aed800c3c96ad43083a\", \"ui_base_unittests\": \"f594af7cf8b5cc7a013828eb6913d9f7b952c0f5\", \"ui_chromeos_unittests\": \"82d37c273a6f1f3cc49473b3549c83b7f43573c6\", \"ui_touch_selection_unittests\": \"261062b3e43470677fb18a3d8f5dd97a1c93e2fb\", \"unit_tests\": \"307fc80e00fec581075ef50af7c070de1c50ce2c\", \"url_unittests\": \"4db7e8c4d9fa7462ecbfc3a4e2a29cd9de496cc6\", \"usage_time_limit_unittests\": \"3ad8bf042d73c3c9b93476c2d62db1fb424eddb1\", \"views_unittests\": \"5e9aed33b196dafa653596ea979a0c14d65a0083\", \"viz_unittests\": \"ab837276a3610cab8fa0305316e4fb1ac9eb52dd\", \"wm_unittests\": \"f52b9e4dcf928770dbb18fdca6e5708e54562d02\", \"wtf_unittests\": \"508d43d4d675bb45b35f6549fc9bd280d62bc448\", \"zlib_unittests\": \"fd8ae3918f26c6cd827615432ec38f270037f69c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_8ed59a4fa98a52009c5b7be7e9c90826b738aab438c85f8db549ef122247493f_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-72-w0e6\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610597406255222",
"status": "COMPLETED",
"status_changed_ts": "1610603271195395",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22192",
"builder:linux-chromeos-dbg",
"buildset:commit/git/54253913786d16850c0ccf469ca9820cbf2c499d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54253913786d16850c0ccf469ca9820cbf2c499d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023590030484469520",
"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/8858159968506177472/+/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:5117e712e7969810",
"user_agent:luci-scheduler"
],
"updated_ts": "1610603271220287",
"url": "https://ci.chromium.org/b/8858159968506177472",
"utcnow_ts": "1610603272249273"
}
}
[05:47:52.260] Invocation finished in 1h38m23.90471654s with status SUCCEEDED