[09:07:06.424] New invocation is queued and will start shortly
[09:07:07.473] Starting the invocation (attempt 1)
[09:07:07.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:07:07.556] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:07:07.557] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031272047104640384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f88c5a4b31d4208796f511970c0736572295e7a5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031272047104640384",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f88c5a4b31d4208796f511970c0736572295e7a5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f88c5a4b31d4208796f511970c0736572295e7a5",
"gitiles_ref:refs/heads/master"
]
}
[09:07:08.255] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603271227676612",
"id": "8865841985126794688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f88c5a4b31d4208796f511970c0736572295e7a5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603271228134952",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20946",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f88c5a4b31d4208796f511970c0736572295e7a5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f88c5a4b31d4208796f511970c0736572295e7a5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031272047104640384",
"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/8865841985126794688/+/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": "1603271228135144",
"url": "https://ci.chromium.org/b/8865841985126794688",
"utcnow_ts": "1603271228248094"
}
}
[09:07:08.255] Task URL: https://ci.chromium.org/b/8865841985126794688
[09:07:08.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:2:0) after 1m0s
[09:08:08.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:2:0)
[09:08:08.342] Timer tick, asking Buildbucket for the build status
[09:08:08.444] Build 8865841985126794688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:08.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:3:0) after 1m0s
[09:09:08.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:3:0)
[09:09:08.596] Timer tick, asking Buildbucket for the build status
[09:09:08.678] Build 8865841985126794688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:08.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:4:0) after 1m0s
[09:09:28.569] Received PubSub notification, asking Buildbucket for the build status
[09:09:28.654] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:08.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:4:0)
[09:10:08.744] Timer tick, asking Buildbucket for the build status
[09:10:08.852] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:08.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:6:0) after 1m0s
[09:11:08.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:6:0)
[09:11:08.922] Timer tick, asking Buildbucket for the build status
[09:11:09.219] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:09.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:7:0) after 1m0s
[09:12:09.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:7:0)
[09:12:09.281] Timer tick, asking Buildbucket for the build status
[09:12:09.440] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:09.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:8:0) after 1m0s
[09:13:09.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:8:0)
[09:13:09.540] Timer tick, asking Buildbucket for the build status
[09:13:09.681] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:09.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:9:0) after 1m0s
[09:14:09.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:9:0)
[09:14:09.740] Timer tick, asking Buildbucket for the build status
[09:14:10.233] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:10.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:10:0) after 1m0s
[09:15:10.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:10:0)
[09:15:10.336] Timer tick, asking Buildbucket for the build status
[09:15:10.520] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:10.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:11:0) after 1m0s
[09:16:10.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:11:0)
[09:16:10.552] Timer tick, asking Buildbucket for the build status
[09:16:10.627] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:10.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:12:0) after 1m0s
[09:17:10.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:12:0)
[09:17:10.648] Timer tick, asking Buildbucket for the build status
[09:17:10.792] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:10.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:13:0) after 1m0s
[09:18:10.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:13:0)
[09:18:10.814] Timer tick, asking Buildbucket for the build status
[09:18:11.256] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:11.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:14:0) after 1m0s
[09:19:11.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:14:0)
[09:19:11.281] Timer tick, asking Buildbucket for the build status
[09:19:11.340] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:11.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:15:0) after 1m0s
[09:20:11.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:15:0)
[09:20:11.396] Timer tick, asking Buildbucket for the build status
[09:20:11.464] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:11.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:16:0) after 1m0s
[09:21:11.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:16:0)
[09:21:11.582] Timer tick, asking Buildbucket for the build status
[09:21:11.722] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:11.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:17:0) after 1m0s
[09:22:11.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:17:0)
[09:22:11.814] Timer tick, asking Buildbucket for the build status
[09:22:11.933] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:11.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:18:0) after 1m0s
[09:23:11.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:18:0)
[09:23:11.983] Timer tick, asking Buildbucket for the build status
[09:23:12.191] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:12.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:19:0) after 1m0s
[09:24:12.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:19:0)
[09:24:12.220] Timer tick, asking Buildbucket for the build status
[09:24:12.500] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:12.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:20:0) after 1m0s
[09:25:12.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:20:0)
[09:25:12.526] Timer tick, asking Buildbucket for the build status
[09:25:12.622] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:21:0) after 1m0s
[09:26:12.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:21:0)
[09:26:12.715] Timer tick, asking Buildbucket for the build status
[09:26:12.780] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:12.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:22:0) after 1m0s
[09:27:12.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:22:0)
[09:27:12.884] Timer tick, asking Buildbucket for the build status
[09:27:13.117] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:13.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:23:0) after 1m0s
[09:28:13.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:23:0)
[09:28:13.273] Timer tick, asking Buildbucket for the build status
[09:28:13.363] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:13.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:24:0) after 1m0s
[09:29:13.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:24:0)
[09:29:13.413] Timer tick, asking Buildbucket for the build status
[09:29:13.534] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:13.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:25:0) after 1m0s
[09:30:13.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:25:0)
[09:30:13.632] Timer tick, asking Buildbucket for the build status
[09:30:13.700] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:13.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:26:0) after 1m0s
[09:31:13.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:26:0)
[09:31:13.767] Timer tick, asking Buildbucket for the build status
[09:31:13.915] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:13.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:27:0) after 1m0s
[09:32:14.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:27:0)
[09:32:14.019] Timer tick, asking Buildbucket for the build status
[09:32:14.325] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:14.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:28:0) after 1m0s
[09:33:14.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:28:0)
[09:33:14.462] Timer tick, asking Buildbucket for the build status
[09:33:14.533] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:14.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:29:0) after 1m0s
[09:34:14.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:29:0)
[09:34:14.632] Timer tick, asking Buildbucket for the build status
[09:34:14.708] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:30:0) after 1m0s
[09:35:14.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:30:0)
[09:35:14.794] Timer tick, asking Buildbucket for the build status
[09:35:14.866] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:14.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:31:0) after 1m0s
[09:36:14.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:31:0)
[09:36:14.886] Timer tick, asking Buildbucket for the build status
[09:36:14.958] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:14.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:32:0) after 1m0s
[09:37:15.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:32:0)
[09:37:15.029] Timer tick, asking Buildbucket for the build status
[09:37:15.429] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:15.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:33:0) after 1m0s
[09:38:15.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:33:0)
[09:38:15.508] Timer tick, asking Buildbucket for the build status
[09:38:15.587] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:15.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:34:0) after 1m0s
[09:39:15.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:34:0)
[09:39:15.723] Timer tick, asking Buildbucket for the build status
[09:39:15.915] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:15.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:35:0) after 1m0s
[09:40:16.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:35:0)
[09:40:16.057] Timer tick, asking Buildbucket for the build status
[09:40:16.397] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:36:0) after 1m0s
[09:41:16.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:36:0)
[09:41:16.684] Timer tick, asking Buildbucket for the build status
[09:41:16.752] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:16.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:37:0) after 1m0s
[09:42:16.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:37:0)
[09:42:16.937] Timer tick, asking Buildbucket for the build status
[09:42:17.066] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:38:0) after 1m0s
[09:43:17.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:38:0)
[09:43:17.155] Timer tick, asking Buildbucket for the build status
[09:43:17.607] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:17.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:39:0) after 1m0s
[09:44:17.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:39:0)
[09:44:17.638] Timer tick, asking Buildbucket for the build status
[09:44:17.707] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:17.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:40:0) after 1m0s
[09:45:17.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:40:0)
[09:45:17.769] Timer tick, asking Buildbucket for the build status
[09:45:18.217] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:18.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:41:0) after 1m0s
[09:46:18.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:41:0)
[09:46:18.237] Timer tick, asking Buildbucket for the build status
[09:46:18.397] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:18.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:42:0) after 1m0s
[09:47:18.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:42:0)
[09:47:18.471] Timer tick, asking Buildbucket for the build status
[09:47:18.724] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:18.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:43:0) after 1m0s
[09:48:18.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:43:0)
[09:48:18.863] Timer tick, asking Buildbucket for the build status
[09:48:18.935] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:44:0) after 1m0s
[09:49:18.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:44:0)
[09:49:18.951] Timer tick, asking Buildbucket for the build status
[09:49:19.045] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:19.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:45:0) after 1m0s
[09:50:19.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:45:0)
[09:50:19.079] Timer tick, asking Buildbucket for the build status
[09:50:19.155] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:19.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:46:0) after 1m0s
[09:51:19.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:46:0)
[09:51:19.194] Timer tick, asking Buildbucket for the build status
[09:51:19.259] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:19.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:47:0) after 1m0s
[09:52:19.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:47:0)
[09:52:19.316] Timer tick, asking Buildbucket for the build status
[09:52:19.455] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:19.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:48:0) after 1m0s
[09:53:19.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:48:0)
[09:53:19.497] Timer tick, asking Buildbucket for the build status
[09:53:19.612] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:19.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:49:0) after 1m0s
[09:54:19.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:49:0)
[09:54:19.806] Timer tick, asking Buildbucket for the build status
[09:54:19.928] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:19.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:50:0) after 1m0s
[09:55:19.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:50:0)
[09:55:19.983] Timer tick, asking Buildbucket for the build status
[09:55:20.123] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:20.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:51:0) after 1m0s
[09:56:20.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:51:0)
[09:56:20.304] Timer tick, asking Buildbucket for the build status
[09:56:20.435] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:20.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:52:0) after 1m0s
[09:57:20.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:52:0)
[09:57:20.941] Timer tick, asking Buildbucket for the build status
[09:57:21.064] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:21.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:53:0) after 1m0s
[09:58:21.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:53:0)
[09:58:21.093] Timer tick, asking Buildbucket for the build status
[09:58:21.802] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:21.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:54:0) after 1m0s
[09:59:21.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:54:0)
[09:59:21.906] Timer tick, asking Buildbucket for the build status
[09:59:22.055] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:22.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:55:0) after 1m0s
[10:00:22.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:55:0)
[10:00:22.097] Timer tick, asking Buildbucket for the build status
[10:00:22.644] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:22.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:56:0) after 1m0s
[10:01:22.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:56:0)
[10:01:22.796] Timer tick, asking Buildbucket for the build status
[10:01:22.927] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:22.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:57:0) after 1m0s
[10:02:23.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:57:0)
[10:02:23.044] Timer tick, asking Buildbucket for the build status
[10:02:23.162] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:23.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:58:0) after 1m0s
[10:03:23.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:58:0)
[10:03:23.194] Timer tick, asking Buildbucket for the build status
[10:03:23.385] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:23.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:59:0) after 1m0s
[10:04:23.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:59:0)
[10:04:23.405] Timer tick, asking Buildbucket for the build status
[10:04:23.520] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:60:0) after 1m0s
[10:05:23.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:60:0)
[10:05:23.540] Timer tick, asking Buildbucket for the build status
[10:05:23.608] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:23.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:61:0) after 1m0s
[10:06:23.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:61:0)
[10:06:23.852] Timer tick, asking Buildbucket for the build status
[10:06:24.084] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:24.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:62:0) after 1m0s
[10:07:24.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:62:0)
[10:07:24.127] Timer tick, asking Buildbucket for the build status
[10:07:24.251] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:24.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:63:0) after 1m0s
[10:08:24.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:63:0)
[10:08:24.448] Timer tick, asking Buildbucket for the build status
[10:08:24.580] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:24.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:64:0) after 1m0s
[10:09:24.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:64:0)
[10:09:24.648] Timer tick, asking Buildbucket for the build status
[10:09:24.773] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:24.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:65:0) after 1m0s
[10:10:24.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:65:0)
[10:10:24.918] Timer tick, asking Buildbucket for the build status
[10:10:25.002] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:25.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:66:0) after 1m0s
[10:11:25.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:66:0)
[10:11:25.075] Timer tick, asking Buildbucket for the build status
[10:11:25.186] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:25.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:67:0) after 1m0s
[10:12:25.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:67:0)
[10:12:25.199] Timer tick, asking Buildbucket for the build status
[10:12:25.342] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:25.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:68:0) after 1m0s
[10:13:25.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:68:0)
[10:13:25.442] Timer tick, asking Buildbucket for the build status
[10:13:25.562] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:69:0) after 1m0s
[10:14:25.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:69:0)
[10:14:25.641] Timer tick, asking Buildbucket for the build status
[10:14:25.729] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:25.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:70:0) after 1m0s
[10:15:25.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:70:0)
[10:15:25.799] Timer tick, asking Buildbucket for the build status
[10:15:25.959] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:25.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:71:0) after 1m0s
[10:16:26.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:71:0)
[10:16:26.022] Timer tick, asking Buildbucket for the build status
[10:16:26.207] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:26.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:72:0) after 1m0s
[10:17:26.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:72:0)
[10:17:26.226] Timer tick, asking Buildbucket for the build status
[10:17:26.335] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:26.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:73:0) after 1m0s
[10:18:26.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:73:0)
[10:18:26.334] Timer tick, asking Buildbucket for the build status
[10:18:26.466] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:26.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:74:0) after 1m0s
[10:19:26.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:74:0)
[10:19:26.619] Timer tick, asking Buildbucket for the build status
[10:19:26.711] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:26.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:75:0) after 1m0s
[10:20:26.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:75:0)
[10:20:26.815] Timer tick, asking Buildbucket for the build status
[10:20:26.917] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:26.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:76:0) after 1m0s
[10:21:26.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:76:0)
[10:21:26.974] Timer tick, asking Buildbucket for the build status
[10:21:27.094] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:27.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:77:0) after 1m0s
[10:22:27.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:77:0)
[10:22:27.088] Timer tick, asking Buildbucket for the build status
[10:22:27.212] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:27.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:78:0) after 1m0s
[10:23:27.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:78:0)
[10:23:27.268] Timer tick, asking Buildbucket for the build status
[10:23:27.518] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:27.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:79:0) after 1m0s
[10:24:27.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:79:0)
[10:24:27.585] Timer tick, asking Buildbucket for the build status
[10:24:27.740] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:27.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:80:0) after 1m0s
[10:25:27.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:80:0)
[10:25:27.800] Timer tick, asking Buildbucket for the build status
[10:25:28.032] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:28.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:81:0) after 1m0s
[10:26:28.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:81:0)
[10:26:28.066] Timer tick, asking Buildbucket for the build status
[10:26:28.222] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:28.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:82:0) after 1m0s
[10:27:28.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:82:0)
[10:27:28.248] Timer tick, asking Buildbucket for the build status
[10:27:28.692] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:83:0) after 1m0s
[10:28:29.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:83:0)
[10:28:29.719] Timer tick, asking Buildbucket for the build status
[10:28:30.018] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:30.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:84:0) after 1m0s
[10:29:30.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:84:0)
[10:29:30.087] Timer tick, asking Buildbucket for the build status
[10:29:30.580] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:30.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:85:0) after 1m0s
[10:30:30.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:85:0)
[10:30:30.691] Timer tick, asking Buildbucket for the build status
[10:30:30.831] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:30.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:86:0) after 1m0s
[10:31:30.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:86:0)
[10:31:30.855] Timer tick, asking Buildbucket for the build status
[10:31:30.927] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:87:0) after 1m0s
[10:32:30.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:87:0)
[10:32:30.983] Timer tick, asking Buildbucket for the build status
[10:32:31.245] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:31.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:88:0) after 1m0s
[10:33:31.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:88:0)
[10:33:31.300] Timer tick, asking Buildbucket for the build status
[10:33:31.613] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:31.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:89:0) after 1m0s
[10:34:31.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:89:0)
[10:34:31.645] Timer tick, asking Buildbucket for the build status
[10:34:31.736] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:31.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:90:0) after 1m0s
[10:35:31.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:90:0)
[10:35:31.880] Timer tick, asking Buildbucket for the build status
[10:35:32.146] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:32.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:91:0) after 1m0s
[10:36:32.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:91:0)
[10:36:32.279] Timer tick, asking Buildbucket for the build status
[10:36:32.426] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:32.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:92:0) after 1m0s
[10:37:32.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:92:0)
[10:37:32.536] Timer tick, asking Buildbucket for the build status
[10:37:32.664] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:32.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:93:0) after 1m0s
[10:38:33.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:93:0)
[10:38:33.357] Timer tick, asking Buildbucket for the build status
[10:38:33.581] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:33.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:94:0) after 1m0s
[10:39:33.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:94:0)
[10:39:33.827] Timer tick, asking Buildbucket for the build status
[10:39:33.972] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:33.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:95:0) after 1m0s
[10:40:34.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:95:0)
[10:40:34.071] Timer tick, asking Buildbucket for the build status
[10:40:34.211] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:34.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:96:0) after 1m0s
[10:41:34.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:96:0)
[10:41:34.302] Timer tick, asking Buildbucket for the build status
[10:41:34.510] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:34.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:97:0) after 1m0s
[10:42:38.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:97:0)
[10:42:38.488] Timer tick, asking Buildbucket for the build status
[10:42:38.650] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:98:0) after 1m0s
[10:43:38.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:98:0)
[10:43:38.849] Timer tick, asking Buildbucket for the build status
[10:43:38.996] Build 8865841985126794688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031272047104640384:99:0) after 1m0s
[10:44:07.478] Received PubSub notification, asking Buildbucket for the build status
[10:44:07.554] Build 8865841985126794688: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:44:07.554] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603277046879643",
"created_by": "project:chromium",
"created_ts": "1603271227676612",
"failure_reason": "BUILD_FAILURE",
"id": "8865841985126794688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f88c5a4b31d4208796f511970c0736572295e7a5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}, \"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\": \"f88c5a4b31d4208796f511970c0736572295e7a5\", \"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-east1-d-8-17-tkzy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20946, \"got_angle_revision\": \"e2147a58a2339351b140d251751eb0c3f1804767\", \"got_dawn_revision\": \"cca03ca6bfe936cea2cda29e0c72fb0d0fde2850\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"f88c5a4b31d4208796f511970c0736572295e7a5\", \"got_revision_cp\": \"refs/heads/master@{#819293}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"84f5eeb6dd9b225f465f93737fa76aad7de355cf\", \"got_v8_revision\": \"d82ff002381657c44563e830ec337d103b99d565\", \"got_v8_revision_cp\": \"refs/heads/8.8.148@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f88c5a4b31d4208796f511970c0736572295e7a5\", \"swarm_hashes_refs/heads/master(at){#819293}_without_patch\": {\"absl_hardening_tests\": \"eda01ccbc20438fb31c9868d00fcb8558f492c22\", \"accessibility_unittests\": \"aead6d41fc423a4df28d7c5304cb04bde40943c6\", \"app_list_unittests\": \"71ff53d37ec792e028aa870f78e1ca4d89e2ee63\", \"app_shell_unittests\": \"385bc3f1ea7c41bc7999ba4f31f2ef81be7ef3c6\", \"ash_unittests\": \"caab046a33fe72a48e0e5fb81efffb96b7e0b180\", \"aura_unittests\": \"319d5d498748eac794b74c8388da37abc7ac9308\", \"base_unittests\": \"dd07f716fdf8267b0b98e667a39c4d21a78d1480\", \"base_util_unittests\": \"1378562c56e0366e06b8aaf56b84f4b9ca3adef3\", \"blink_common_unittests\": \"e3ad0a3ee4755044e2fa44cdd05ec81563770142\", \"blink_fuzzer_unittests\": \"0ad8a33d1e66fc0fd5824d98ff8f86cf760052ef\", \"blink_heap_unittests\": \"0eeaf87b898afa5cf9fca91f8dcb46dbc5ecf866\", \"blink_platform_unittests\": \"f562799c5175efcd0cd8039aaf40c526ef95680f\", \"blink_unittests\": \"6c20eb17dd3df80036aa3ea625ccd9a95231d64f\", \"boringssl_crypto_tests\": \"922b3159637718310b87a0dd9f7bc859f31d6b39\", \"boringssl_ssl_tests\": \"6c472c37c95a29ba3c7ecf02c1924298475423f6\", \"browser_tests\": \"6ff0b0777c74021f51af460a69646adfabf7a6db\", \"capture_unittests\": \"e2a2102a44ec193c3fe5a8d50363bd9c7b2580ff\", \"cast_unittests\": \"8b2b80e93cecce006193d1d3302bad3a15a34ce0\", \"cc_unittests\": \"d68f7b26a62240aeb275a00ae4dc4a2db188b726\", \"chrome_app_unittests\": \"bd5ee457eb0f0ea5db5f1f2463633b0d1fddb68c\", \"chromedriver_unittests\": \"42e22c311e98f950a091886624fe376643a7b988\", \"chromeos_components_unittests\": \"8aab75c1aa1ecea64f2e88268fdbd803e947bba9\", \"chromeos_unittests\": \"0f93971d69d7f1bc2a516b2df7a2aa492e577648\", \"components_browsertests\": \"39559a417f1c01187666ce7b195da4dce6844bd4\", \"components_unittests\": \"3be7c12359133634cec4546a9a22317e19826b7e\", \"compositor_unittests\": \"d1e9e397acace08dfb33ba0e8ca00a4a27fde919\", \"content_browsertests\": \"545926d2810d2784821c8eb3c93683d9d27cb5bb\", \"content_unittests\": \"110f6b6fda01c815b9fe749a782165a0374fabc1\", \"crypto_unittests\": \"412d7b25229f1db157897786f61162c7e25ab000\", \"dbus_unittests\": \"0535b1532dfb8897b312fe77442fb8771ea0b9e4\", \"device_unittests\": \"5a264fc7eefd1fecad759b4e5d79f42de431a466\", \"display_unittests\": \"5ba4ec51aa7ce102baad27867a8eb75c7025e8d7\", \"events_unittests\": \"55912863a9b4fee3116a61637bc03c5d2c46cead\", \"exo_unittests\": \"164bb624f0e5f7d99d525ec11698cfdedd113273\", \"extensions_browsertests\": \"d9aabeab852f76e8d2afc5c8d5c0e07795ff3d13\", \"extensions_unittests\": \"bbe383e8fa5e4152e0da5fad0873e17c2e45747c\", \"filesystem_service_unittests\": \"599cf075aa22953972931c6bb96fff62ca11768b\", \"gcm_unit_tests\": \"6ce7a7a74112ee715cda0acc38f651f8ffbf9437\", \"gfx_unittests\": \"b23306344d18d1a7e42041894242a468f158c399\", \"gin_unittests\": \"f014acde3580a4ebdb6951c36781217bbc687090\", \"gl_unittests_ozone\": \"b1f582d6c396ddb72b933fd6e458575b301bc09e\", \"google_apis_unittests\": \"01fbc18fe7b6cbad64cfaa583c7d694dd396d469\", \"gpu_unittests\": \"3fa0ad2c15439e6d06a892db5dae8cbc0a18bdbc\", \"gwp_asan_unittests\": \"46f4f94ae3c3ba0525f25992deb20738638b8255\", \"interactive_ui_tests\": \"8f1fd10073420e816a9d2985b0685ab824427bbc\", \"ipc_tests\": \"04ff8d4b63a4b3745ed347cb9d7a855cad5031d4\", \"jingle_unittests\": \"52a0e05f2b237c13271e536c475686f52a5eef2f\", \"keyboard_unittests\": \"ac62a704fef30ccb2b76522ee31ba80a0b53b39c\", \"latency_unittests\": \"8d28863313cb14896e29683c31304a696a76cbfc\", \"libjingle_xmpp_unittests\": \"df4719244736ff5bdaffbbe6cd7e5f3344296d6f\", \"media_blink_unittests\": \"2c95322c16fb098e184907a8cb68b4991ad6d247\", \"media_unittests\": \"56b4d7f1837a64b2398752c799c9e39ee1118941\", \"message_center_unittests\": \"913cfbf56e072f9412c14397776d7ef9dc2f9364\", \"midi_unittests\": \"d980e3d05f176e0b0e21811c41c6f132948017f9\", \"mojo_core_unittests\": \"e6f7d1c17a541a6a670cd9341d1276c851bc77a7\", \"mojo_unittests\": \"6a36d2bb1562fd958e78f7186e853971cf17cffd\", \"nacl_helper_nonsfi_unittests\": \"3a07145f6a2e975f1f98601a260415b44626645f\", \"nacl_loader_unittests\": \"1a8fc3df77393801a549faa840824d612c85ecb5\", \"native_theme_unittests\": \"8b4c471996c2aeb83721b178de6a996bfbe98db8\", \"net_unittests\": \"1958bb45b7604f1b71d3f040c61c307d8d846fa2\", \"ozone_gl_unittests\": \"3764309924cdc2537cda133654353fa1fa983f16\", \"ozone_unittests\": \"a08f4bbda97767524460c0f4425b556ae04dd314\", \"ozone_x11_unittests\": \"6f64a621d0eeaac750cc14e236f0f33220c5224c\", \"pdf_unittests\": \"1e942c4d1f69fdf464adfdf300aad42ba69ed67c\", \"perfetto_unittests\": \"fc0fcf33e75796c65992b42a6c7ca7b97fe94384\", \"ppapi_unittests\": \"35d5e85a879ca62f8439b431e8e22fd674e8bef2\", \"printing_unittests\": \"38a0e9514aa44474507b75af9fdd804c9192def6\", \"remoting_unittests\": \"a103611e16fb544ca8fc90a5eb2f03d64662c417\", \"sandbox_linux_unittests\": \"d0b8420f28975041f91d30cf20f095fc349b9e5f\", \"service_manager_unittests\": \"049d69e6d964e95fd403893a2fcb58f67d2555e5\", \"services_unittests\": \"c095fd843793470f079a406e36912aeb13315a3d\", \"shell_dialogs_unittests\": \"075e917e44f629d25dd89184ab847f6c959e1943\", \"skia_unittests\": \"96fafee48c439595613789aaea98f7a596c0d1be\", \"snapshot_unittests\": \"8ce3b9a9b8f6a3183e0c4ad39123be44d4847c34\", \"sql_unittests\": \"dad574b8e025d67cc4c42341a5062ff75f2ede90\", \"standalone_angle_unittests\": \"ba70fb5a925275109e9c29b79bb1af66283613f8\", \"storage_unittests\": \"5d7cddf64bbd3642124720c53de62ba2eba6bb35\", \"sync_integration_tests\": \"8a1aa5b785b1330b162fd16cc8f65a7d5b9e3c46\", \"traffic_annotation_auditor_unittests\": \"0ddafb1f3832a87172d7dd95c096bf32dfdb496f\", \"ui_base_unittests\": \"78a08b6dbec4ba7f0e120d13739960879081815a\", \"ui_chromeos_unittests\": \"f3d406f16120a9b6410c2a6daa64e138a37006c3\", \"ui_touch_selection_unittests\": \"393be0a72c3f5e36cb9cd423c70d3717677c3a33\", \"unit_tests\": \"d4cada1cfad512931f5b57ec2a40612921875a1b\", \"url_unittests\": \"eef573ffe8e7cd69db8789077bca21c06d4fe0b1\", \"usage_time_limit_unittests\": \"27c1750f169654eafa7a5619b3643d2279d9312b\", \"views_unittests\": \"ed0e2d10bee1799219b32a15ca03b16ca33bd1b9\", \"viz_unittests\": \"b52cb487a4e92b4f9dd98f327fb0a08eb4576cdd\", \"wm_unittests\": \"65772851f908269f07be1690de3cd0d2070879d8\", \"wtf_unittests\": \"cc077a39d367ce56cd059af2c96d44008d1c12b4\", \"zlib_unittests\": \"eff3f47e2b820acffd458bddd4e71c2b79ebab45\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06bf165a3bf7a25e93955b74ebaf013d13a4a87ad7bcb716437f8a47afa74d09_v2\", \"builder_3b2af173bd6c7c2422ea21f333ca7959a40b63aa844e8561bdce050550b2b6b9_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_9d393496fc50bd2ba7e16167b6377b317d5cb146b2dfdb60405146db5a374eac_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-east1-d-8-17-tkzy\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603271367811890",
"status": "COMPLETED",
"status_changed_ts": "1603271368268020",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20946",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f88c5a4b31d4208796f511970c0736572295e7a5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f88c5a4b31d4208796f511970c0736572295e7a5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031272047104640384",
"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/8865841985126794688/+/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:4f633b049962b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1603277047257275",
"url": "https://ci.chromium.org/b/8865841985126794688",
"utcnow_ts": "1603277047545484"
}
}
[10:44:07.554] Invocation finished in 1h37m1.147768303s with status FAILED