[14:04:39.042] New invocation is queued and will start shortly
[14:04:40.174] Starting the invocation (attempt 1)
[14:04:40.234] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:04:40.234] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:04:40.234] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030528551557570144",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3f309335571515a4ec8a9cf27caa8a3427c41f24\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030528551557570144",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"gitiles_ref:refs/heads/master"
]
}
[14:04:41.077] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603980280381072",
"id": "8865098489477204112",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f309335571515a4ec8a9cf27caa8a3427c41f24\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603980280906927",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21060",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030528551557570144",
"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/8865098489477204112/+/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": "1603980280907043",
"url": "https://ci.chromium.org/b/8865098489477204112",
"utcnow_ts": "1603980281064090"
}
}
[14:04:41.077] Task URL: https://ci.chromium.org/b/8865098489477204112
[14:04:41.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:2:0) after 1m0s
[14:04:52.320] Received PubSub notification, asking Buildbucket for the build status
[14:04:52.714] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:41.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:2:0)
[14:05:41.206] Timer tick, asking Buildbucket for the build status
[14:05:41.353] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:41.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:4:0) after 1m0s
[14:06:41.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:4:0)
[14:06:41.379] Timer tick, asking Buildbucket for the build status
[14:06:41.953] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:41.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:5:0) after 1m0s
[14:07:42.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:5:0)
[14:07:42.001] Timer tick, asking Buildbucket for the build status
[14:07:42.133] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:42.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:6:0) after 1m0s
[14:08:42.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:6:0)
[14:08:42.193] Timer tick, asking Buildbucket for the build status
[14:08:42.435] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:42.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:7:0) after 1m0s
[14:09:42.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:7:0)
[14:09:42.465] Timer tick, asking Buildbucket for the build status
[14:09:42.772] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:42.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:8:0) after 1m0s
[14:10:42.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:8:0)
[14:10:42.801] Timer tick, asking Buildbucket for the build status
[14:10:43.098] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:43.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:9:0) after 1m0s
[14:11:43.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:9:0)
[14:11:43.139] Timer tick, asking Buildbucket for the build status
[14:11:44.613] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:44.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:10:0) after 1m0s
[14:12:44.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:10:0)
[14:12:44.644] Timer tick, asking Buildbucket for the build status
[14:12:44.758] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:44.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:11:0) after 1m0s
[14:13:44.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:11:0)
[14:13:44.847] Timer tick, asking Buildbucket for the build status
[14:13:44.962] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:44.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:12:0) after 1m0s
[14:14:45.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:12:0)
[14:14:45.126] Timer tick, asking Buildbucket for the build status
[14:14:45.210] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:45.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:13:0) after 1m0s
[14:15:45.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:13:0)
[14:15:45.241] Timer tick, asking Buildbucket for the build status
[14:15:45.728] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:45.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:14:0) after 1m0s
[14:16:45.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:14:0)
[14:16:45.779] Timer tick, asking Buildbucket for the build status
[14:16:45.937] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:45.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:15:0) after 1m0s
[14:17:45.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:15:0)
[14:17:45.990] Timer tick, asking Buildbucket for the build status
[14:17:46.093] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:46.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:16:0) after 1m0s
[14:18:46.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:16:0)
[14:18:46.131] Timer tick, asking Buildbucket for the build status
[14:18:46.282] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:46.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:17:0) after 1m0s
[14:19:46.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:17:0)
[14:19:46.311] Timer tick, asking Buildbucket for the build status
[14:19:46.970] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:46.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:18:0) after 1m0s
[14:20:47.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:18:0)
[14:20:47.033] Timer tick, asking Buildbucket for the build status
[14:20:47.291] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:47.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:19:0) after 1m0s
[14:21:47.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:19:0)
[14:21:47.301] Timer tick, asking Buildbucket for the build status
[14:21:47.391] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:47.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:20:0) after 1m0s
[14:22:47.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:20:0)
[14:22:47.439] Timer tick, asking Buildbucket for the build status
[14:22:47.518] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:47.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:21:0) after 1m0s
[14:23:47.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:21:0)
[14:23:47.694] Timer tick, asking Buildbucket for the build status
[14:23:47.829] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:47.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:22:0) after 1m0s
[14:24:48.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:22:0)
[14:24:48.047] Timer tick, asking Buildbucket for the build status
[14:24:48.139] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:23:0) after 1m0s
[14:25:48.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:23:0)
[14:25:48.307] Timer tick, asking Buildbucket for the build status
[14:25:48.597] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:48.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:24:0) after 1m0s
[14:26:48.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:24:0)
[14:26:48.637] Timer tick, asking Buildbucket for the build status
[14:26:48.731] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:48.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:25:0) after 1m0s
[14:27:48.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:25:0)
[14:27:48.807] Timer tick, asking Buildbucket for the build status
[14:27:48.931] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:48.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:26:0) after 1m0s
[14:28:49.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:26:0)
[14:28:49.120] Timer tick, asking Buildbucket for the build status
[14:28:49.274] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:49.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:27:0) after 1m0s
[14:29:49.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:27:0)
[14:29:49.301] Timer tick, asking Buildbucket for the build status
[14:29:49.383] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:49.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:28:0) after 1m0s
[14:30:49.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:28:0)
[14:30:49.493] Timer tick, asking Buildbucket for the build status
[14:30:49.654] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:49.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:29:0) after 1m0s
[14:31:49.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:29:0)
[14:31:49.801] Timer tick, asking Buildbucket for the build status
[14:31:49.982] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:49.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:30:0) after 1m0s
[14:32:50.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:30:0)
[14:32:50.020] Timer tick, asking Buildbucket for the build status
[14:32:50.115] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:50.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:31:0) after 1m0s
[14:33:50.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:31:0)
[14:33:50.275] Timer tick, asking Buildbucket for the build status
[14:33:50.345] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:50.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:32:0) after 1m0s
[14:34:50.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:32:0)
[14:34:50.404] Timer tick, asking Buildbucket for the build status
[14:34:50.464] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:50.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:33:0) after 1m0s
[14:35:50.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:33:0)
[14:35:50.575] Timer tick, asking Buildbucket for the build status
[14:35:50.824] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:50.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:34:0) after 1m0s
[14:36:50.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:34:0)
[14:36:50.918] Timer tick, asking Buildbucket for the build status
[14:36:51.325] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:51.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:35:0) after 1m0s
[14:37:51.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:35:0)
[14:37:51.371] Timer tick, asking Buildbucket for the build status
[14:37:51.453] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:51.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:36:0) after 1m0s
[14:38:51.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:36:0)
[14:38:51.477] Timer tick, asking Buildbucket for the build status
[14:38:51.543] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:51.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:37:0) after 1m0s
[14:39:51.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:37:0)
[14:39:51.568] Timer tick, asking Buildbucket for the build status
[14:39:51.693] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:51.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:38:0) after 1m0s
[14:40:51.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:38:0)
[14:40:51.776] Timer tick, asking Buildbucket for the build status
[14:40:52.097] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:52.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:39:0) after 1m0s
[14:41:52.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:39:0)
[14:41:52.096] Timer tick, asking Buildbucket for the build status
[14:41:52.194] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:52.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:40:0) after 1m0s
[14:42:52.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:40:0)
[14:42:52.232] Timer tick, asking Buildbucket for the build status
[14:42:52.555] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:52.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:41:0) after 1m0s
[14:43:52.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:41:0)
[14:43:52.566] Timer tick, asking Buildbucket for the build status
[14:43:52.689] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:52.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:42:0) after 1m0s
[14:44:52.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:42:0)
[14:44:52.825] Timer tick, asking Buildbucket for the build status
[14:44:53.336] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:53.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:43:0) after 1m0s
[14:45:53.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:43:0)
[14:45:53.425] Timer tick, asking Buildbucket for the build status
[14:45:53.713] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:53.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:44:0) after 1m0s
[14:46:53.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:44:0)
[14:46:53.739] Timer tick, asking Buildbucket for the build status
[14:46:53.809] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:53.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:45:0) after 1m0s
[14:47:54.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:45:0)
[14:47:54.012] Timer tick, asking Buildbucket for the build status
[14:47:54.076] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:54.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:46:0) after 1m0s
[14:48:54.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:46:0)
[14:48:54.120] Timer tick, asking Buildbucket for the build status
[14:48:54.323] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:54.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:47:0) after 1m0s
[14:49:54.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:47:0)
[14:49:54.354] Timer tick, asking Buildbucket for the build status
[14:49:54.773] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:54.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:48:0) after 1m0s
[14:50:54.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:48:0)
[14:50:54.806] Timer tick, asking Buildbucket for the build status
[14:50:55.267] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:55.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:49:0) after 1m0s
[14:51:55.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:49:0)
[14:51:55.376] Timer tick, asking Buildbucket for the build status
[14:51:55.704] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:55.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:50:0) after 1m0s
[14:52:55.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:50:0)
[14:52:55.781] Timer tick, asking Buildbucket for the build status
[14:52:55.923] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:55.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:51:0) after 1m0s
[14:53:55.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:51:0)
[14:53:55.934] Timer tick, asking Buildbucket for the build status
[14:53:56.070] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:56.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:52:0) after 1m0s
[14:54:56.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:52:0)
[14:54:56.154] Timer tick, asking Buildbucket for the build status
[14:54:56.334] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:56.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:53:0) after 1m0s
[14:55:56.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:53:0)
[14:55:56.349] Timer tick, asking Buildbucket for the build status
[14:55:56.463] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:56.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:54:0) after 1m0s
[14:56:56.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:54:0)
[14:56:56.501] Timer tick, asking Buildbucket for the build status
[14:56:56.617] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:56.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:55:0) after 1m0s
[14:57:56.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:55:0)
[14:57:56.807] Timer tick, asking Buildbucket for the build status
[14:57:56.903] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:56.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:56:0) after 1m0s
[14:58:57.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:56:0)
[14:58:57.025] Timer tick, asking Buildbucket for the build status
[14:58:57.618] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:57.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:57:0) after 1m0s
[14:59:57.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:57:0)
[14:59:57.691] Timer tick, asking Buildbucket for the build status
[14:59:57.854] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:57.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:58:0) after 1m0s
[15:00:57.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:58:0)
[15:00:57.970] Timer tick, asking Buildbucket for the build status
[15:00:59.845] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:59.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:59:0) after 1m0s
[15:01:59.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:59:0)
[15:01:59.918] Timer tick, asking Buildbucket for the build status
[15:02:00.287] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:00.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:60:0) after 1m0s
[15:03:00.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:60:0)
[15:03:00.314] Timer tick, asking Buildbucket for the build status
[15:03:00.383] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:00.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:61:0) after 1m0s
[15:04:00.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:61:0)
[15:04:00.743] Timer tick, asking Buildbucket for the build status
[15:04:00.821] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:00.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:62:0) after 1m0s
[15:05:00.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:62:0)
[15:05:00.877] Timer tick, asking Buildbucket for the build status
[15:05:01.023] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:01.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:63:0) after 1m0s
[15:06:01.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:63:0)
[15:06:01.293] Timer tick, asking Buildbucket for the build status
[15:06:01.415] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:01.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:64:0) after 1m0s
[15:07:01.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:64:0)
[15:07:01.438] Timer tick, asking Buildbucket for the build status
[15:07:01.610] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:01.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:65:0) after 1m0s
[15:08:01.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:65:0)
[15:08:01.883] Timer tick, asking Buildbucket for the build status
[15:08:02.007] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:02.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:66:0) after 1m0s
[15:09:02.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:66:0)
[15:09:02.198] Timer tick, asking Buildbucket for the build status
[15:09:02.342] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:02.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:67:0) after 1m0s
[15:10:02.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:67:0)
[15:10:02.479] Timer tick, asking Buildbucket for the build status
[15:10:02.616] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:02.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:68:0) after 1m0s
[15:11:02.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:68:0)
[15:11:02.678] Timer tick, asking Buildbucket for the build status
[15:11:02.923] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:02.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:69:0) after 1m0s
[15:12:02.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:69:0)
[15:12:02.996] Timer tick, asking Buildbucket for the build status
[15:12:03.316] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:03.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:70:0) after 1m0s
[15:13:03.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:70:0)
[15:13:03.344] Timer tick, asking Buildbucket for the build status
[15:13:03.509] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:03.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:71:0) after 1m0s
[15:14:03.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:71:0)
[15:14:03.543] Timer tick, asking Buildbucket for the build status
[15:14:03.624] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:03.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:72:0) after 1m0s
[15:15:03.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:72:0)
[15:15:03.684] Timer tick, asking Buildbucket for the build status
[15:15:03.873] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:03.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:73:0) after 1m0s
[15:16:03.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:73:0)
[15:16:03.953] Timer tick, asking Buildbucket for the build status
[15:16:04.201] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:04.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:74:0) after 1m0s
[15:17:04.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:74:0)
[15:17:04.274] Timer tick, asking Buildbucket for the build status
[15:17:05.196] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:05.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:75:0) after 1m0s
[15:18:05.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:75:0)
[15:18:05.217] Timer tick, asking Buildbucket for the build status
[15:18:05.604] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:05.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:76:0) after 1m0s
[15:19:05.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:76:0)
[15:19:05.638] Timer tick, asking Buildbucket for the build status
[15:19:05.766] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:05.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:77:0) after 1m0s
[15:20:05.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:77:0)
[15:20:05.848] Timer tick, asking Buildbucket for the build status
[15:20:06.009] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:06.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:78:0) after 1m0s
[15:21:06.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:78:0)
[15:21:06.103] Timer tick, asking Buildbucket for the build status
[15:21:06.362] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:79:0) after 1m0s
[15:22:06.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:79:0)
[15:22:06.478] Timer tick, asking Buildbucket for the build status
[15:22:06.632] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:06.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:80:0) after 1m0s
[15:23:06.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:80:0)
[15:23:06.682] Timer tick, asking Buildbucket for the build status
[15:23:06.804] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:06.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:81:0) after 1m0s
[15:24:06.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:81:0)
[15:24:06.836] Timer tick, asking Buildbucket for the build status
[15:24:06.999] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:06.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:82:0) after 1m0s
[15:25:07.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:82:0)
[15:25:07.172] Timer tick, asking Buildbucket for the build status
[15:25:07.874] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:07.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:83:0) after 1m0s
[15:26:07.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:83:0)
[15:26:07.903] Timer tick, asking Buildbucket for the build status
[15:26:07.981] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:07.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:84:0) after 1m0s
[15:27:07.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:84:0)
[15:27:07.998] Timer tick, asking Buildbucket for the build status
[15:27:08.086] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:08.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:85:0) after 1m0s
[15:28:08.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:85:0)
[15:28:08.131] Timer tick, asking Buildbucket for the build status
[15:28:08.247] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:08.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:86:0) after 1m0s
[15:29:08.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:86:0)
[15:29:08.314] Timer tick, asking Buildbucket for the build status
[15:29:08.574] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:08.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:87:0) after 1m0s
[15:30:08.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:87:0)
[15:30:08.640] Timer tick, asking Buildbucket for the build status
[15:30:09.003] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:88:0) after 1m0s
[15:31:09.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:88:0)
[15:31:09.044] Timer tick, asking Buildbucket for the build status
[15:31:09.175] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:89:0) after 1m0s
[15:32:09.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:89:0)
[15:32:09.232] Timer tick, asking Buildbucket for the build status
[15:32:09.317] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:09.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:90:0) after 1m0s
[15:33:09.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:90:0)
[15:33:09.387] Timer tick, asking Buildbucket for the build status
[15:33:09.764] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:09.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:91:0) after 1m0s
[15:34:09.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:91:0)
[15:34:09.831] Timer tick, asking Buildbucket for the build status
[15:34:09.967] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:92:0) after 1m0s
[15:35:09.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:92:0)
[15:35:09.977] Timer tick, asking Buildbucket for the build status
[15:35:10.104] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:10.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:93:0) after 1m0s
[15:36:10.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:93:0)
[15:36:10.260] Timer tick, asking Buildbucket for the build status
[15:36:10.349] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:10.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:94:0) after 1m0s
[15:37:10.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:94:0)
[15:37:10.547] Timer tick, asking Buildbucket for the build status
[15:37:10.645] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:10.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:95:0) after 1m0s
[15:38:10.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:95:0)
[15:38:10.815] Timer tick, asking Buildbucket for the build status
[15:38:11.317] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:11.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:96:0) after 1m0s
[15:39:11.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:96:0)
[15:39:11.371] Timer tick, asking Buildbucket for the build status
[15:39:11.564] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:11.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:97:0) after 1m0s
[15:40:11.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:97:0)
[15:40:11.603] Timer tick, asking Buildbucket for the build status
[15:40:11.811] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:11.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:98:0) after 1m0s
[15:41:11.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:98:0)
[15:41:11.879] Timer tick, asking Buildbucket for the build status
[15:41:12.024] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:12.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:99:0) after 1m0s
[15:42:12.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:99:0)
[15:42:12.168] Timer tick, asking Buildbucket for the build status
[15:42:12.392] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:12.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:100:0) after 1m0s
[15:43:12.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:100:0)
[15:43:12.420] Timer tick, asking Buildbucket for the build status
[15:43:12.789] Build 8865098489477204112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030528551557570144:101:0) after 1m0s
[15:43:30.382] Received PubSub notification, asking Buildbucket for the build status
[15:43:30.488] Build 8865098489477204112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:43:30.488] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603986204806598",
"created_by": "project:chromium",
"created_ts": "1603980280381072",
"id": "8865098489477204112",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f309335571515a4ec8a9cf27caa8a3427c41f24\"}}",
"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\": \"3f309335571515a4ec8a9cf27caa8a3427c41f24\", \"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-70-a1u5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21060, \"got_angle_revision\": \"3591997b58bfb1aab16a2d3d071529275bb84b05\", \"got_dawn_revision\": \"a584311a6a73a2b8b21703874742128c6d92f549\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"3f309335571515a4ec8a9cf27caa8a3427c41f24\", \"got_revision_cp\": \"refs/heads/master@{#822145}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"2be25f08deafe1fb1eada032cd3b2aae3021f367\", \"got_v8_revision\": \"74cd21ef855b0602e4b70e049794699fe06b4f82\", \"got_v8_revision_cp\": \"refs/heads/8.8.206@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f309335571515a4ec8a9cf27caa8a3427c41f24\", \"swarm_hashes_refs/heads/master(at){#822145}_without_patch\": {\"absl_hardening_tests\": \"aa090caa2ae59b1de15cfd42f5e69c2cf8ddecd3\", \"accessibility_unittests\": \"92c63910ddacb38ddcf50bb7fcaee94a2655b22a\", \"angle_unittests\": \"4a3cb07a10123b6c40b166b5a73e27a6ed4274f7\", \"app_list_unittests\": \"1e9ee1f4ac39b88c20f0d4c2dd526eae51015e6a\", \"app_shell_unittests\": \"67cbfb303eff90b61348971cb546108466e97d87\", \"ash_unittests\": \"e20cebc63c97e5bb3da88dbdb27472de14ab58bc\", \"aura_unittests\": \"a095d325b4f66551cf76bef2f15589e2549ff36f\", \"base_unittests\": \"660eddd601523729209fe0e49ba3be8f8e34aa28\", \"base_util_unittests\": \"860a43dd66657786252bb6a0360fe03120240fba\", \"blink_common_unittests\": \"dd185ca2237f70f396c0d13304c6b2b423f442b2\", \"blink_fuzzer_unittests\": \"10baeb3592f0353b37a97ef9384053965b0bbccb\", \"blink_heap_unittests\": \"eaea00809761f67e914b77959640f1365ada76b1\", \"blink_platform_unittests\": \"c54c908f43481ccfda76def2d5b9cbd12901e769\", \"blink_unittests\": \"c2d22ad978714b495426c42e68f1e4d810e6ca67\", \"boringssl_crypto_tests\": \"907d41f59509e7ed23129d966e4787aa5e01d61c\", \"boringssl_ssl_tests\": \"a9bc28356ac74ec980c0f8d679e4926dc0985dea\", \"browser_tests\": \"e63628c9f9223bf0bf6e7e881a0dfe281493f3ac\", \"capture_unittests\": \"f3b50af1baae24048fb2e61e145e4e5c8fdbe02c\", \"cast_unittests\": \"c4703d90f134b6084b9acac2fc4d24416e49ccd2\", \"cc_unittests\": \"a48b9405c65a75ad8823e4bdc585d01b83759a03\", \"chrome_app_unittests\": \"ae2cb07029fbd5b5afd4ccdd9007e45a936795c7\", \"chromedriver_unittests\": \"f0af342af76d4f39bb0b39246dba98876b5bab42\", \"chromeos_components_unittests\": \"fe9667ce1c37a13c1c71f112229f6ba49acf7415\", \"chromeos_unittests\": \"295c4c41ca48dbedb8b9f8562220f80c5d49c52f\", \"components_browsertests\": \"00d20b11c4860dbfac0ed030776a0426b2706806\", \"components_unittests\": \"25f451b53bbb5b9d3659e790d0aa5139c4a63c76\", \"compositor_unittests\": \"d37692cdf0f320ffee90b31fc5df81882c37cc42\", \"content_browsertests\": \"4b3a9349e1ddbd750ef4c295bda38f31141e772f\", \"content_unittests\": \"b0f1bccad0827fea452e5bba6562a57fd8d07ddf\", \"crypto_unittests\": \"84f7ad9a0cc723ca527678db64a3323b93633a47\", \"dbus_unittests\": \"d903827a94ad487a56cb2ebeafa683fa9aa3e911\", \"device_unittests\": \"efdce46266ebc442aac4e84ba556e011418aa808\", \"display_unittests\": \"f2cea5a4dfde7a4e6ccc021b3bc18a8f62c09f9d\", \"events_unittests\": \"b098d8e90b700bb4cd614c887548d4753d360eed\", \"exo_unittests\": \"b64178d040368e9d5d6910a2d02081811bd130f5\", \"extensions_browsertests\": \"167552ba3bca8c120eb967e6dab8cef44af2c213\", \"extensions_unittests\": \"0825f90e7c87fdfd7db296057d16ed74112bffcf\", \"filesystem_service_unittests\": \"aba75c2dd4f99f07b31f2e0b7e64aeeecd3d9c00\", \"gcm_unit_tests\": \"98d2ced66c6f94eaac5a60b6fb8c3a83c5eb2612\", \"gfx_unittests\": \"49d6808c428efa265aebfacc19b5b2249294914e\", \"gin_unittests\": \"c808fab84f732968306ee216b70b7826394a64d1\", \"gl_unittests_ozone\": \"9b31afe087dcc22b7f1d2acd13eb0e215487df6d\", \"google_apis_unittests\": \"6521952ea782eaa12ef3dbbf7a5e32455f791128\", \"gpu_unittests\": \"ec18f4098c9d3edea6947c7507f12fe7954832f7\", \"gwp_asan_unittests\": \"d821971608a37e95f4bc0d06ff8a7caa9964dc7f\", \"interactive_ui_tests\": \"9362f39a8f0f1de320d611c256f6a26542c37d72\", \"ipc_tests\": \"20224436178a536afb63664b93e10f88eeb71c33\", \"jingle_unittests\": \"596ad0134d110bc8fd522f22f97697e0cac610c3\", \"keyboard_unittests\": \"a999e471f90b81ea7e72d1a491bc3243ecdf39b6\", \"latency_unittests\": \"ffe5a3a513882a900271bf8fd5398d7eab187f58\", \"libjingle_xmpp_unittests\": \"8a68c32186b327959181aaf0f17fcf641c3bc546\", \"liburlpattern_unittests\": \"9e83a3d599ef83959d046c0b16f0fef35c5c565e\", \"media_blink_unittests\": \"989897927cf17c9a9c1c757315789b90e376f54c\", \"media_unittests\": \"fc0888b07386f6befb941c3aabd92902db2838ce\", \"message_center_unittests\": \"d799b6277ed38f79758a2599c202a1273915df15\", \"midi_unittests\": \"a2a98a36f8b8f402ea745b5348fd9881f1e8b7a2\", \"mojo_core_unittests\": \"a2ca826a97841ae853225175d8fcad18f020f8a6\", \"mojo_unittests\": \"68d94402a3b365776c41de2d7b4374c816469924\", \"nacl_helper_nonsfi_unittests\": \"807b783e919f6374419a6bf04d874763caba0526\", \"nacl_loader_unittests\": \"a7eb4ce21aa8ec7e3b485cd3c62117d6652ee493\", \"native_theme_unittests\": \"040c521563ed93f52daff380b32c4bed4ecfef37\", \"net_unittests\": \"9b4787c8e12642b35a872ae89123ea2769b057bb\", \"ozone_gl_unittests\": \"2641614f57739ba3ea211efc52ce04169f828db6\", \"ozone_unittests\": \"3a3e39f8baab7034064f9b67344ac95d43ddb9c9\", \"ozone_x11_unittests\": \"e67f7afcbdd5b1780237dd4c6f8083219f4d0385\", \"pdf_unittests\": \"8ed6c1ed7e8f8e72699e18ab09beec7ad386c855\", \"perfetto_unittests\": \"c5d5808e7559990740c407fecc6e5853f7ab4317\", \"ppapi_unittests\": \"89a05f958631d160c8de2ab4ba96b2a3fd425343\", \"printing_unittests\": \"f063bf2e938c17a9ecc55688306404f389bb52c5\", \"remoting_unittests\": \"5bfe85550a403b05822b831d6833a136402491e8\", \"sandbox_linux_unittests\": \"654cd48ccf0f3155038af410043750c56dcbbd47\", \"service_manager_unittests\": \"bbe0ceec466b1ea25f95db5115a1ca057d435352\", \"services_unittests\": \"6e1bfc295d9e0bdc744853b6720e0ba3725b5cb0\", \"shell_dialogs_unittests\": \"d009a047598902a50b9e2b4b33d7d67ad887b796\", \"skia_unittests\": \"d39b41f188655b91d7963015ad2c78053a9c8473\", \"snapshot_unittests\": \"3548c8e4d9f292984e89e81760f7447192beb711\", \"sql_unittests\": \"ceb6ef6ab8c4138f45e1afc2b607294690d34a79\", \"storage_unittests\": \"27745a01a14541ffe7452b1286efd108820552cd\", \"sync_integration_tests\": \"5bfc7b50689daab96b3d9827e5c09b9043e2fb0e\", \"traffic_annotation_auditor_unittests\": \"9fc19bf05fd57ff74fcbcb5924520b7d501793af\", \"ui_base_unittests\": \"d459193dfdba51964842fba5f0d568e99ac971ed\", \"ui_chromeos_unittests\": \"73260307442e3f162627102b2ad6de6003bd3f6e\", \"ui_touch_selection_unittests\": \"c0785e12364390998f262b73c51c6eaa77243ff9\", \"unit_tests\": \"22bc96e95d51ac8b3fbeb76a059868d39ca07138\", \"url_unittests\": \"18f0808bfafe9f1d795c370872ca01613e65f117\", \"usage_time_limit_unittests\": \"f9d2251500f998735dc4e1187a66290477c603c0\", \"views_unittests\": \"0c0caafa895a3339a7900d86106ee76de2b451eb\", \"viz_unittests\": \"1fb994bae938d87bbb78c89dc7a2fb0ffc072f62\", \"wm_unittests\": \"c2658d234485d4961cdfa68ecc0a7c88cc12c5bc\", \"wtf_unittests\": \"c56dae833e8d61eb0feeca89f0c5d1ba68e7060a\", \"zlib_unittests\": \"c56f7b753d5eed4cf3926bc0b2075e0f1626a769\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_b944d05f04021c9e96cb2c0814a44822758db0ee628018e3c9fb8f4cebb05c9d_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_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-70-a1u5\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603980291552343",
"status": "COMPLETED",
"status_changed_ts": "1603986205594842",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21060",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f309335571515a4ec8a9cf27caa8a3427c41f24",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030528551557570144",
"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/8865098489477204112/+/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:4f8d7e72006c1a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603986205641056",
"url": "https://ci.chromium.org/b/8865098489477204112",
"utcnow_ts": "1603986210475200"
}
}
[15:43:30.488] Invocation finished in 1h38m51.473671824s with status SUCCEEDED