[02:11:58.119] New invocation is queued and will start shortly
[02:11:59.208] Starting the invocation (attempt 1)
[02:11:59.248] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:11:59.248] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:11:59.249] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029758016943241824",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029758016943241824",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master"
]
}
[02:12:01.038] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604715119347261",
"id": "8864327954974123712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604715119925108",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21189",
"builder:linux-chromeos-dbg",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029758016943241824",
"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/8864327954974123712/+/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": "1604715119925218",
"url": "https://ci.chromium.org/b/8864327954974123712",
"utcnow_ts": "1604715121027244"
}
}
[02:12:01.038] Task URL: https://ci.chromium.org/b/8864327954974123712
[02:12:01.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:2:0) after 1m0s
[02:13:01.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:2:0)
[02:13:01.106] Timer tick, asking Buildbucket for the build status
[02:13:01.269] Build 8864327954974123712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:01.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:3:0) after 1m0s
[02:14:01.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:3:0)
[02:14:01.286] Timer tick, asking Buildbucket for the build status
[02:14:01.374] Build 8864327954974123712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:01.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:4:0) after 1m0s
[02:14:17.604] Received PubSub notification, asking Buildbucket for the build status
[02:14:17.891] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:01.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:4:0)
[02:15:01.397] Timer tick, asking Buildbucket for the build status
[02:15:02.832] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:02.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:6:0) after 1m0s
[02:16:02.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:6:0)
[02:16:02.864] Timer tick, asking Buildbucket for the build status
[02:16:03.414] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:03.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:7:0) after 1m0s
[02:17:03.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:7:0)
[02:17:03.444] Timer tick, asking Buildbucket for the build status
[02:17:03.744] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:03.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:8:0) after 1m0s
[02:18:03.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:8:0)
[02:18:03.853] Timer tick, asking Buildbucket for the build status
[02:18:03.958] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:03.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:9:0) after 1m0s
[02:19:04.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:9:0)
[02:19:04.015] Timer tick, asking Buildbucket for the build status
[02:19:04.307] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:04.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:10:0) after 1m0s
[02:20:04.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:10:0)
[02:20:04.381] Timer tick, asking Buildbucket for the build status
[02:20:04.453] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:04.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:11:0) after 1m0s
[02:21:04.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:11:0)
[02:21:04.472] Timer tick, asking Buildbucket for the build status
[02:21:04.566] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:04.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:12:0) after 1m0s
[02:22:04.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:12:0)
[02:22:04.788] Timer tick, asking Buildbucket for the build status
[02:22:04.961] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:04.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:13:0) after 1m0s
[02:23:04.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:13:0)
[02:23:04.992] Timer tick, asking Buildbucket for the build status
[02:23:05.081] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:05.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:14:0) after 1m0s
[02:24:05.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:14:0)
[02:24:05.143] Timer tick, asking Buildbucket for the build status
[02:24:05.263] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:05.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:15:0) after 1m0s
[02:25:05.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:15:0)
[02:25:05.372] Timer tick, asking Buildbucket for the build status
[02:25:05.487] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:05.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:16:0) after 1m0s
[02:26:05.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:16:0)
[02:26:05.532] Timer tick, asking Buildbucket for the build status
[02:26:05.600] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:05.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:17:0) after 1m0s
[02:27:05.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:17:0)
[02:27:05.688] Timer tick, asking Buildbucket for the build status
[02:27:05.804] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:05.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:18:0) after 1m0s
[02:28:06.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:18:0)
[02:28:06.063] Timer tick, asking Buildbucket for the build status
[02:28:06.150] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:06.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:19:0) after 1m0s
[02:29:06.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:19:0)
[02:29:06.216] Timer tick, asking Buildbucket for the build status
[02:29:06.287] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:06.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:20:0) after 1m0s
[02:30:06.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:20:0)
[02:30:06.298] Timer tick, asking Buildbucket for the build status
[02:30:06.614] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:06.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:21:0) after 1m0s
[02:31:06.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:21:0)
[02:31:06.722] Timer tick, asking Buildbucket for the build status
[02:31:06.802] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:06.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:22:0) after 1m0s
[02:32:06.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:22:0)
[02:32:06.879] Timer tick, asking Buildbucket for the build status
[02:32:06.993] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:06.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:23:0) after 1m0s
[02:33:07.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:23:0)
[02:33:07.006] Timer tick, asking Buildbucket for the build status
[02:33:07.133] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:07.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:24:0) after 1m0s
[02:34:07.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:24:0)
[02:34:07.188] Timer tick, asking Buildbucket for the build status
[02:34:07.266] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:25:0) after 1m0s
[02:35:07.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:25:0)
[02:35:07.278] Timer tick, asking Buildbucket for the build status
[02:35:07.491] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:07.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:26:0) after 1m0s
[02:36:07.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:26:0)
[02:36:07.537] Timer tick, asking Buildbucket for the build status
[02:36:07.845] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:07.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:27:0) after 1m0s
[02:37:07.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:27:0)
[02:37:07.878] Timer tick, asking Buildbucket for the build status
[02:37:08.084] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:08.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:28:0) after 1m0s
[02:38:08.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:28:0)
[02:38:08.217] Timer tick, asking Buildbucket for the build status
[02:38:08.657] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:08.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:29:0) after 1m0s
[02:39:08.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:29:0)
[02:39:08.732] Timer tick, asking Buildbucket for the build status
[02:39:08.805] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:08.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:30:0) after 1m0s
[02:40:08.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:30:0)
[02:40:08.857] Timer tick, asking Buildbucket for the build status
[02:40:08.920] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:08.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:31:0) after 1m0s
[02:41:08.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:31:0)
[02:41:08.945] Timer tick, asking Buildbucket for the build status
[02:41:09.006] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:09.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:32:0) after 1m0s
[02:42:09.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:32:0)
[02:42:09.024] Timer tick, asking Buildbucket for the build status
[02:42:09.484] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:09.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:33:0) after 1m0s
[02:43:09.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:33:0)
[02:43:09.570] Timer tick, asking Buildbucket for the build status
[02:43:09.847] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:09.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:34:0) after 1m0s
[02:44:09.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:34:0)
[02:44:09.967] Timer tick, asking Buildbucket for the build status
[02:44:10.036] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:35:0) after 1m0s
[02:45:10.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:35:0)
[02:45:10.094] Timer tick, asking Buildbucket for the build status
[02:45:10.166] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:10.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:36:0) after 1m0s
[02:46:10.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:36:0)
[02:46:10.193] Timer tick, asking Buildbucket for the build status
[02:46:10.275] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:10.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:37:0) after 1m0s
[02:47:10.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:37:0)
[02:47:10.306] Timer tick, asking Buildbucket for the build status
[02:47:10.478] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:10.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:38:0) after 1m0s
[02:48:10.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:38:0)
[02:48:10.507] Timer tick, asking Buildbucket for the build status
[02:48:10.591] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:10.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:39:0) after 1m0s
[02:49:10.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:39:0)
[02:49:10.657] Timer tick, asking Buildbucket for the build status
[02:49:10.727] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:10.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:40:0) after 1m0s
[02:50:10.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:40:0)
[02:50:10.735] Timer tick, asking Buildbucket for the build status
[02:50:10.830] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:10.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:41:0) after 1m0s
[02:51:10.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:41:0)
[02:51:10.935] Timer tick, asking Buildbucket for the build status
[02:51:11.018] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:11.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:42:0) after 1m0s
[02:52:11.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:42:0)
[02:52:11.061] Timer tick, asking Buildbucket for the build status
[02:52:11.167] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:43:0) after 1m0s
[02:53:11.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:43:0)
[02:53:11.340] Timer tick, asking Buildbucket for the build status
[02:53:11.449] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:11.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:44:0) after 1m0s
[02:54:11.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:44:0)
[02:54:11.578] Timer tick, asking Buildbucket for the build status
[02:54:11.935] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:11.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:45:0) after 1m0s
[02:55:12.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:45:0)
[02:55:12.090] Timer tick, asking Buildbucket for the build status
[02:55:12.168] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:12.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:46:0) after 1m0s
[02:56:12.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:46:0)
[02:56:12.294] Timer tick, asking Buildbucket for the build status
[02:56:12.419] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:12.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:47:0) after 1m0s
[02:57:12.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:47:0)
[02:57:12.504] Timer tick, asking Buildbucket for the build status
[02:57:12.627] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:12.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:48:0) after 1m0s
[02:58:12.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:48:0)
[02:58:12.709] Timer tick, asking Buildbucket for the build status
[02:58:12.790] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:12.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:49:0) after 1m0s
[02:59:12.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:49:0)
[02:59:12.932] Timer tick, asking Buildbucket for the build status
[02:59:13.039] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:13.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:50:0) after 1m0s
[03:00:13.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:50:0)
[03:00:13.177] Timer tick, asking Buildbucket for the build status
[03:00:13.431] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:13.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:51:0) after 1m0s
[03:01:13.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:51:0)
[03:01:13.476] Timer tick, asking Buildbucket for the build status
[03:01:13.549] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:13.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:52:0) after 1m0s
[03:02:13.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:52:0)
[03:02:13.573] Timer tick, asking Buildbucket for the build status
[03:02:13.709] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:13.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:53:0) after 1m0s
[03:03:13.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:53:0)
[03:03:13.738] Timer tick, asking Buildbucket for the build status
[03:03:13.812] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:13.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:54:0) after 1m0s
[03:04:13.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:54:0)
[03:04:13.831] Timer tick, asking Buildbucket for the build status
[03:04:14.106] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:14.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:55:0) after 1m0s
[03:05:14.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:55:0)
[03:05:14.413] Timer tick, asking Buildbucket for the build status
[03:05:14.703] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:14.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:56:0) after 1m0s
[03:06:15.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:56:0)
[03:06:15.097] Timer tick, asking Buildbucket for the build status
[03:06:15.239] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:57:0) after 1m0s
[03:07:15.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:57:0)
[03:07:15.502] Timer tick, asking Buildbucket for the build status
[03:07:15.633] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:58:0) after 1m0s
[03:08:15.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:58:0)
[03:08:15.731] Timer tick, asking Buildbucket for the build status
[03:08:16.905] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:59:0) after 1m0s
[03:09:17.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:59:0)
[03:09:17.042] Timer tick, asking Buildbucket for the build status
[03:09:17.268] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:17.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:60:0) after 1m0s
[03:10:17.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:60:0)
[03:10:17.334] Timer tick, asking Buildbucket for the build status
[03:10:17.625] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:61:0) after 1m0s
[03:11:17.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:61:0)
[03:11:17.656] Timer tick, asking Buildbucket for the build status
[03:11:17.802] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:17.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:62:0) after 1m0s
[03:12:17.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:62:0)
[03:12:17.967] Timer tick, asking Buildbucket for the build status
[03:12:18.110] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:63:0) after 1m0s
[03:13:18.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:63:0)
[03:13:18.280] Timer tick, asking Buildbucket for the build status
[03:13:18.413] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:18.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:64:0) after 1m0s
[03:14:18.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:64:0)
[03:14:18.506] Timer tick, asking Buildbucket for the build status
[03:14:18.604] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:18.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:65:0) after 1m0s
[03:15:18.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:65:0)
[03:15:18.804] Timer tick, asking Buildbucket for the build status
[03:15:18.955] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:18.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:66:0) after 1m0s
[03:16:19.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:66:0)
[03:16:19.005] Timer tick, asking Buildbucket for the build status
[03:16:19.173] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:19.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:67:0) after 1m0s
[03:17:19.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:67:0)
[03:17:19.271] Timer tick, asking Buildbucket for the build status
[03:17:19.565] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:19.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:68:0) after 1m0s
[03:18:19.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:68:0)
[03:18:19.642] Timer tick, asking Buildbucket for the build status
[03:18:19.729] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:19.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:69:0) after 1m0s
[03:19:19.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:69:0)
[03:19:19.758] Timer tick, asking Buildbucket for the build status
[03:19:20.259] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:70:0) after 1m0s
[03:20:20.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:70:0)
[03:20:20.311] Timer tick, asking Buildbucket for the build status
[03:20:20.389] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:20.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:71:0) after 1m0s
[03:21:20.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:71:0)
[03:21:20.554] Timer tick, asking Buildbucket for the build status
[03:21:20.831] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:72:0) after 1m0s
[03:22:20.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:72:0)
[03:22:20.936] Timer tick, asking Buildbucket for the build status
[03:22:21.113] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:21.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:73:0) after 1m0s
[03:23:21.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:73:0)
[03:23:21.137] Timer tick, asking Buildbucket for the build status
[03:23:21.957] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:21.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:74:0) after 1m0s
[03:24:22.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:74:0)
[03:24:22.069] Timer tick, asking Buildbucket for the build status
[03:24:22.194] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:22.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:75:0) after 1m0s
[03:25:22.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:75:0)
[03:25:22.240] Timer tick, asking Buildbucket for the build status
[03:25:22.526] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:22.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:76:0) after 1m0s
[03:26:22.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:76:0)
[03:26:22.548] Timer tick, asking Buildbucket for the build status
[03:26:22.663] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:22.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:77:0) after 1m0s
[03:27:22.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:77:0)
[03:27:22.695] Timer tick, asking Buildbucket for the build status
[03:27:22.847] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:22.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:78:0) after 1m0s
[03:28:22.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:78:0)
[03:28:22.901] Timer tick, asking Buildbucket for the build status
[03:28:22.976] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:22.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:79:0) after 1m0s
[03:29:22.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:79:0)
[03:29:22.966] Timer tick, asking Buildbucket for the build status
[03:29:23.044] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:23.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:80:0) after 1m0s
[03:30:23.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:80:0)
[03:30:23.191] Timer tick, asking Buildbucket for the build status
[03:30:23.418] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:23.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:81:0) after 1m0s
[03:31:23.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:81:0)
[03:31:23.553] Timer tick, asking Buildbucket for the build status
[03:31:23.781] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:23.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:82:0) after 1m0s
[03:32:23.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:82:0)
[03:32:23.869] Timer tick, asking Buildbucket for the build status
[03:32:24.007] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:24.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:83:0) after 1m0s
[03:33:24.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:83:0)
[03:33:24.110] Timer tick, asking Buildbucket for the build status
[03:33:24.428] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:24.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:84:0) after 1m0s
[03:34:24.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:84:0)
[03:34:24.454] Timer tick, asking Buildbucket for the build status
[03:34:24.563] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:24.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:85:0) after 1m0s
[03:35:24.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:85:0)
[03:35:24.591] Timer tick, asking Buildbucket for the build status
[03:35:24.710] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:24.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:86:0) after 1m0s
[03:36:24.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:86:0)
[03:36:24.768] Timer tick, asking Buildbucket for the build status
[03:36:24.867] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:24.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:87:0) after 1m0s
[03:37:24.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:87:0)
[03:37:24.964] Timer tick, asking Buildbucket for the build status
[03:37:25.144] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:25.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:88:0) after 1m0s
[03:38:25.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:88:0)
[03:38:25.237] Timer tick, asking Buildbucket for the build status
[03:38:25.331] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:89:0) after 1m0s
[03:39:25.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:89:0)
[03:39:25.373] Timer tick, asking Buildbucket for the build status
[03:39:25.485] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:25.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:90:0) after 1m0s
[03:40:25.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:90:0)
[03:40:25.516] Timer tick, asking Buildbucket for the build status
[03:40:25.593] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:25.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:91:0) after 1m0s
[03:41:25.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:91:0)
[03:41:25.635] Timer tick, asking Buildbucket for the build status
[03:41:25.717] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:25.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:92:0) after 1m0s
[03:42:25.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:92:0)
[03:42:25.731] Timer tick, asking Buildbucket for the build status
[03:42:26.239] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:93:0) after 1m0s
[03:43:26.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:93:0)
[03:43:26.348] Timer tick, asking Buildbucket for the build status
[03:43:26.574] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:26.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:94:0) after 1m0s
[03:44:26.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:94:0)
[03:44:26.602] Timer tick, asking Buildbucket for the build status
[03:44:27.601] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:27.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:95:0) after 1m0s
[03:45:27.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:95:0)
[03:45:27.729] Timer tick, asking Buildbucket for the build status
[03:45:27.800] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:27.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:96:0) after 1m0s
[03:46:27.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:96:0)
[03:46:27.865] Timer tick, asking Buildbucket for the build status
[03:46:28.059] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:28.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:97:0) after 1m0s
[03:47:28.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:97:0)
[03:47:28.078] Timer tick, asking Buildbucket for the build status
[03:47:28.526] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:28.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:98:0) after 1m0s
[03:48:28.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:98:0)
[03:48:28.624] Timer tick, asking Buildbucket for the build status
[03:48:28.700] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:28.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:99:0) after 1m0s
[03:49:28.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:99:0)
[03:49:28.774] Timer tick, asking Buildbucket for the build status
[03:49:29.239] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:29.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:100:0) after 1m0s
[03:50:29.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:100:0)
[03:50:29.349] Timer tick, asking Buildbucket for the build status
[03:50:29.440] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:29.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:101:0) after 1m0s
[03:51:29.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:101:0)
[03:51:29.466] Timer tick, asking Buildbucket for the build status
[03:51:29.674] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:29.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:102:0) after 1m0s
[03:52:29.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:102:0)
[03:52:29.743] Timer tick, asking Buildbucket for the build status
[03:52:30.488] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:30.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:103:0) after 1m0s
[03:53:30.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:103:0)
[03:53:30.682] Timer tick, asking Buildbucket for the build status
[03:53:31.701] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:104:0) after 1m0s
[03:54:31.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:104:0)
[03:54:31.805] Timer tick, asking Buildbucket for the build status
[03:54:31.975] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:31.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:105:0) after 1m0s
[03:55:32.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:105:0)
[03:55:32.048] Timer tick, asking Buildbucket for the build status
[03:55:32.183] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:32.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:106:0) after 1m0s
[03:56:32.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:106:0)
[03:56:32.275] Timer tick, asking Buildbucket for the build status
[03:56:32.405] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:32.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:107:0) after 1m0s
[03:57:32.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:107:0)
[03:57:32.471] Timer tick, asking Buildbucket for the build status
[03:57:32.584] Build 8864327954974123712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:32.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029758016943241824:108:0) after 1m0s
[03:58:08.152] Received PubSub notification, asking Buildbucket for the build status
[03:58:08.263] Build 8864327954974123712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:58:08.263] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604721487009895",
"created_by": "project:chromium",
"created_ts": "1604715119347261",
"id": "8864327954974123712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\"}}",
"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\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"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-203-bxm2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21189, \"got_angle_revision\": \"a481bee281b16c9d16b1c7d2393a4e169514ac39\", \"got_dawn_revision\": \"56af9cbd3f3581fcb2a89d3b4a3b37b328cd00d4\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"got_revision_cp\": \"refs/heads/master@{#825152}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"a16002b5edb4e0ad297cb7835e984dc9d79fd417\", \"got_v8_revision_cp\": \"refs/heads/8.8.248@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"657b47a9eef04e784d0946d196e1a286d85774ab\", \"swarm_hashes_refs/heads/master(at){#825152}_without_patch\": {\"absl_hardening_tests\": \"156f8e804425d5ebad6ae4e4ad17a8d8d69368fd\", \"accessibility_unittests\": \"ba2f78d26f03a5bd1e15e7600b25aa07e763860f\", \"angle_unittests\": \"93ddb917bf9fffed4147891b1380ac201e3997a4\", \"app_list_unittests\": \"a3ed5c98c999925bd4c08ee7f0986c648b10d202\", \"app_shell_unittests\": \"28dbd78271d83192ab5879703f1283264ca801e8\", \"ash_unittests\": \"bf31d05ba636aa50c8a26237e83540e46eb525d8\", \"aura_unittests\": \"c416b5d05cc78a57d998541ea5ed7c0a17a41a55\", \"base_unittests\": \"4607b87bfb68dd08ca4a0b7ea237547e5f0e217f\", \"base_util_unittests\": \"8aab8352830b08fff8c860e2d5f56f3aadf1cd0d\", \"blink_common_unittests\": \"e52c06c3ce19441a858df945b0d9e914d465508a\", \"blink_fuzzer_unittests\": \"05898c193c235095aae35e02009977f969cc5da4\", \"blink_heap_unittests\": \"0dc1c970d8e66c38925fb4617ccefaeea3a76724\", \"blink_platform_unittests\": \"95a5be9cdae2bb2d0028168cd8cf621162ca6fde\", \"blink_unittests\": \"54e66f71935f10dbe23ad9ea53a95bc257b44800\", \"boringssl_crypto_tests\": \"6203ba9dc035e424cd0dd143fe280d818e3fba2c\", \"boringssl_ssl_tests\": \"cfa904026d133dcecf05808e0ffa15422a000f1a\", \"browser_tests\": \"3e9c543741d2b5657cc80d8aff7bc646a1f9b314\", \"capture_unittests\": \"280b5567ac098c10686a6e56d626d17fe81018a3\", \"cast_unittests\": \"2ded7d6c169e996e06b33f32d17ee44ac594d02b\", \"cc_unittests\": \"e69927269c8aaf80481c6f40952b03b19f9b3ac9\", \"chrome_app_unittests\": \"7137458543b89a7d23716ce9e463b3be8e7e4cb1\", \"chromedriver_unittests\": \"15a7a77e45f5147089ac390ee88adc4af622c485\", \"chromeos_components_unittests\": \"978cfb8b6802be567a6dd3c2d06352b35d4c823f\", \"chromeos_unittests\": \"93e070b164593203de630706b384e735fd2ce8fa\", \"components_browsertests\": \"91542f4fdd1859ff61715ad68a6ce75c4af7a8e0\", \"components_unittests\": \"c91e5879e45a35d09fba1023038fde4aaae1f008\", \"compositor_unittests\": \"9c8adc12234f0fac3d60c0abf42a146473db3fa4\", \"content_browsertests\": \"8cbb91bd8bb4e625ba40e7c323c349735bd38489\", \"content_unittests\": \"5261f208395b5a6d1c45446cb81f65e1bbdafadb\", \"crypto_unittests\": \"2035d9548e9e2044b7d5f07aedd5730a91e72486\", \"dbus_unittests\": \"d68d065ceccdb3c4eb3f346bb5d6c8e0c3bbfccc\", \"device_unittests\": \"480cb8a0bd9423ea73e26b71f3242eafec667952\", \"display_unittests\": \"02e0eee18bfb1e93d5db05d8b42b5d2fc3046a45\", \"events_unittests\": \"82614ab5b40ea5aa6da511118bd1116318cbd750\", \"exo_unittests\": \"3fa99ad78c96619d81c29f0a96bf9ff58426b3db\", \"extensions_browsertests\": \"c9c2aa0505eb5db3f6e3537f636e33f23bd2b7af\", \"extensions_unittests\": \"896cd1328d8e536c006c2cd187076c862647e688\", \"filesystem_service_unittests\": \"e6f1bdcfac7fdb187fc22b85e2ebc177766c696a\", \"gcm_unit_tests\": \"cfa79a8ccd51d6a7bdd2ce3846c268d9895247fb\", \"gfx_unittests\": \"1542a0c7beeef49f4dc08575c2047b07f639e6a5\", \"gin_unittests\": \"6f71591075b56120323d8290bf80b34ce6687cb3\", \"gl_unittests_ozone\": \"86ad6682a348b598edbbc6116fd34f3112749c8f\", \"google_apis_unittests\": \"87e7a4c31d4ca611095a38b21a6a760db8762b43\", \"gpu_unittests\": \"b810a36439a8508f2888fa99ed272c0a10f45d91\", \"gwp_asan_unittests\": \"a8f7a4e6ad0e7112a5dcf40bd3b9ba0aa894a261\", \"interactive_ui_tests\": \"dd482c74b7597696a6e8e6a4e24fdbd64cb778ee\", \"ipc_tests\": \"22ada099c219cc855ab8864eaf65d1e81907bbf1\", \"jingle_unittests\": \"aec04a7a79df527ad998b38fe69595583fe7a3d5\", \"keyboard_unittests\": \"6c9b3d9cb980526c0be7c821a6c572eccbd76a7b\", \"latency_unittests\": \"ebc6d29455f8d21a917b662a4ba1d79385764e6c\", \"libjingle_xmpp_unittests\": \"0748c7e9068ab2f42114799a122339b98502a0ed\", \"liburlpattern_unittests\": \"b9f02a97499911b8119cd63ae764549ca1acd6bc\", \"media_blink_unittests\": \"2b0f74775456c1d4ba48bded1cb9cd74ada5c13f\", \"media_unittests\": \"eae5919b2ed73210caa7e2eefe474c255e080e8b\", \"message_center_unittests\": \"658286baebcfe85fb9bff338f76713d5b3437254\", \"midi_unittests\": \"45ea6bdbe775e69135cddf2b0c8c9cdc8c90e401\", \"mojo_core_unittests\": \"bca6140b9a5c809b42f8660b4b8f410f37e9e8d7\", \"mojo_unittests\": \"281c59d9810ab6306ffe7dc105323d2ba8d47b69\", \"nacl_helper_nonsfi_unittests\": \"fbd972334a2be55ae68b01f15a317f803f306126\", \"nacl_loader_unittests\": \"21a02283476ee9ccb7158ecd148f4d0337c7cd92\", \"native_theme_unittests\": \"a4efd56b27cb246c23ae3b084de480e2e3517fe0\", \"net_unittests\": \"fba906c6a624ec0513c85a2739bf0256e3445c1c\", \"ozone_gl_unittests\": \"d36767e71d48c6e1e579a7b2159217f61c8fe2ed\", \"ozone_unittests\": \"21e7476c58eea02beff703d48ea660319f6984ad\", \"ozone_x11_unittests\": \"a86e800927caca22c7cb74deae446759f29cd35a\", \"pdf_unittests\": \"e5369303f2a70ca658c091402d520514ddd1704c\", \"perfetto_unittests\": \"b2388485e9196c246ed3ad54b497d298ee7b7c47\", \"ppapi_unittests\": \"a5096720ec4f7744e78e1b8ec839feac644f62d6\", \"printing_unittests\": \"60dc389d2505c6ce8be6412aff6e6a01041f4371\", \"remoting_unittests\": \"049e3cd7d99f92193cd01e51a61b410d216eae0a\", \"sandbox_linux_unittests\": \"ac18f8ac458883f0e4909a8e78f7eccd8be453ca\", \"service_manager_unittests\": \"716fbcee04d84e3d23fe5b4f8cb4e33eddf6be20\", \"services_unittests\": \"6a46457bebdbe3f7c08467a5e308d06c8ed24648\", \"shell_dialogs_unittests\": \"40b4eafae1aa373ffab9cf8f769339abe98a7a4e\", \"skia_unittests\": \"51cc03ccfbe8b6321aed593096f3a21c44447bd8\", \"snapshot_unittests\": \"7b0d9bb4b79bb3173ba9982a96a3cdcea2716a36\", \"sql_unittests\": \"a0522bfd0f457e43eca0cd3ae462587a46b2838b\", \"storage_unittests\": \"04d26b5e3688837bbe373cf3829ff02482b3f700\", \"sync_integration_tests\": \"695f808f3866711050418dc0fed17a49c400a91b\", \"traffic_annotation_auditor_unittests\": \"a7059d6475f8c1ba016275062583fb29b82146c0\", \"ui_base_unittests\": \"7fabcaeb17abb24d114117800bd48d6777fafe9a\", \"ui_chromeos_unittests\": \"cdb40f2f976652d6f31d440f9b776b9242403965\", \"ui_touch_selection_unittests\": \"719d6f43c813054e7012a943f0ac14bd64aa517a\", \"unit_tests\": \"18475a1aa12749e748ac3fd0f898bbf9d4fd6c58\", \"url_unittests\": \"20a7f281e63ee349d252f75d9bab494af6cf4317\", \"usage_time_limit_unittests\": \"bcea10e2d419c26aebb1487d31acbe6d850f8633\", \"views_unittests\": \"d3047f01991468de3ad9db46ab1cceb28f075f95\", \"viz_unittests\": \"3e918373c273d29b565d616b559bed7cc81f81cb\", \"wm_unittests\": \"93e185f83c06bd791916c24bd8247668bbdca5b6\", \"wtf_unittests\": \"2dc419002056d1066311bd349dc3f552c9e4ebc9\", \"zlib_unittests\": \"2c9a6c9e1920e5c9f68dfe6d05f8845862208c24\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_8bff6729eb7a20b41fa723231755491227dfae6025a6d103df6a00cfb6cc22b8_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_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-203-bxm2\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604715256700689",
"status": "COMPLETED",
"status_changed_ts": "1604721487449335",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21189",
"builder:linux-chromeos-dbg",
"buildset:commit/git/657b47a9eef04e784d0946d196e1a286d85774ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/657b47a9eef04e784d0946d196e1a286d85774ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029758016943241824",
"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/8864327954974123712/+/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:4fb94b12d2792810",
"user_agent:luci-scheduler"
],
"updated_ts": "1604721487461033",
"url": "https://ci.chromium.org/b/8864327954974123712",
"utcnow_ts": "1604721488248784"
}
}
[03:58:08.263] Invocation finished in 1h46m10.178276909s with status SUCCEEDED