[22:47:09.095] New invocation is queued and will start shortly
[22:47:10.261] Starting the invocation (attempt 1)
[22:47:10.373] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:47:10.374] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:47:10.374] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028864933239706384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"706526c7c82424f14e84ada3c3ec17e011827126\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028864933239706384",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/706526c7c82424f14e84ada3c3ec17e011827126",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/706526c7c82424f14e84ada3c3ec17e011827126",
"gitiles_ref:refs/heads/master"
]
}
[22:47:11.586] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605566830967415",
"id": "8863434870609860080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"706526c7c82424f14e84ada3c3ec17e011827126\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605566831410983",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21345",
"builder:linux-chromeos-dbg",
"buildset:commit/git/706526c7c82424f14e84ada3c3ec17e011827126",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/706526c7c82424f14e84ada3c3ec17e011827126",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028864933239706384",
"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/8863434870609860080/+/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": "1605566831411252",
"url": "https://ci.chromium.org/b/8863434870609860080",
"utcnow_ts": "1605566831564901"
}
}
[22:47:11.586] Task URL: https://ci.chromium.org/b/8863434870609860080
[22:47:11.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:2:0) after 1m0s
[22:47:30.675] Received PubSub notification, asking Buildbucket for the build status
[22:47:30.753] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:11.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:2:0)
[22:48:11.648] Timer tick, asking Buildbucket for the build status
[22:48:11.752] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:11.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:4:0) after 1m0s
[22:49:11.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:4:0)
[22:49:11.820] Timer tick, asking Buildbucket for the build status
[22:49:11.930] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:11.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:5:0) after 1m0s
[22:50:11.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:5:0)
[22:50:11.993] Timer tick, asking Buildbucket for the build status
[22:50:12.090] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:12.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:6:0) after 1m0s
[22:51:12.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:6:0)
[22:51:12.260] Timer tick, asking Buildbucket for the build status
[22:51:12.351] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:12.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:7:0) after 1m0s
[22:52:12.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:7:0)
[22:52:12.382] Timer tick, asking Buildbucket for the build status
[22:52:12.928] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:12.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:8:0) after 1m0s
[22:53:12.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:8:0)
[22:53:12.907] Timer tick, asking Buildbucket for the build status
[22:53:13.045] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:13.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:9:0) after 1m0s
[22:54:13.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:9:0)
[22:54:13.075] Timer tick, asking Buildbucket for the build status
[22:54:13.528] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:10:0) after 1m0s
[22:55:13.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:10:0)
[22:55:13.577] Timer tick, asking Buildbucket for the build status
[22:55:13.979] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:11:0) after 1m0s
[22:56:14.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:11:0)
[22:56:14.075] Timer tick, asking Buildbucket for the build status
[22:56:14.149] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:14.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:12:0) after 1m0s
[22:57:14.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:12:0)
[22:57:14.229] Timer tick, asking Buildbucket for the build status
[22:57:14.350] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:14.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:13:0) after 1m0s
[22:58:14.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:13:0)
[22:58:14.454] Timer tick, asking Buildbucket for the build status
[22:58:14.689] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:14.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:14:0) after 1m0s
[22:59:14.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:14:0)
[22:59:14.716] Timer tick, asking Buildbucket for the build status
[22:59:14.854] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:15:0) after 1m0s
[23:00:14.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:15:0)
[23:00:14.947] Timer tick, asking Buildbucket for the build status
[23:00:15.044] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:15.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:16:0) after 1m0s
[23:01:15.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:16:0)
[23:01:15.092] Timer tick, asking Buildbucket for the build status
[23:01:15.189] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:15.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:17:0) after 1m0s
[23:02:15.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:17:0)
[23:02:15.281] Timer tick, asking Buildbucket for the build status
[23:02:15.606] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:15.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:18:0) after 1m0s
[23:03:15.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:18:0)
[23:03:15.719] Timer tick, asking Buildbucket for the build status
[23:03:15.784] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:15.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:19:0) after 1m0s
[23:04:15.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:19:0)
[23:04:15.808] Timer tick, asking Buildbucket for the build status
[23:04:16.066] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:20:0) after 1m0s
[23:05:16.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:20:0)
[23:05:16.092] Timer tick, asking Buildbucket for the build status
[23:05:16.272] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:16.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:21:0) after 1m0s
[23:06:16.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:21:0)
[23:06:16.266] Timer tick, asking Buildbucket for the build status
[23:06:16.403] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:16.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:22:0) after 1m0s
[23:07:16.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:22:0)
[23:07:16.435] Timer tick, asking Buildbucket for the build status
[23:07:16.527] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:16.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:23:0) after 1m0s
[23:08:16.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:23:0)
[23:08:16.554] Timer tick, asking Buildbucket for the build status
[23:08:16.613] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:16.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:24:0) after 1m0s
[23:09:16.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:24:0)
[23:09:16.640] Timer tick, asking Buildbucket for the build status
[23:09:16.741] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:16.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:25:0) after 1m0s
[23:10:16.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:25:0)
[23:10:16.895] Timer tick, asking Buildbucket for the build status
[23:10:17.043] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:17.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:26:0) after 1m0s
[23:11:17.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:26:0)
[23:11:17.137] Timer tick, asking Buildbucket for the build status
[23:11:17.219] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:17.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:27:0) after 1m0s
[23:12:17.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:27:0)
[23:12:17.206] Timer tick, asking Buildbucket for the build status
[23:12:17.324] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:17.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:28:0) after 1m0s
[23:13:17.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:28:0)
[23:13:17.411] Timer tick, asking Buildbucket for the build status
[23:13:17.515] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:17.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:29:0) after 1m0s
[23:14:18.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:29:0)
[23:14:18.012] Timer tick, asking Buildbucket for the build status
[23:14:18.125] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:18.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:30:0) after 1m0s
[23:15:18.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:30:0)
[23:15:18.296] Timer tick, asking Buildbucket for the build status
[23:15:18.376] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:18.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:31:0) after 1m0s
[23:16:18.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:31:0)
[23:16:18.579] Timer tick, asking Buildbucket for the build status
[23:16:18.654] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:18.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:32:0) after 1m0s
[23:17:18.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:32:0)
[23:17:18.881] Timer tick, asking Buildbucket for the build status
[23:17:19.066] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:19.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:33:0) after 1m0s
[23:18:19.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:33:0)
[23:18:19.105] Timer tick, asking Buildbucket for the build status
[23:18:19.336] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:19.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:34:0) after 1m0s
[23:19:19.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:34:0)
[23:19:19.397] Timer tick, asking Buildbucket for the build status
[23:19:19.472] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:19.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:35:0) after 1m0s
[23:20:19.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:35:0)
[23:20:19.539] Timer tick, asking Buildbucket for the build status
[23:20:19.679] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:19.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:36:0) after 1m0s
[23:21:19.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:36:0)
[23:21:19.704] Timer tick, asking Buildbucket for the build status
[23:21:19.782] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:37:0) after 1m0s
[23:22:19.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:37:0)
[23:22:19.786] Timer tick, asking Buildbucket for the build status
[23:22:20.132] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:20.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:38:0) after 1m0s
[23:23:20.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:38:0)
[23:23:20.198] Timer tick, asking Buildbucket for the build status
[23:23:20.259] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:39:0) after 1m0s
[23:24:20.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:39:0)
[23:24:20.266] Timer tick, asking Buildbucket for the build status
[23:24:20.359] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:20.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:40:0) after 1m0s
[23:25:20.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:40:0)
[23:25:20.335] Timer tick, asking Buildbucket for the build status
[23:25:20.551] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:20.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:41:0) after 1m0s
[23:26:20.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:41:0)
[23:26:20.564] Timer tick, asking Buildbucket for the build status
[23:26:20.899] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:20.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:42:0) after 1m0s
[23:27:20.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:42:0)
[23:27:20.967] Timer tick, asking Buildbucket for the build status
[23:27:21.106] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:21.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:43:0) after 1m0s
[23:28:21.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:43:0)
[23:28:21.141] Timer tick, asking Buildbucket for the build status
[23:28:21.227] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:21.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:44:0) after 1m0s
[23:29:21.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:44:0)
[23:29:21.265] Timer tick, asking Buildbucket for the build status
[23:29:21.331] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:45:0) after 1m0s
[23:30:21.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:45:0)
[23:30:21.425] Timer tick, asking Buildbucket for the build status
[23:30:21.599] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:21.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:46:0) after 1m0s
[23:31:21.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:46:0)
[23:31:21.633] Timer tick, asking Buildbucket for the build status
[23:31:21.756] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:21.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:47:0) after 1m0s
[23:32:21.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:47:0)
[23:32:21.882] Timer tick, asking Buildbucket for the build status
[23:32:22.109] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:22.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:48:0) after 1m0s
[23:33:22.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:48:0)
[23:33:22.124] Timer tick, asking Buildbucket for the build status
[23:33:22.608] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:49:0) after 1m0s
[23:34:22.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:49:0)
[23:34:22.659] Timer tick, asking Buildbucket for the build status
[23:34:22.824] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:22.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:50:0) after 1m0s
[23:35:22.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:50:0)
[23:35:22.851] Timer tick, asking Buildbucket for the build status
[23:35:23.015] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:23.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:51:0) after 1m0s
[23:36:23.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:51:0)
[23:36:23.084] Timer tick, asking Buildbucket for the build status
[23:36:23.210] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:23.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:52:0) after 1m0s
[23:37:23.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:52:0)
[23:37:23.297] Timer tick, asking Buildbucket for the build status
[23:37:23.741] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:53:0) after 1m0s
[23:38:23.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:53:0)
[23:38:23.837] Timer tick, asking Buildbucket for the build status
[23:38:23.896] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:54:0) after 1m0s
[23:39:23.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:54:0)
[23:39:23.946] Timer tick, asking Buildbucket for the build status
[23:39:24.066] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:55:0) after 1m0s
[23:40:24.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:55:0)
[23:40:24.211] Timer tick, asking Buildbucket for the build status
[23:40:24.330] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:24.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:56:0) after 1m0s
[23:41:24.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:56:0)
[23:41:24.401] Timer tick, asking Buildbucket for the build status
[23:41:24.466] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:24.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:57:0) after 1m0s
[23:42:24.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:57:0)
[23:42:24.499] Timer tick, asking Buildbucket for the build status
[23:42:24.597] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:24.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:58:0) after 1m0s
[23:43:24.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:58:0)
[23:43:24.618] Timer tick, asking Buildbucket for the build status
[23:43:24.685] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:24.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:59:0) after 1m0s
[23:44:24.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:59:0)
[23:44:24.714] Timer tick, asking Buildbucket for the build status
[23:44:24.819] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:24.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:60:0) after 1m0s
[23:45:24.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:60:0)
[23:45:24.851] Timer tick, asking Buildbucket for the build status
[23:45:25.094] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:25.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:61:0) after 1m0s
[23:46:25.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:61:0)
[23:46:25.124] Timer tick, asking Buildbucket for the build status
[23:46:25.211] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:25.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:62:0) after 1m0s
[23:47:25.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:62:0)
[23:47:25.286] Timer tick, asking Buildbucket for the build status
[23:47:25.891] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:25.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:63:0) after 1m0s
[23:48:25.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:63:0)
[23:48:25.975] Timer tick, asking Buildbucket for the build status
[23:48:26.093] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:26.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:64:0) after 1m0s
[23:49:26.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:64:0)
[23:49:26.148] Timer tick, asking Buildbucket for the build status
[23:49:26.533] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:26.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:65:0) after 1m0s
[23:50:26.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:65:0)
[23:50:26.583] Timer tick, asking Buildbucket for the build status
[23:50:26.734] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:26.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:66:0) after 1m0s
[23:51:26.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:66:0)
[23:51:26.749] Timer tick, asking Buildbucket for the build status
[23:51:26.925] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:26.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:67:0) after 1m0s
[23:52:26.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:67:0)
[23:52:26.940] Timer tick, asking Buildbucket for the build status
[23:52:27.044] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:27.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:68:0) after 1m0s
[23:53:27.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:68:0)
[23:53:27.066] Timer tick, asking Buildbucket for the build status
[23:53:27.227] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:27.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:69:0) after 1m0s
[23:54:27.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:69:0)
[23:54:27.280] Timer tick, asking Buildbucket for the build status
[23:54:27.368] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:27.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:70:0) after 1m0s
[23:55:27.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:70:0)
[23:55:27.508] Timer tick, asking Buildbucket for the build status
[23:55:27.582] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:71:0) after 1m0s
[23:56:27.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:71:0)
[23:56:27.617] Timer tick, asking Buildbucket for the build status
[23:56:27.723] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:27.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:72:0) after 1m0s
[23:57:27.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:72:0)
[23:57:27.970] Timer tick, asking Buildbucket for the build status
[23:57:28.077] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:28.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:73:0) after 1m0s
[23:58:28.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:73:0)
[23:58:28.109] Timer tick, asking Buildbucket for the build status
[23:58:28.180] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:28.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:74:0) after 1m0s
[23:59:28.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:74:0)
[23:59:28.313] Timer tick, asking Buildbucket for the build status
[23:59:28.406] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:75:0) after 1m0s
[00:00:28.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:75:0)
[00:00:28.563] Timer tick, asking Buildbucket for the build status
[00:00:28.961] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:28.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:76:0) after 1m0s
[00:01:29.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:76:0)
[00:01:29.140] Timer tick, asking Buildbucket for the build status
[00:01:29.880] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:77:0) after 1m0s
[00:02:29.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:77:0)
[00:02:29.964] Timer tick, asking Buildbucket for the build status
[00:02:30.322] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:30.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:78:0) after 1m0s
[00:03:30.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:78:0)
[00:03:30.358] Timer tick, asking Buildbucket for the build status
[00:03:30.849] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:30.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:79:0) after 1m0s
[00:04:30.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:79:0)
[00:04:30.938] Timer tick, asking Buildbucket for the build status
[00:04:31.120] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:31.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:80:0) after 1m0s
[00:05:31.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:80:0)
[00:05:31.179] Timer tick, asking Buildbucket for the build status
[00:05:31.396] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:31.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:81:0) after 1m0s
[00:06:31.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:81:0)
[00:06:31.456] Timer tick, asking Buildbucket for the build status
[00:06:31.601] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:31.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:82:0) after 1m0s
[00:07:31.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:82:0)
[00:07:31.661] Timer tick, asking Buildbucket for the build status
[00:07:32.046] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:83:0) after 1m0s
[00:08:32.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:83:0)
[00:08:32.078] Timer tick, asking Buildbucket for the build status
[00:08:32.517] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:32.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:84:0) after 1m0s
[00:09:32.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:84:0)
[00:09:32.941] Timer tick, asking Buildbucket for the build status
[00:09:33.089] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:33.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:85:0) after 1m0s
[00:10:33.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:85:0)
[00:10:33.186] Timer tick, asking Buildbucket for the build status
[00:10:33.272] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:33.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:86:0) after 1m0s
[00:11:33.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:86:0)
[00:11:33.371] Timer tick, asking Buildbucket for the build status
[00:11:33.612] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:33.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:87:0) after 1m0s
[00:12:33.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:87:0)
[00:12:33.702] Timer tick, asking Buildbucket for the build status
[00:12:34.102] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:34.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:88:0) after 1m0s
[00:13:34.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:88:0)
[00:13:34.175] Timer tick, asking Buildbucket for the build status
[00:13:34.358] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:34.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:89:0) after 1m0s
[00:14:34.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:89:0)
[00:14:34.472] Timer tick, asking Buildbucket for the build status
[00:14:34.561] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:34.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:90:0) after 1m0s
[00:15:34.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:90:0)
[00:15:34.644] Timer tick, asking Buildbucket for the build status
[00:15:35.027] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:35.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:91:0) after 1m0s
[00:16:35.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:91:0)
[00:16:35.071] Timer tick, asking Buildbucket for the build status
[00:16:35.152] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:35.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:92:0) after 1m0s
[00:17:35.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:92:0)
[00:17:35.214] Timer tick, asking Buildbucket for the build status
[00:17:35.405] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:35.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:93:0) after 1m0s
[00:18:35.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:93:0)
[00:18:35.424] Timer tick, asking Buildbucket for the build status
[00:18:35.496] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:35.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:94:0) after 1m0s
[00:19:35.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:94:0)
[00:19:35.596] Timer tick, asking Buildbucket for the build status
[00:19:35.804] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:35.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:95:0) after 1m0s
[00:20:35.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:95:0)
[00:20:35.863] Timer tick, asking Buildbucket for the build status
[00:20:35.957] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:35.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:96:0) after 1m0s
[00:21:35.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:96:0)
[00:21:35.962] Timer tick, asking Buildbucket for the build status
[00:21:36.315] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:36.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:97:0) after 1m0s
[00:22:36.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:97:0)
[00:22:36.421] Timer tick, asking Buildbucket for the build status
[00:22:36.554] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:36.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:98:0) after 1m0s
[00:23:36.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:98:0)
[00:23:36.552] Timer tick, asking Buildbucket for the build status
[00:23:36.627] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:99:0) after 1m0s
[00:24:36.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:99:0)
[00:24:36.673] Timer tick, asking Buildbucket for the build status
[00:24:37.022] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:37.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:100:0) after 1m0s
[00:25:37.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:100:0)
[00:25:37.095] Timer tick, asking Buildbucket for the build status
[00:25:37.187] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:37.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:101:0) after 1m0s
[00:26:37.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:101:0)
[00:26:37.285] Timer tick, asking Buildbucket for the build status
[00:26:37.410] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:37.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:102:0) after 1m0s
[00:27:37.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:102:0)
[00:27:37.489] Timer tick, asking Buildbucket for the build status
[00:27:37.632] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:37.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:103:0) after 1m0s
[00:28:37.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:103:0)
[00:28:37.699] Timer tick, asking Buildbucket for the build status
[00:28:37.778] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:104:0) after 1m0s
[00:29:37.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:104:0)
[00:29:37.784] Timer tick, asking Buildbucket for the build status
[00:29:37.872] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:37.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:105:0) after 1m0s
[00:30:37.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:105:0)
[00:30:37.913] Timer tick, asking Buildbucket for the build status
[00:30:37.993] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:37.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:106:0) after 1m0s
[00:31:38.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:106:0)
[00:31:38.372] Timer tick, asking Buildbucket for the build status
[00:31:38.472] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:38.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:107:0) after 1m0s
[00:32:38.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:107:0)
[00:32:38.525] Timer tick, asking Buildbucket for the build status
[00:32:38.649] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:38.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:108:0) after 1m0s
[00:33:38.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:108:0)
[00:33:38.746] Timer tick, asking Buildbucket for the build status
[00:33:38.838] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:38.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:109:0) after 1m0s
[00:34:38.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:109:0)
[00:34:38.916] Timer tick, asking Buildbucket for the build status
[00:34:38.998] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:38.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:110:0) after 1m0s
[00:35:39.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:110:0)
[00:35:39.187] Timer tick, asking Buildbucket for the build status
[00:35:39.871] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:39.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:111:0) after 1m0s
[00:36:39.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:111:0)
[00:36:39.995] Timer tick, asking Buildbucket for the build status
[00:36:40.158] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:40.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:112:0) after 1m0s
[00:37:40.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:112:0)
[00:37:40.322] Timer tick, asking Buildbucket for the build status
[00:37:40.516] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:113:0) after 1m0s
[00:38:40.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:113:0)
[00:38:40.608] Timer tick, asking Buildbucket for the build status
[00:38:41.244] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:41.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:114:0) after 1m0s
[00:39:41.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:114:0)
[00:39:41.347] Timer tick, asking Buildbucket for the build status
[00:39:41.613] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:41.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:115:0) after 1m0s
[00:40:41.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:115:0)
[00:40:41.672] Timer tick, asking Buildbucket for the build status
[00:40:41.743] Build 8863434870609860080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:41.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028864933239706384:116:0) after 1m0s
[00:41:25.209] Received PubSub notification, asking Buildbucket for the build status
[00:41:25.340] Build 8863434870609860080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:41:25.340] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605573684452907",
"created_by": "project:chromium",
"created_ts": "1605566830967415",
"id": "8863434870609860080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"706526c7c82424f14e84ada3c3ec17e011827126\"}}",
"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\": \"706526c7c82424f14e84ada3c3ec17e011827126\", \"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-179-dr25\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21345, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"dd6b36e8801ebeee53342c295fb56812504db80d\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"706526c7c82424f14e84ada3c3ec17e011827126\", \"got_revision_cp\": \"refs/heads/master@{#827948}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"3e551b3ce67ddeaf0a29516b4dc98375886daf51\", \"got_v8_revision\": \"e05d24f98144a68f3f5d84b1dc1a9a28a0c7c804\", \"got_v8_revision_cp\": \"refs/heads/8.9.2@{#1}\", \"got_webrtc_revision\": \"02736010cb171c3cc36ea2039911a6dadec9952d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32613}\", \"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\": \"706526c7c82424f14e84ada3c3ec17e011827126\", \"swarm_hashes_refs/heads/master(at){#827948}_without_patch\": {\"absl_hardening_tests\": \"430ed96a87532777021970406c322b9287a3b0d4\", \"accessibility_unittests\": \"a8c58152971e38816e28c1a0fb75e9002f8d5990\", \"angle_unittests\": \"62bdf0b6c26b7ae05f892c3e350ca3db6283ea88\", \"app_list_unittests\": \"b137595c366219a8cef81c22a4988fad7e70084f\", \"app_shell_unittests\": \"7fb0517e8fafa3d45c5cb882d1698f25a854848e\", \"ash_unittests\": \"0ccfc1951ec7c0583721f63cdaca53663cf99c56\", \"aura_unittests\": \"33c270a13b8012d4a02e6b54ff12fa0d0fdc6a2d\", \"base_unittests\": \"cb401d21881e9410e49e07dbc98521b752826e46\", \"base_util_unittests\": \"4fd761fb6787828a7cfaddbe0e883fd49abe320a\", \"blink_common_unittests\": \"2a09a2292c0e26f0aed6c2915ce0af73471ca3f3\", \"blink_fuzzer_unittests\": \"68f69309a45ebd8b5aa9936535c972a195b6f66e\", \"blink_heap_unittests\": \"79ed9b743df1b23577f1dd177ee25a2a0f40eed9\", \"blink_platform_unittests\": \"9b50c1206d88a52025c0753392d485ad20aa82f5\", \"blink_unittests\": \"085774a560d49ab44d152e7a8c0b9162f705c655\", \"boringssl_crypto_tests\": \"20cd4205bb1b9eaa3e842be132521225346c1421\", \"boringssl_ssl_tests\": \"4ae5d75cb311699789412263f9282b01e06cbbe6\", \"browser_tests\": \"e36753988618c8dcbb3cef767eb14782673178e5\", \"capture_unittests\": \"ec685ccfb97ce97c13981e6af457604fb4b25653\", \"cast_unittests\": \"e6944557d61d03115094568456a4fda3b53a9ccf\", \"cc_unittests\": \"9e23e396b4aa0f5354ea01d87044f487c23c0a9f\", \"chrome_app_unittests\": \"329d1e5dd2868b7498315aeb77df38ab098e2df1\", \"chromedriver_unittests\": \"52b083870430649c7c8ee928df533e5390cf501d\", \"chromeos_components_unittests\": \"d7043f18acb3bc90c01ab8a21f8bd301262e2081\", \"chromeos_unittests\": \"5fa1c21d9a2297fef11c600bb4bf4578d3b693f8\", \"components_browsertests\": \"e27299f8c434487dd25d187c2571f447c1f58597\", \"components_unittests\": \"b9a8d7470eefc050c3fc27b88615911b25d3beef\", \"compositor_unittests\": \"32ca8f844f4be5aa86e4859cf71161587b658a25\", \"content_browsertests\": \"622bf61b46ce152cb4e0898ef77925d205c1cba7\", \"content_unittests\": \"78c34cfaf8abd3667afeb93c410b216cdeb27385\", \"crashpad_tests\": \"6dced3f4095fbcbb7aeda016110c729382f77f1e\", \"crypto_unittests\": \"4b06244b9188affc4874fb3b9bc505daaab9ecab\", \"dbus_unittests\": \"aceb2cd6833a107637bb82801b4396fc4ac2d9c0\", \"device_unittests\": \"9453e03bc7ab53e33cb7530a691279366ce2c28e\", \"display_unittests\": \"e0439ac786ba2aefa4f6149581fca2cb6603ec61\", \"events_unittests\": \"9de01950836cbe5bba2f9aba73772844b389b2e1\", \"exo_unittests\": \"83349620a2529c94bd27e81f2eabd172828ece21\", \"extensions_browsertests\": \"ce5466c58c3c67f8121be8bc29c965623584f86b\", \"extensions_unittests\": \"7fd82f3900958596b7ebb110635923205fda5ac3\", \"filesystem_service_unittests\": \"facaf853781646c48c57f710618a8a8343bea845\", \"gcm_unit_tests\": \"0392a89da0ca9f17f5cb95c28e5be3b1d7e48d31\", \"gfx_unittests\": \"efde19fe22f8341cc9d8e974af01ed6fa78fc1a3\", \"gin_unittests\": \"ef04b31147dd08fc17a3c376e77007d4776a7709\", \"gl_unittests_ozone\": \"311da72244638b095b47a8cf1d6b175de6590959\", \"google_apis_unittests\": \"d04a2bac52b1956e007cde3fcff212916fe1e864\", \"gpu_unittests\": \"52f575525810523c3681beac5fff257cdef1fdc8\", \"gwp_asan_unittests\": \"6184dc9e36fb6274e6cdaadb4371bf9759fa6469\", \"interactive_ui_tests\": \"9873d97d017e35441f13378815fb35270b527289\", \"ipc_tests\": \"586657125d13520ad7ba23621050eb77b6e45daf\", \"jingle_unittests\": \"654c329fd933d16f64aa2fa7c9947de65f8b6590\", \"keyboard_unittests\": \"0eb32dde5975076fb83ff58a53e691c9309d3824\", \"latency_unittests\": \"2943760727d8bdc0c265c21f0df0270aeb488e46\", \"libjingle_xmpp_unittests\": \"de5a174838cd1a4e3ac275670e12ad3e716d65e4\", \"liburlpattern_unittests\": \"0f334b82ca043cc0d3e8b1746d0aba1b0c55274b\", \"media_blink_unittests\": \"91f4bce4f0ee0c811e7037bd2b2c0e7ec8ac9a8d\", \"media_unittests\": \"67138ddabdf5e9309ce4015f4931788fef17de42\", \"message_center_unittests\": \"ef84d02669b91cfc38d6c0888158303869dce095\", \"midi_unittests\": \"baf68fe8f3e6a7035350384112150ec6fe2d741b\", \"mojo_core_unittests\": \"560aea0b7ecbc606da50b03051fc8447955b3ad4\", \"mojo_unittests\": \"b28e4bf1655d765e6e6cd61e55d62f086d7e71c7\", \"nacl_helper_nonsfi_unittests\": \"4d0e3f95d4682f58401df5e25a4e9708ca697c75\", \"nacl_loader_unittests\": \"81b3888ded7890e12aa49dab4e0cf5d63838c6d5\", \"native_theme_unittests\": \"4c070f71904b54d5b604b4946cfd36bd33b60d9a\", \"net_unittests\": \"0a74e91e021fc4572914f66e1ec6e58e8b863cc7\", \"ozone_gl_unittests\": \"ba3e5ab7b5d9cbee9d389043a3e7df73ea68bdf6\", \"ozone_unittests\": \"1a46e7dcc92ea378b907339136632e5b8df3decd\", \"ozone_x11_unittests\": \"b7bcde36439276621c0c4e586f48e1209e8c579f\", \"pdf_unittests\": \"bdcdec1b243d8caf0e8eab5b41112ad00c77a787\", \"perfetto_unittests\": \"044cdc52de0ad2ace8388e621695cd60264c1b71\", \"ppapi_unittests\": \"7056e1d31298d89e391b0441a9d174dbbd52c981\", \"printing_unittests\": \"03dd255c956d752d2cb25b0aafc381049e553af8\", \"remoting_unittests\": \"79f445c6eb002d8865f53d21111f70f46eca7c4d\", \"sandbox_linux_unittests\": \"71d9611fd9ffb703a6c47c5afc0e4072630f1c26\", \"service_manager_unittests\": \"33a3bca85046217aab6aa52e4d7c874966e79203\", \"services_unittests\": \"2ad4828a13b517ab811c56de87b8b08eaad3d00d\", \"shell_dialogs_unittests\": \"b38665e80e345361f8acc123c4f47e7d731eae98\", \"skia_unittests\": \"2da0dc690a6510c61ad0e14d6d95cc7cdb4c3910\", \"snapshot_unittests\": \"c9d4d79a8a13ffa9e2d3611b9d5ff64c988fad27\", \"sql_unittests\": \"078baee43a6970ac9da445d8f964eb4ecc74b307\", \"storage_unittests\": \"ae4daaaf6cc7735b2c1939580b5b3ff31e043807\", \"sync_integration_tests\": \"1553b6eb030cde5ce5c52727f16834926e138371\", \"traffic_annotation_auditor_unittests\": \"d8f747f8d82370e829bd8863b6c9b7b0bbeed431\", \"ui_base_unittests\": \"630b047a11612b16bbe918069843b3cd7ea78195\", \"ui_chromeos_unittests\": \"b1b8038e328d7107e461f364e706a1da9688703f\", \"ui_touch_selection_unittests\": \"c764153490f15aae0949800259d64c89ed573e46\", \"unit_tests\": \"5967547081fb642eaaeb381405ffefa8e530f7a3\", \"url_unittests\": \"f0a1ad3e0992a0364c8690388a659be3dac03a76\", \"usage_time_limit_unittests\": \"4b10ec532a14d0b954b753509da097956317d617\", \"views_unittests\": \"537124558628d0a247bbb1359d129c1b549c9bdf\", \"viz_unittests\": \"f4e97fb3be94013a848e8375a3cae420ac49066a\", \"wm_unittests\": \"e07b2988eb58729b2515ae49004bc96bd9924793\", \"wtf_unittests\": \"e35f7ec0cc37473fc48792b2d300a9af40d6b279\", \"zlib_unittests\": \"812f46fe85e19b9b39a5c17a0bffdcac2b3d2d0e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0111b226b6a2e1a66cbbf5d93fde4367495bc99d98428795ba3e931083c57f27_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_73a5b2ce307b316a1240917eaad41a92e4adc44903c6789e05a5f10300306cda_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_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-179-dr25\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605566849372862",
"status": "COMPLETED",
"status_changed_ts": "1605573684847520",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21345",
"builder:linux-chromeos-dbg",
"buildset:commit/git/706526c7c82424f14e84ada3c3ec17e011827126",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/706526c7c82424f14e84ada3c3ec17e011827126",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028864933239706384",
"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/8863434870609860080/+/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:4fec0f27f22a1d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605573684852321",
"url": "https://ci.chromium.org/b/8863434870609860080",
"utcnow_ts": "1605573685324991"
}
}
[00:41:25.340] Invocation finished in 1h54m16.264550938s with status SUCCEEDED