[20:49:52.419] New invocation is queued and will start shortly
[20:49:53.650] Starting the invocation (attempt 1)
[20:49:53.688] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:49:53.689] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:49:53.689] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031409026794006992",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"de0413684218b683bfef6054031ab14035bf2d7c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031409026794006992",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/de0413684218b683bfef6054031ab14035bf2d7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de0413684218b683bfef6054031ab14035bf2d7c",
"gitiles_ref:refs/heads/master"
]
}
[20:49:54.392] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603140593772062",
"id": "8865978964702739424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"de0413684218b683bfef6054031ab14035bf2d7c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603140594160603",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20921",
"builder:linux-chromeos-dbg",
"buildset:commit/git/de0413684218b683bfef6054031ab14035bf2d7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de0413684218b683bfef6054031ab14035bf2d7c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031409026794006992",
"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/8865978964702739424/+/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": "1603140594160771",
"url": "https://ci.chromium.org/b/8865978964702739424",
"utcnow_ts": "1603140594382852"
}
}
[20:49:54.392] Task URL: https://ci.chromium.org/b/8865978964702739424
[20:49:54.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:2:0) after 1m0s
[20:49:57.211] Received PubSub notification, asking Buildbucket for the build status
[20:49:57.280] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:54.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:2:0)
[20:50:54.483] Timer tick, asking Buildbucket for the build status
[20:50:54.734] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:54.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:4:0) after 1m0s
[20:51:54.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:4:0)
[20:51:54.808] Timer tick, asking Buildbucket for the build status
[20:51:55.103] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:55.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:5:0) after 1m0s
[20:52:55.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:5:0)
[20:52:55.194] Timer tick, asking Buildbucket for the build status
[20:52:55.660] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:55.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:6:0) after 1m0s
[20:53:55.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:6:0)
[20:53:55.956] Timer tick, asking Buildbucket for the build status
[20:53:56.088] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:56.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:7:0) after 1m0s
[20:54:56.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:7:0)
[20:54:56.211] Timer tick, asking Buildbucket for the build status
[20:54:56.316] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:56.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:8:0) after 1m0s
[20:55:56.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:8:0)
[20:55:56.419] Timer tick, asking Buildbucket for the build status
[20:55:56.540] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:56.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:9:0) after 1m0s
[20:56:56.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:9:0)
[20:56:56.619] Timer tick, asking Buildbucket for the build status
[20:56:56.684] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:56.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:10:0) after 1m0s
[20:57:56.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:10:0)
[20:57:56.887] Timer tick, asking Buildbucket for the build status
[20:57:57.248] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:57.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:11:0) after 1m0s
[20:58:57.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:11:0)
[20:58:57.334] Timer tick, asking Buildbucket for the build status
[20:58:57.395] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:57.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:12:0) after 1m0s
[20:59:57.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:12:0)
[20:59:57.501] Timer tick, asking Buildbucket for the build status
[20:59:57.645] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:57.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:13:0) after 1m0s
[21:00:57.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:13:0)
[21:00:57.695] Timer tick, asking Buildbucket for the build status
[21:00:58.294] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:58.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:14:0) after 1m0s
[21:01:58.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:14:0)
[21:01:58.324] Timer tick, asking Buildbucket for the build status
[21:01:58.676] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:58.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:15:0) after 1m0s
[21:02:58.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:15:0)
[21:02:58.707] Timer tick, asking Buildbucket for the build status
[21:02:58.999] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:16:0) after 1m0s
[21:03:59.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:16:0)
[21:03:59.020] Timer tick, asking Buildbucket for the build status
[21:03:59.102] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:17:0) after 1m0s
[21:04:59.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:17:0)
[21:04:59.228] Timer tick, asking Buildbucket for the build status
[21:04:59.417] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:59.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:18:0) after 1m0s
[21:05:59.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:18:0)
[21:05:59.622] Timer tick, asking Buildbucket for the build status
[21:06:00.186] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:00.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:19:0) after 1m0s
[21:07:00.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:19:0)
[21:07:00.821] Timer tick, asking Buildbucket for the build status
[21:07:00.899] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:00.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:20:0) after 1m0s
[21:08:01.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:20:0)
[21:08:01.260] Timer tick, asking Buildbucket for the build status
[21:08:01.532] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:01.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:21:0) after 1m0s
[21:09:02.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:21:0)
[21:09:02.657] Timer tick, asking Buildbucket for the build status
[21:09:02.796] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:02.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:22:0) after 1m0s
[21:10:02.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:22:0)
[21:10:02.843] Timer tick, asking Buildbucket for the build status
[21:10:02.980] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:02.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:23:0) after 1m0s
[21:11:03.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:23:0)
[21:11:03.124] Timer tick, asking Buildbucket for the build status
[21:11:03.389] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:03.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:24:0) after 1m0s
[21:12:03.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:24:0)
[21:12:03.413] Timer tick, asking Buildbucket for the build status
[21:12:03.794] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:03.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:25:0) after 1m0s
[21:13:03.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:25:0)
[21:13:03.843] Timer tick, asking Buildbucket for the build status
[21:13:03.905] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:03.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:26:0) after 1m0s
[21:14:03.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:26:0)
[21:14:03.977] Timer tick, asking Buildbucket for the build status
[21:14:04.042] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:04.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:27:0) after 1m0s
[21:15:04.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:27:0)
[21:15:04.119] Timer tick, asking Buildbucket for the build status
[21:15:04.325] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:04.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:28:0) after 1m0s
[21:16:04.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:28:0)
[21:16:04.410] Timer tick, asking Buildbucket for the build status
[21:16:04.681] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:04.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:29:0) after 1m0s
[21:17:04.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:29:0)
[21:17:04.728] Timer tick, asking Buildbucket for the build status
[21:17:04.874] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:04.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:30:0) after 1m0s
[21:18:04.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:30:0)
[21:18:04.951] Timer tick, asking Buildbucket for the build status
[21:18:05.055] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:05.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:31:0) after 1m0s
[21:19:05.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:31:0)
[21:19:05.061] Timer tick, asking Buildbucket for the build status
[21:19:05.128] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:05.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:32:0) after 1m0s
[21:20:05.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:32:0)
[21:20:05.182] Timer tick, asking Buildbucket for the build status
[21:20:05.514] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:05.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:33:0) after 1m0s
[21:21:05.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:33:0)
[21:21:05.568] Timer tick, asking Buildbucket for the build status
[21:21:05.686] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:05.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:34:0) after 1m0s
[21:22:05.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:34:0)
[21:22:05.787] Timer tick, asking Buildbucket for the build status
[21:22:06.115] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:35:0) after 1m0s
[21:23:06.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:35:0)
[21:23:06.202] Timer tick, asking Buildbucket for the build status
[21:23:06.322] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:06.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:36:0) after 1m0s
[21:24:06.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:36:0)
[21:24:06.367] Timer tick, asking Buildbucket for the build status
[21:24:06.435] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:06.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:37:0) after 1m0s
[21:25:06.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:37:0)
[21:25:06.473] Timer tick, asking Buildbucket for the build status
[21:25:06.578] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:06.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:38:0) after 1m0s
[21:26:06.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:38:0)
[21:26:06.611] Timer tick, asking Buildbucket for the build status
[21:26:06.699] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:06.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:39:0) after 1m0s
[21:27:06.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:39:0)
[21:27:06.729] Timer tick, asking Buildbucket for the build status
[21:27:07.067] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:07.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:40:0) after 1m0s
[21:28:07.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:40:0)
[21:28:07.093] Timer tick, asking Buildbucket for the build status
[21:28:07.185] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:41:0) after 1m0s
[21:29:07.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:41:0)
[21:29:07.241] Timer tick, asking Buildbucket for the build status
[21:29:07.423] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:42:0) after 1m0s
[21:30:07.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:42:0)
[21:30:07.402] Timer tick, asking Buildbucket for the build status
[21:30:07.539] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:07.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:43:0) after 1m0s
[21:31:07.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:43:0)
[21:31:07.576] Timer tick, asking Buildbucket for the build status
[21:31:07.644] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:07.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:44:0) after 1m0s
[21:32:07.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:44:0)
[21:32:07.664] Timer tick, asking Buildbucket for the build status
[21:32:08.208] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:08.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:45:0) after 1m0s
[21:33:08.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:45:0)
[21:33:08.192] Timer tick, asking Buildbucket for the build status
[21:33:08.257] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:08.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:46:0) after 1m0s
[21:34:08.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:46:0)
[21:34:08.295] Timer tick, asking Buildbucket for the build status
[21:34:08.408] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:08.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:47:0) after 1m0s
[21:35:08.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:47:0)
[21:35:08.443] Timer tick, asking Buildbucket for the build status
[21:35:08.577] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:08.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:48:0) after 1m0s
[21:36:08.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:48:0)
[21:36:08.583] Timer tick, asking Buildbucket for the build status
[21:36:08.709] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:08.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:49:0) after 1m0s
[21:37:08.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:49:0)
[21:37:08.774] Timer tick, asking Buildbucket for the build status
[21:37:09.239] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:09.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:50:0) after 1m0s
[21:38:09.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:50:0)
[21:38:09.322] Timer tick, asking Buildbucket for the build status
[21:38:09.457] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:09.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:51:0) after 1m0s
[21:39:09.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:51:0)
[21:39:09.588] Timer tick, asking Buildbucket for the build status
[21:39:09.684] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:09.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:52:0) after 1m0s
[21:40:09.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:52:0)
[21:40:09.749] Timer tick, asking Buildbucket for the build status
[21:40:09.885] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:09.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:53:0) after 1m0s
[21:41:09.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:53:0)
[21:41:09.885] Timer tick, asking Buildbucket for the build status
[21:41:10.208] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:10.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:54:0) after 1m0s
[21:42:10.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:54:0)
[21:42:10.265] Timer tick, asking Buildbucket for the build status
[21:42:10.379] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:10.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:55:0) after 1m0s
[21:43:10.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:55:0)
[21:43:10.392] Timer tick, asking Buildbucket for the build status
[21:43:10.512] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:10.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:56:0) after 1m0s
[21:44:10.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:56:0)
[21:44:10.582] Timer tick, asking Buildbucket for the build status
[21:44:10.768] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:10.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:57:0) after 1m0s
[21:45:10.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:57:0)
[21:45:10.824] Timer tick, asking Buildbucket for the build status
[21:45:11.032] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:11.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:58:0) after 1m0s
[21:46:11.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:58:0)
[21:46:11.812] Timer tick, asking Buildbucket for the build status
[21:46:12.313] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:12.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:59:0) after 1m0s
[21:47:12.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:59:0)
[21:47:12.437] Timer tick, asking Buildbucket for the build status
[21:47:12.745] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:12.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:60:0) after 1m0s
[21:48:12.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:60:0)
[21:48:12.794] Timer tick, asking Buildbucket for the build status
[21:48:13.043] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:13.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:61:0) after 1m0s
[21:49:13.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:61:0)
[21:49:13.140] Timer tick, asking Buildbucket for the build status
[21:49:13.248] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:13.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:62:0) after 1m0s
[21:50:13.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:62:0)
[21:50:13.285] Timer tick, asking Buildbucket for the build status
[21:50:13.397] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:13.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:63:0) after 1m0s
[21:51:13.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:63:0)
[21:51:13.465] Timer tick, asking Buildbucket for the build status
[21:51:13.601] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:13.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:64:0) after 1m0s
[21:52:16.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:64:0)
[21:52:16.323] Timer tick, asking Buildbucket for the build status
[21:52:16.700] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:16.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:65:0) after 1m0s
[21:53:16.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:65:0)
[21:53:16.912] Timer tick, asking Buildbucket for the build status
[21:53:17.472] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:17.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:66:0) after 1m0s
[21:54:17.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:66:0)
[21:54:17.552] Timer tick, asking Buildbucket for the build status
[21:54:18.033] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:18.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:67:0) after 1m0s
[21:55:18.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:67:0)
[21:55:18.077] Timer tick, asking Buildbucket for the build status
[21:55:18.201] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:18.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:68:0) after 1m0s
[21:56:18.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:68:0)
[21:56:18.261] Timer tick, asking Buildbucket for the build status
[21:56:18.680] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:18.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:69:0) after 1m0s
[21:57:18.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:69:0)
[21:57:18.735] Timer tick, asking Buildbucket for the build status
[21:57:18.920] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:18.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:70:0) after 1m0s
[21:58:18.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:70:0)
[21:58:18.925] Timer tick, asking Buildbucket for the build status
[21:58:19.230] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:19.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:71:0) after 1m0s
[21:59:19.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:71:0)
[21:59:19.310] Timer tick, asking Buildbucket for the build status
[21:59:19.446] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:19.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:72:0) after 1m0s
[22:00:19.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:72:0)
[22:00:19.519] Timer tick, asking Buildbucket for the build status
[22:00:19.759] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:73:0) after 1m0s
[22:01:19.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:73:0)
[22:01:19.831] Timer tick, asking Buildbucket for the build status
[22:01:19.913] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:74:0) after 1m0s
[22:02:19.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:74:0)
[22:02:19.899] Timer tick, asking Buildbucket for the build status
[22:02:19.955] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:19.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:75:0) after 1m0s
[22:03:20.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:75:0)
[22:03:20.033] Timer tick, asking Buildbucket for the build status
[22:03:20.395] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:76:0) after 1m0s
[22:04:20.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:76:0)
[22:04:20.452] Timer tick, asking Buildbucket for the build status
[22:04:20.575] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:20.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:77:0) after 1m0s
[22:05:20.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:77:0)
[22:05:20.633] Timer tick, asking Buildbucket for the build status
[22:05:20.762] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:20.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:78:0) after 1m0s
[22:06:20.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:78:0)
[22:06:20.818] Timer tick, asking Buildbucket for the build status
[22:06:20.999] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:20.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:79:0) after 1m0s
[22:07:21.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:79:0)
[22:07:21.030] Timer tick, asking Buildbucket for the build status
[22:07:21.121] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:21.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:80:0) after 1m0s
[22:08:21.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:80:0)
[22:08:21.193] Timer tick, asking Buildbucket for the build status
[22:08:21.296] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:21.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:81:0) after 1m0s
[22:09:21.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:81:0)
[22:09:21.388] Timer tick, asking Buildbucket for the build status
[22:09:21.477] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:21.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:82:0) after 1m0s
[22:10:21.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:82:0)
[22:10:21.585] Timer tick, asking Buildbucket for the build status
[22:10:22.108] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:22.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:83:0) after 1m0s
[22:11:22.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:83:0)
[22:11:22.105] Timer tick, asking Buildbucket for the build status
[22:11:22.191] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:22.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:84:0) after 1m0s
[22:12:22.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:84:0)
[22:12:22.233] Timer tick, asking Buildbucket for the build status
[22:12:22.344] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:22.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:85:0) after 1m0s
[22:13:22.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:85:0)
[22:13:22.429] Timer tick, asking Buildbucket for the build status
[22:13:22.966] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:22.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:86:0) after 1m0s
[22:14:23.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:86:0)
[22:14:23.040] Timer tick, asking Buildbucket for the build status
[22:14:23.113] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:23.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:87:0) after 1m0s
[22:15:23.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:87:0)
[22:15:23.142] Timer tick, asking Buildbucket for the build status
[22:15:23.497] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:23.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:88:0) after 1m0s
[22:16:23.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:88:0)
[22:16:23.502] Timer tick, asking Buildbucket for the build status
[22:16:23.590] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:89:0) after 1m0s
[22:17:23.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:89:0)
[22:17:23.714] Timer tick, asking Buildbucket for the build status
[22:17:23.813] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:23.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:90:0) after 1m0s
[22:18:23.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:90:0)
[22:18:23.892] Timer tick, asking Buildbucket for the build status
[22:18:24.282] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:24.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:91:0) after 1m0s
[22:19:24.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:91:0)
[22:19:24.358] Timer tick, asking Buildbucket for the build status
[22:19:25.023] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:25.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:92:0) after 1m0s
[22:20:25.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:92:0)
[22:20:25.066] Timer tick, asking Buildbucket for the build status
[22:20:25.222] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:25.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:93:0) after 1m0s
[22:21:25.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:93:0)
[22:21:25.265] Timer tick, asking Buildbucket for the build status
[22:21:25.578] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:94:0) after 1m0s
[22:22:25.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:94:0)
[22:22:25.654] Timer tick, asking Buildbucket for the build status
[22:22:26.238] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:26.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:95:0) after 1m0s
[22:23:26.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:95:0)
[22:23:26.290] Timer tick, asking Buildbucket for the build status
[22:23:26.521] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:26.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:96:0) after 1m0s
[22:24:26.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:96:0)
[22:24:26.535] Timer tick, asking Buildbucket for the build status
[22:24:26.619] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:26.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:97:0) after 1m0s
[22:25:26.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:97:0)
[22:25:26.705] Timer tick, asking Buildbucket for the build status
[22:25:26.826] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:26.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:98:0) after 1m0s
[22:26:26.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:98:0)
[22:26:26.837] Timer tick, asking Buildbucket for the build status
[22:26:27.101] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:27.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:99:0) after 1m0s
[22:27:27.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:99:0)
[22:27:27.144] Timer tick, asking Buildbucket for the build status
[22:27:27.294] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:27.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:100:0) after 1m0s
[22:28:27.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:100:0)
[22:28:27.348] Timer tick, asking Buildbucket for the build status
[22:28:27.423] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:27.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:101:0) after 1m0s
[22:29:27.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:101:0)
[22:29:27.435] Timer tick, asking Buildbucket for the build status
[22:29:28.522] Build 8865978964702739424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:28.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031409026794006992:102:0) after 1m0s
[22:29:53.719] Received PubSub notification, asking Buildbucket for the build status
[22:29:54.209] Build 8865978964702739424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:29:54.209] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603146593163622",
"created_by": "project:chromium",
"created_ts": "1603140593772062",
"id": "8865978964702739424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"de0413684218b683bfef6054031ab14035bf2d7c\"}}",
"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\": \"de0413684218b683bfef6054031ab14035bf2d7c\", \"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-199-j9i5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20921, \"got_angle_revision\": \"6d3d381e725125d6adb0f4a571426e3cfc6ab5a5\", \"got_dawn_revision\": \"aff4c0366314c445dda2537a2f27c8c60ddf51da\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"de0413684218b683bfef6054031ab14035bf2d7c\", \"got_revision_cp\": \"refs/heads/master@{#818622}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"375e574dc6b0b5ccacbb4ab9bb5b48ca5531fdf7\", \"got_v8_revision_cp\": \"refs/heads/8.8.130@{#1}\", \"got_webrtc_revision\": \"d40c764ba81e24883b8c79ffa257c1eacab50fc7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32440}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"de0413684218b683bfef6054031ab14035bf2d7c\", \"swarm_hashes_refs/heads/master(at){#818622}_without_patch\": {\"absl_hardening_tests\": \"b9d42a7f50ca213a129e1ae5ee62cf39823e951d\", \"accessibility_unittests\": \"4e81f90f72650e0ba9e5e7092fbdba93354caa42\", \"app_list_unittests\": \"7f41b1c3e9aad03cef7b295c3e20eb4c25a9a762\", \"app_shell_unittests\": \"7fffcea0f1d351c811da15adc173a8890b4b6f5a\", \"ash_unittests\": \"37b1c07d09e8b2eb68c6649c0427cbc6774e4b5f\", \"aura_unittests\": \"afa7a4199db0b15eb54f2c658bfbb1df6a5dd053\", \"base_unittests\": \"43ade5d56dcfa6a292c982ac4b8f58f76f6e45e2\", \"base_util_unittests\": \"039b0244c2f354254bc1747dae99cd75503e9b41\", \"blink_common_unittests\": \"49d3bf43c22f524cc7c204a58face1933aa807e2\", \"blink_fuzzer_unittests\": \"624f8a3694affec49020d5bb6d81094459fe4dbe\", \"blink_heap_unittests\": \"20a8745f8f9348f84f83f28b37889bc7376f5351\", \"blink_platform_unittests\": \"510ed36810464731d24aa654d47ac1dffb63dbad\", \"blink_unittests\": \"7f7ee9b8b95cbb721fe97aaa11cae4dd28dfa393\", \"boringssl_crypto_tests\": \"72c947295e1760d465ad29fe17fc5acce7f5de6d\", \"boringssl_ssl_tests\": \"2afb434d85f6488e6a4dfec11e68ccbb124e6659\", \"browser_tests\": \"31592c985f6f05237b2245744c01180b16bf8449\", \"capture_unittests\": \"166d35e429edf2451194d242461bbb2d589f58cc\", \"cast_unittests\": \"db89d3ce2c628e50eea1d182aa16ec35fcd429ec\", \"cc_unittests\": \"06154e4d14f7c9d02c062ba8e7b223842f792217\", \"chrome_app_unittests\": \"42150c34775042e4ec98c061c59c469b883ecf15\", \"chromedriver_unittests\": \"a7bf4de05084b2b2a6148d693e58d76a3e2a9e34\", \"chromeos_components_unittests\": \"3c90d1d7ce0afaeab79d3f53186f6bf092d34237\", \"chromeos_unittests\": \"1ab0fc29de07b798b9d48925164b49d7b34b710d\", \"components_browsertests\": \"f687b377fe22572828a61f9a3d05d9425511dbff\", \"components_unittests\": \"62230e54da62d5e67e4f096d21a2cef397bc22b5\", \"compositor_unittests\": \"91190855fbd3b62ff31a2551edb2481d862a0f9a\", \"content_browsertests\": \"4e505cb2b070ae9b8562ac4a5e74c6f87e991d6a\", \"content_unittests\": \"8a82cb4616e7795aaf8db86128ac013299b4acbc\", \"crypto_unittests\": \"e72b0ef7d7aa428db673c699d41c962c52b24b2c\", \"dbus_unittests\": \"67b301f6a4016a5e83b9135db6ec417ebcc2a560\", \"device_unittests\": \"0a0e4e261b0cba3a3e9280d07060dbc7eaea1108\", \"display_unittests\": \"6befa01c94a46f63965f53c02a04484b68ab5982\", \"events_unittests\": \"938683b0fe56f7a6741de4b9aa7f03fa82012fc4\", \"exo_unittests\": \"cab029b4ce60198adfe36e66e29a3640d77cbcd2\", \"extensions_browsertests\": \"1189238b7ec018aaee5208f5913fbd1ce2bfb851\", \"extensions_unittests\": \"1d9b0f842b385cf2340aea2f922f1700e6c97329\", \"filesystem_service_unittests\": \"f912d9393a8361954e0f1b28fa94087ac8cdf355\", \"gcm_unit_tests\": \"5e3bbf36d6f94603e1b5455e78553beb004d8f03\", \"gfx_unittests\": \"a2b7bd6a0d9560192ddee16c54a1eff789196837\", \"gin_unittests\": \"1cb4302cdc28fb50ae0d6315dbd9d99ba5891742\", \"gl_unittests_ozone\": \"6b719c921289e9be4770bce04b5e3739109a9816\", \"google_apis_unittests\": \"c006374becc3ebdc902888e68ff9644f7d9ff9ee\", \"gpu_unittests\": \"7eab87a9c9a4017dd3c6f050ed7e62d5c61aa80b\", \"gwp_asan_unittests\": \"7745cbf1e6f8992157fb28d201e1edc84d59c022\", \"interactive_ui_tests\": \"2cbce84db2c2e3769af861cb6b5906907600d222\", \"ipc_tests\": \"961ac4d51702637e0c774ce50fef3a9691d25702\", \"jingle_unittests\": \"f5f65d1b927e41a1b7741ece0203385e26c2b323\", \"keyboard_unittests\": \"c13eea6b2af540f587f9c5ac59ef23be8a453227\", \"latency_unittests\": \"a92ce91f330de72c404b689baf19b0b4d5581a22\", \"libjingle_xmpp_unittests\": \"5d03c0fa40ed05199f12fa5c05f2f083e82fab84\", \"media_blink_unittests\": \"20452104e329a4b1b8a760fbfb919354d6c1ef86\", \"media_unittests\": \"bf389f2608e8ef8075e78ca2f13335f2fd0b8f98\", \"message_center_unittests\": \"340d12e32a4174e73e51f7281a8a59e22b361220\", \"midi_unittests\": \"0b608ab81b39829c323a5a4edf6fe7d891d79f98\", \"mojo_core_unittests\": \"56697f3419b39e67ca842d4a9da65b79b141ed36\", \"mojo_unittests\": \"ee45f24200a36d1d857bc879a8d8a95145b187d3\", \"nacl_helper_nonsfi_unittests\": \"c5ee438f41b438aeb5d84b6d9582e43d8c269007\", \"nacl_loader_unittests\": \"df0634b73ae442ddaa818270e8ad3a7798a72e18\", \"native_theme_unittests\": \"174bc249a77a4b0ae137e04a4f78dc386c535781\", \"net_unittests\": \"a660e61f4e0ac023abf37222d393caca4911583f\", \"ozone_gl_unittests\": \"e7ce03b4c184615bfb2456901cc1e295bd751cc3\", \"ozone_unittests\": \"1f587e7e8de5ae5f0e5243d83ccfe652d08e1602\", \"ozone_x11_unittests\": \"f90b2c9db13b7bb6ea8f43cca327edcf9f992d6f\", \"pdf_unittests\": \"364cb4391cf6b0fab1af3af474ecf10bccc6c7f7\", \"perfetto_unittests\": \"fa6fe475611e2ec3b832ccf7264b3457681c1997\", \"ppapi_unittests\": \"f282711407de1c15c217cc6201f08774d85d0b61\", \"printing_unittests\": \"15d91ee13691710ea0234873499acbb622129a72\", \"remoting_unittests\": \"bbf5be2b41d416f92407c4fb66c15e63f79e80c5\", \"sandbox_linux_unittests\": \"748fc81ca1504ca1409c0e57d819ea1f3f2b84c8\", \"service_manager_unittests\": \"b44aba64ee504274ca365541454bffaa495b156f\", \"services_unittests\": \"7b91c89bf28433ad26877b168705cb7fcb72864b\", \"shell_dialogs_unittests\": \"f62e5731eb06929a42f86ed964e729590d47d910\", \"skia_unittests\": \"2de60894469d12e31562b862b449de37aaa493f2\", \"snapshot_unittests\": \"4e6de19c516fe33dc017c10a9f274e1c715d0aa5\", \"sql_unittests\": \"5512a94b783c2ce610da7defcc7dc828e16ebfed\", \"standalone_angle_unittests\": \"a5bbe2fb9094c2a3bca1d60f11f97d5866ceee40\", \"storage_unittests\": \"5be00a5ea7f8f39023056af2be60c94be68113c5\", \"sync_integration_tests\": \"a3c9d20986747d8b14b19caa29bfc93857bb27dc\", \"traffic_annotation_auditor_unittests\": \"d228269df07ee7bc0429102e45f045bb2c1702bc\", \"ui_base_unittests\": \"efa92417a88fd6d10df9c2f1077dd8e706de27b7\", \"ui_chromeos_unittests\": \"bb7834316df1a62a622b986c0c3cfd58d2479c2e\", \"ui_touch_selection_unittests\": \"90a7c7ad3b667887c28eda959a84e93522835017\", \"unit_tests\": \"ca2eee8d3508afb72a06ac757526a46b20694453\", \"url_unittests\": \"8d8d33ad3a15215d3c6a1d07b269d7735e56d5dd\", \"usage_time_limit_unittests\": \"5fc02290381950801604b08e4176774da1f11a5a\", \"views_unittests\": \"15732fe5249e018320fa5d609ba337090e59ceb3\", \"viz_unittests\": \"96f791de79d9c6ad2ae772dd8cf39c0e0c845c60\", \"wm_unittests\": \"236d2076097a54c82c7fb5ef11c01f6794fb18ef\", \"wtf_unittests\": \"0724f46ea67d1b0af484a22f8117115581a9b244\", \"zlib_unittests\": \"14e57efdeb3fb76f202d5fbbb5ffcdd36c54365b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_e319b4acfa449663a77f14f67b133d07e86ee2e15654353d4f7662f0a9751b66_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-199-j9i5\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603140596325145",
"status": "COMPLETED",
"status_changed_ts": "1603146593445604",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20921",
"builder:linux-chromeos-dbg",
"buildset:commit/git/de0413684218b683bfef6054031ab14035bf2d7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de0413684218b683bfef6054031ab14035bf2d7c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031409026794006992",
"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/8865978964702739424/+/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:4f5b71b387c4c610",
"user_agent:luci-scheduler"
],
"updated_ts": "1603146593450400",
"url": "https://ci.chromium.org/b/8865978964702739424",
"utcnow_ts": "1603146594189785"
}
}
[22:29:54.209] Invocation finished in 1h40m1.814914394s with status SUCCEEDED