[01:37:00.991] New invocation is queued and will start shortly
[01:37:02.173] Starting the invocation (attempt 1)
[01:37:02.217] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:02.218] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:02.218] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020519325349188736",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020519325349188736",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"gitiles_ref:refs/heads/master"
]
}
[01:37:03.846] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613525822396163",
"id": "8855089263213626688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613525823488655",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22656",
"builder:linux-chromeos-dbg",
"buildset:commit/git/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020519325349188736",
"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/8855089263213626688/+/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": "1613525823488807",
"url": "https://ci.chromium.org/b/8855089263213626688",
"utcnow_ts": "1613525823817765"
}
}
[01:37:03.846] Task URL: https://ci.chromium.org/b/8855089263213626688
[01:37:03.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:2:0) after 1m0s
[01:37:05.779] Received PubSub notification, asking Buildbucket for the build status
[01:37:05.852] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:03.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:2:0)
[01:38:03.881] Timer tick, asking Buildbucket for the build status
[01:38:03.974] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:03.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:4:0) after 1m0s
[01:39:04.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:4:0)
[01:39:04.022] Timer tick, asking Buildbucket for the build status
[01:39:04.241] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:04.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:5:0) after 1m0s
[01:40:04.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:5:0)
[01:40:04.395] Timer tick, asking Buildbucket for the build status
[01:40:04.614] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:04.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:6:0) after 1m0s
[01:41:04.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:6:0)
[01:41:04.700] Timer tick, asking Buildbucket for the build status
[01:41:04.811] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:04.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:7:0) after 1m0s
[01:42:04.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:7:0)
[01:42:04.900] Timer tick, asking Buildbucket for the build status
[01:42:04.975] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:04.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:8:0) after 1m0s
[01:43:05.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:8:0)
[01:43:05.058] Timer tick, asking Buildbucket for the build status
[01:43:05.160] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:05.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:9:0) after 1m0s
[01:44:05.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:9:0)
[01:44:05.279] Timer tick, asking Buildbucket for the build status
[01:44:05.403] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:05.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:10:0) after 1m0s
[01:45:05.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:10:0)
[01:45:05.407] Timer tick, asking Buildbucket for the build status
[01:45:05.489] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:05.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:11:0) after 1m0s
[01:46:05.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:11:0)
[01:46:05.526] Timer tick, asking Buildbucket for the build status
[01:46:05.625] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:05.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:12:0) after 1m0s
[01:47:05.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:12:0)
[01:47:05.647] Timer tick, asking Buildbucket for the build status
[01:47:05.989] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:05.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:13:0) after 1m0s
[01:48:05.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:13:0)
[01:48:05.997] Timer tick, asking Buildbucket for the build status
[01:48:06.115] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:14:0) after 1m0s
[01:49:06.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:14:0)
[01:49:06.198] Timer tick, asking Buildbucket for the build status
[01:49:06.317] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:06.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:15:0) after 1m0s
[01:50:06.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:15:0)
[01:50:06.609] Timer tick, asking Buildbucket for the build status
[01:50:06.950] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:16:0) after 1m0s
[01:51:07.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:16:0)
[01:51:07.125] Timer tick, asking Buildbucket for the build status
[01:51:07.411] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:07.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:17:0) after 1m0s
[01:52:07.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:17:0)
[01:52:07.570] Timer tick, asking Buildbucket for the build status
[01:52:07.691] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:18:0) after 1m0s
[01:53:07.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:18:0)
[01:53:07.720] Timer tick, asking Buildbucket for the build status
[01:53:07.827] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:07.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:19:0) after 1m0s
[01:54:07.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:19:0)
[01:54:07.997] Timer tick, asking Buildbucket for the build status
[01:54:08.114] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:20:0) after 1m0s
[01:55:08.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:20:0)
[01:55:08.326] Timer tick, asking Buildbucket for the build status
[01:55:08.409] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:21:0) after 1m0s
[01:56:08.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:21:0)
[01:56:08.607] Timer tick, asking Buildbucket for the build status
[01:56:08.689] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:08.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:22:0) after 1m0s
[01:57:08.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:22:0)
[01:57:08.759] Timer tick, asking Buildbucket for the build status
[01:57:08.884] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:08.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:23:0) after 1m0s
[01:58:09.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:23:0)
[01:58:09.012] Timer tick, asking Buildbucket for the build status
[01:58:09.098] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:09.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:24:0) after 1m0s
[01:59:09.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:24:0)
[01:59:09.191] Timer tick, asking Buildbucket for the build status
[01:59:09.425] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:09.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:25:0) after 1m0s
[02:00:09.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:25:0)
[02:00:09.523] Timer tick, asking Buildbucket for the build status
[02:00:09.711] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:09.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:26:0) after 1m0s
[02:01:10.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:26:0)
[02:01:10.024] Timer tick, asking Buildbucket for the build status
[02:01:11.225] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:11.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:27:0) after 1m0s
[02:02:11.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:27:0)
[02:02:11.506] Timer tick, asking Buildbucket for the build status
[02:02:11.603] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:11.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:28:0) after 1m0s
[02:03:11.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:28:0)
[02:03:11.751] Timer tick, asking Buildbucket for the build status
[02:03:11.842] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:11.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:29:0) after 1m0s
[02:04:11.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:29:0)
[02:04:11.917] Timer tick, asking Buildbucket for the build status
[02:04:12.429] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:12.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:30:0) after 1m0s
[02:05:12.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:30:0)
[02:05:12.476] Timer tick, asking Buildbucket for the build status
[02:05:12.564] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:12.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:31:0) after 1m0s
[02:06:12.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:31:0)
[02:06:12.700] Timer tick, asking Buildbucket for the build status
[02:06:12.856] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:12.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:32:0) after 1m0s
[02:07:13.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:32:0)
[02:07:13.276] Timer tick, asking Buildbucket for the build status
[02:07:13.456] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:13.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:33:0) after 1m0s
[02:08:13.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:33:0)
[02:08:13.506] Timer tick, asking Buildbucket for the build status
[02:08:13.620] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:34:0) after 1m0s
[02:09:14.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:34:0)
[02:09:14.177] Timer tick, asking Buildbucket for the build status
[02:09:14.268] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:14.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:35:0) after 1m0s
[02:10:14.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:35:0)
[02:10:14.371] Timer tick, asking Buildbucket for the build status
[02:10:14.571] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:36:0) after 1m0s
[02:11:14.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:36:0)
[02:11:14.599] Timer tick, asking Buildbucket for the build status
[02:11:15.013] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:15.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:37:0) after 1m0s
[02:12:15.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:37:0)
[02:12:15.126] Timer tick, asking Buildbucket for the build status
[02:12:15.239] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:15.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:38:0) after 1m0s
[02:13:15.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:38:0)
[02:13:15.343] Timer tick, asking Buildbucket for the build status
[02:13:15.694] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:15.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:39:0) after 1m0s
[02:14:15.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:39:0)
[02:14:15.723] Timer tick, asking Buildbucket for the build status
[02:14:16.064] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:16.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:40:0) after 1m0s
[02:15:16.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:40:0)
[02:15:16.258] Timer tick, asking Buildbucket for the build status
[02:15:16.328] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:16.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:41:0) after 1m0s
[02:16:16.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:41:0)
[02:16:16.379] Timer tick, asking Buildbucket for the build status
[02:16:16.490] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:16.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:42:0) after 1m0s
[02:17:16.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:42:0)
[02:17:16.640] Timer tick, asking Buildbucket for the build status
[02:17:16.819] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:16.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:43:0) after 1m0s
[02:18:16.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:43:0)
[02:18:16.839] Timer tick, asking Buildbucket for the build status
[02:18:16.919] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:16.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:44:0) after 1m0s
[02:19:17.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:44:0)
[02:19:17.005] Timer tick, asking Buildbucket for the build status
[02:19:17.102] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:17.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:45:0) after 1m0s
[02:20:17.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:45:0)
[02:20:17.230] Timer tick, asking Buildbucket for the build status
[02:20:17.331] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:17.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:46:0) after 1m0s
[02:21:17.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:46:0)
[02:21:17.389] Timer tick, asking Buildbucket for the build status
[02:21:17.875] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:17.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:47:0) after 1m0s
[02:22:18.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:47:0)
[02:22:18.071] Timer tick, asking Buildbucket for the build status
[02:22:18.293] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:18.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:48:0) after 1m0s
[02:23:18.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:48:0)
[02:23:18.354] Timer tick, asking Buildbucket for the build status
[02:23:18.482] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:49:0) after 1m0s
[02:24:18.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:49:0)
[02:24:18.501] Timer tick, asking Buildbucket for the build status
[02:24:18.795] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:18.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:50:0) after 1m0s
[02:25:18.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:50:0)
[02:25:18.868] Timer tick, asking Buildbucket for the build status
[02:25:19.063] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:19.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:51:0) after 1m0s
[02:26:19.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:51:0)
[02:26:19.263] Timer tick, asking Buildbucket for the build status
[02:26:19.495] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:19.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:52:0) after 1m0s
[02:27:19.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:52:0)
[02:27:19.508] Timer tick, asking Buildbucket for the build status
[02:27:19.636] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:19.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:53:0) after 1m0s
[02:28:19.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:53:0)
[02:28:19.685] Timer tick, asking Buildbucket for the build status
[02:28:19.806] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:19.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:54:0) after 1m0s
[02:29:19.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:54:0)
[02:29:19.856] Timer tick, asking Buildbucket for the build status
[02:29:19.979] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:19.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:55:0) after 1m0s
[02:30:20.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:55:0)
[02:30:20.067] Timer tick, asking Buildbucket for the build status
[02:30:20.353] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:56:0) after 1m0s
[02:31:20.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:56:0)
[02:31:20.434] Timer tick, asking Buildbucket for the build status
[02:31:20.540] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:20.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:57:0) after 1m0s
[02:32:20.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:57:0)
[02:32:20.693] Timer tick, asking Buildbucket for the build status
[02:32:20.798] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:20.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:58:0) after 1m0s
[02:33:20.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:58:0)
[02:33:20.951] Timer tick, asking Buildbucket for the build status
[02:33:21.170] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:59:0) after 1m0s
[02:34:21.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:59:0)
[02:34:21.176] Timer tick, asking Buildbucket for the build status
[02:34:21.308] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:60:0) after 1m0s
[02:35:21.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:60:0)
[02:35:21.502] Timer tick, asking Buildbucket for the build status
[02:35:21.603] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:61:0) after 1m0s
[02:36:21.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:61:0)
[02:36:21.634] Timer tick, asking Buildbucket for the build status
[02:36:21.722] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:21.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:62:0) after 1m0s
[02:37:24.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:62:0)
[02:37:24.713] Timer tick, asking Buildbucket for the build status
[02:37:24.828] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:24.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:63:0) after 1m0s
[02:38:24.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:63:0)
[02:38:24.890] Timer tick, asking Buildbucket for the build status
[02:38:25.054] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:25.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:64:0) after 1m0s
[02:39:25.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:64:0)
[02:39:25.110] Timer tick, asking Buildbucket for the build status
[02:39:25.285] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:25.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:65:0) after 1m0s
[02:40:25.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:65:0)
[02:40:25.326] Timer tick, asking Buildbucket for the build status
[02:40:25.460] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:66:0) after 1m0s
[02:41:25.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:66:0)
[02:41:25.547] Timer tick, asking Buildbucket for the build status
[02:41:26.097] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:26.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:67:0) after 1m0s
[02:42:26.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:67:0)
[02:42:26.153] Timer tick, asking Buildbucket for the build status
[02:42:26.466] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:26.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:68:0) after 1m0s
[02:43:26.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:68:0)
[02:43:26.551] Timer tick, asking Buildbucket for the build status
[02:43:26.680] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:26.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:69:0) after 1m0s
[02:44:26.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:69:0)
[02:44:26.762] Timer tick, asking Buildbucket for the build status
[02:44:26.878] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:26.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:70:0) after 1m0s
[02:45:26.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:70:0)
[02:45:26.929] Timer tick, asking Buildbucket for the build status
[02:45:27.334] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:27.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:71:0) after 1m0s
[02:46:27.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:71:0)
[02:46:27.353] Timer tick, asking Buildbucket for the build status
[02:46:27.697] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:72:0) after 1m0s
[02:47:27.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:72:0)
[02:47:27.720] Timer tick, asking Buildbucket for the build status
[02:47:27.848] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:27.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:73:0) after 1m0s
[02:48:27.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:73:0)
[02:48:27.902] Timer tick, asking Buildbucket for the build status
[02:48:27.993] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:27.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:74:0) after 1m0s
[02:49:28.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:74:0)
[02:49:28.005] Timer tick, asking Buildbucket for the build status
[02:49:28.114] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:28.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:75:0) after 1m0s
[02:50:28.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:75:0)
[02:50:28.159] Timer tick, asking Buildbucket for the build status
[02:50:28.273] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:28.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:76:0) after 1m0s
[02:51:28.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:76:0)
[02:51:28.322] Timer tick, asking Buildbucket for the build status
[02:51:28.465] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:28.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:77:0) after 1m0s
[02:52:28.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:77:0)
[02:52:28.573] Timer tick, asking Buildbucket for the build status
[02:52:29.034] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:29.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:78:0) after 1m0s
[02:53:29.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:78:0)
[02:53:29.119] Timer tick, asking Buildbucket for the build status
[02:53:29.385] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:29.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:79:0) after 1m0s
[02:54:29.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:79:0)
[02:54:29.406] Timer tick, asking Buildbucket for the build status
[02:54:29.639] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:29.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:80:0) after 1m0s
[02:55:29.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:80:0)
[02:55:29.691] Timer tick, asking Buildbucket for the build status
[02:55:29.789] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:29.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:81:0) after 1m0s
[02:56:29.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:81:0)
[02:56:29.835] Timer tick, asking Buildbucket for the build status
[02:56:30.293] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:30.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:82:0) after 1m0s
[02:57:30.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:82:0)
[02:57:30.341] Timer tick, asking Buildbucket for the build status
[02:57:30.919] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:30.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:83:0) after 1m0s
[02:58:30.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:83:0)
[02:58:30.943] Timer tick, asking Buildbucket for the build status
[02:58:31.052] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:31.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:84:0) after 1m0s
[02:59:31.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:84:0)
[02:59:31.038] Timer tick, asking Buildbucket for the build status
[02:59:31.164] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:31.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:85:0) after 1m0s
[03:00:31.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:85:0)
[03:00:31.228] Timer tick, asking Buildbucket for the build status
[03:00:31.313] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:31.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:86:0) after 1m0s
[03:01:31.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:86:0)
[03:01:31.377] Timer tick, asking Buildbucket for the build status
[03:01:31.496] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:31.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:87:0) after 1m0s
[03:02:31.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:87:0)
[03:02:31.521] Timer tick, asking Buildbucket for the build status
[03:02:31.748] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:31.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:88:0) after 1m0s
[03:03:31.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:88:0)
[03:03:31.733] Timer tick, asking Buildbucket for the build status
[03:03:31.933] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:31.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:89:0) after 1m0s
[03:04:32.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:89:0)
[03:04:32.364] Timer tick, asking Buildbucket for the build status
[03:04:32.456] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:32.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:90:0) after 1m0s
[03:05:32.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:90:0)
[03:05:32.655] Timer tick, asking Buildbucket for the build status
[03:05:32.761] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:32.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:91:0) after 1m0s
[03:06:32.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:91:0)
[03:06:32.802] Timer tick, asking Buildbucket for the build status
[03:06:32.911] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:32.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:92:0) after 1m0s
[03:07:33.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:92:0)
[03:07:33.114] Timer tick, asking Buildbucket for the build status
[03:07:33.311] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:93:0) after 1m0s
[03:08:33.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:93:0)
[03:08:33.371] Timer tick, asking Buildbucket for the build status
[03:08:33.480] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:33.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:94:0) after 1m0s
[03:09:33.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:94:0)
[03:09:33.695] Timer tick, asking Buildbucket for the build status
[03:09:33.890] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:33.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:95:0) after 1m0s
[03:10:33.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:95:0)
[03:10:33.932] Timer tick, asking Buildbucket for the build status
[03:10:34.412] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:34.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:96:0) after 1m0s
[03:11:34.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:96:0)
[03:11:34.470] Timer tick, asking Buildbucket for the build status
[03:11:34.580] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:34.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:97:0) after 1m0s
[03:12:34.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:97:0)
[03:12:34.634] Timer tick, asking Buildbucket for the build status
[03:12:34.778] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:34.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:98:0) after 1m0s
[03:13:34.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:98:0)
[03:13:34.820] Timer tick, asking Buildbucket for the build status
[03:13:34.915] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:34.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:99:0) after 1m0s
[03:14:34.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:99:0)
[03:14:34.925] Timer tick, asking Buildbucket for the build status
[03:14:35.070] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:35.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:100:0) after 1m0s
[03:15:35.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:100:0)
[03:15:35.117] Timer tick, asking Buildbucket for the build status
[03:15:35.219] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:35.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:101:0) after 1m0s
[03:16:35.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:101:0)
[03:16:35.236] Timer tick, asking Buildbucket for the build status
[03:16:35.608] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:35.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:102:0) after 1m0s
[03:17:35.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:102:0)
[03:17:35.692] Timer tick, asking Buildbucket for the build status
[03:17:35.911] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:35.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:103:0) after 1m0s
[03:18:35.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:103:0)
[03:18:35.918] Timer tick, asking Buildbucket for the build status
[03:18:36.004] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:36.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:104:0) after 1m0s
[03:19:36.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:104:0)
[03:19:36.085] Timer tick, asking Buildbucket for the build status
[03:19:36.194] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:36.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:105:0) after 1m0s
[03:20:36.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:105:0)
[03:20:36.246] Timer tick, asking Buildbucket for the build status
[03:20:36.383] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:36.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:106:0) after 1m0s
[03:21:36.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:106:0)
[03:21:36.446] Timer tick, asking Buildbucket for the build status
[03:21:36.579] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:36.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:107:0) after 1m0s
[03:22:36.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:107:0)
[03:22:36.614] Timer tick, asking Buildbucket for the build status
[03:22:36.748] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:36.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:108:0) after 1m0s
[03:23:36.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:108:0)
[03:23:36.794] Timer tick, asking Buildbucket for the build status
[03:23:36.897] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:36.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:109:0) after 1m0s
[03:24:36.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:109:0)
[03:24:36.974] Timer tick, asking Buildbucket for the build status
[03:24:37.069] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:110:0) after 1m0s
[03:25:37.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:110:0)
[03:25:37.077] Timer tick, asking Buildbucket for the build status
[03:25:37.358] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:37.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:111:0) after 1m0s
[03:26:37.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:111:0)
[03:26:37.414] Timer tick, asking Buildbucket for the build status
[03:26:37.510] Build 8855089263213626688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:37.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020519325349188736:112:0) after 1m0s
[03:27:02.220] Received PubSub notification, asking Buildbucket for the build status
[03:27:02.356] Build 8855089263213626688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:27:02.356] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613532420388338",
"created_by": "project:chromium",
"created_ts": "1613525822396163",
"id": "8855089263213626688",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\"}}",
"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\": \"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\", \"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-184-d4lj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22656, \"got_angle_revision\": \"e153063d249766be53ce1d9c9808a7d14a736fcb\", \"got_dawn_revision\": \"536c7aea7df989fd773e397ca34ed08ef7af03b6\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\", \"got_revision_cp\": \"refs/heads/master@{#854566}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"bb04803b8daf08e186b327d18e14c78378f44e37\", \"got_v8_revision\": \"1e2050c11767986fc74d4a58ae346f14aeeb892a\", \"got_v8_revision_cp\": \"refs/heads/9.0.192@{#1}\", \"got_webrtc_revision\": \"8408c9938cb543a7cd5e7127927f3b4d0834ad59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33272}\", \"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\": \"73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7\", \"swarm_hashes_refs/heads/master(at){#854566}_without_patch\": {\"absl_hardening_tests\": \"c8d2b1d7256351f12686fff49efaab6281d19e0e\", \"accessibility_unittests\": \"4a9d4a5e71f2de7f0d882c55d5307d09ddd46865\", \"angle_unittests\": \"17125a6a4b3866fb26f756f51d2d39e2b48270b1\", \"app_list_unittests\": \"1460715c60bd560f98e8eb709275450b98de6440\", \"app_shell_unittests\": \"a1055e82111b4a9348b97b046a6ed74e9d9cfb00\", \"ash_unittests\": \"26b4912f1fe78cfe6ba00110f8fd2699b50b37b1\", \"aura_unittests\": \"d55b45aff1f30314dd73aafaddaa911ea651f854\", \"base_unittests\": \"1f878e8a5b792a08222fda1856a1e459515e3d6a\", \"base_util_unittests\": \"715f6285fbb50a63c13cc966cc5f18b47db44ef4\", \"blink_common_unittests\": \"76794b2a7a3d6f5e3e30f6638f594e18590a4933\", \"blink_fuzzer_unittests\": \"f27540564e78e5e7fb2c080ff09687e9620b99fe\", \"blink_heap_unittests\": \"95a9e2fb89c2639a92c82feba7a003e1d3e1560f\", \"blink_platform_unittests\": \"5886c2d94cb9c6d07a9a9cfe37a8ed7379298ce5\", \"blink_unittests\": \"765c73a2a66efd61a93b48226a4c8cbc65175051\", \"boringssl_crypto_tests\": \"55f4a003473d6fc89a45284a99133bc953cf8275\", \"boringssl_ssl_tests\": \"4b03409cd18ca065968e8e26584f211d31ddf12f\", \"browser_tests\": \"e712b1bf9ddcb81841a27cc9c8eb72a66ba42d5c\", \"capture_unittests\": \"d23c145efc33c92e20d813f03ebc18728550e25a\", \"cast_unittests\": \"7341b4d17c1e3869295f7228427c5167c1264446\", \"cc_unittests\": \"157fa66974abe3bfb15a5b86008f1189616885e7\", \"chrome_app_unittests\": \"310f1b88ca0ed0750ea1f045296ec8c7231cbfe6\", \"chromedriver_unittests\": \"9a3c231ac7ae825a92d32e429dcd73a92326fe1c\", \"chromeos_components_unittests\": \"0272ac1dc4b2e9fd90574e76c4f014a101b42495\", \"chromeos_unittests\": \"cba9a0fffd9508ce6038db49fb9912af42c8aeed\", \"components_browsertests\": \"5f80f1cafdb5e97b9066b4a6db91a1de7483650e\", \"components_unittests\": \"f16fff7db5e9b32b596b9e18565a247b27593325\", \"compositor_unittests\": \"0a3393892973c72a4db815ac27799f5a7c057e0c\", \"content_browsertests\": \"1fde83aecda0f1da382950a913fd9ccdea14f336\", \"content_unittests\": \"555874372792e401d509fb1f0f82aa6e71e7e99e\", \"crashpad_tests\": \"4a5bbb6a39303a000901a83bab8339ef1b05874c\", \"crypto_unittests\": \"fa4a0a135dd47fe84e17cdf88e272522b9e9f54d\", \"dbus_unittests\": \"46c87f3e5ae7bd0479d255c3cadff62eaca118ae\", \"device_unittests\": \"fa0a25db03d17be4426391b629ea4da8e14bc8e6\", \"display_unittests\": \"a4bf77705d2d277ae66862f158076bac4426d665\", \"events_unittests\": \"48dff07d903ff3aa8b848508c9fe4d85a523229c\", \"exo_unittests\": \"aac976b7c91bf96a51c28d0bb7187d8147787af1\", \"extensions_browsertests\": \"40fc0d8f0b2cd6ebbcca89dd9e90dc92e31ab91d\", \"extensions_unittests\": \"fbf64f5cf3f3bab2addeb2b7fcd51a8f735f301e\", \"filesystem_service_unittests\": \"11f254c3cf2a4b2daeae90b3e97ca70333c5a569\", \"gcm_unit_tests\": \"a75eb392a8d89094aa84b4b694da2504d4c64cc2\", \"gfx_unittests\": \"168f8731abe6e93f5b9ec9fe86edb300fcb7400d\", \"gin_unittests\": \"064eb46825a65d40505406107955a09472599648\", \"gl_unittests_ozone\": \"433f5236c103a553be18b0bf411962741e0b2d0e\", \"google_apis_unittests\": \"a223a0c4472e2df87e157c8297df6e196681b564\", \"gpu_unittests\": \"cf9593738999c1683e2a3381e6838bacabd682f5\", \"gwp_asan_unittests\": \"155d2f8e077c5343c72e1435dcb854a2391b20c8\", \"interactive_ui_tests\": \"d95fd176d3a041d288680fa59287c1f75217168e\", \"ipc_tests\": \"4f305bde0884205e11aba6d9402fd59628e0e34a\", \"jingle_unittests\": \"5969a086a7d02e8fa8692422eb715e5dbcc6d3a8\", \"keyboard_unittests\": \"05ae55d52b23407fe153251e57f130138eab43e9\", \"latency_unittests\": \"f4443ef00bb767867d56c43ddcb08852acd95193\", \"libjingle_xmpp_unittests\": \"40112ff6632f0cdc9ae582552658c144b4e259ce\", \"liburlpattern_unittests\": \"bc97406968d18d090a670f84844305d3f4e10bd8\", \"media_blink_unittests\": \"c95d20b8d0b00f944b31d76e72d38a7eb783e214\", \"media_unittests\": \"6752e2ce190e0915e59c2478776add5e28ab9e47\", \"message_center_unittests\": \"0dd099700c1a67eab5a605284e717331848eddde\", \"midi_unittests\": \"7802b94ec07fcc414a98e53db02659bc95f35c76\", \"mojo_core_unittests\": \"5625d8c85777a56b929c398015b7122a9d788a46\", \"mojo_unittests\": \"f23c76914a8b7ba8ef0edd6f9899beb88107de66\", \"nacl_helper_nonsfi_unittests\": \"c91a75f14748415a777fcca28ca0653d58a76cad\", \"nacl_loader_unittests\": \"b6a1b4c996c132109fd1c108189c3ebd1eec0c18\", \"native_theme_unittests\": \"7aa96dc20e4c1d79e55bda53d763800b38f34a79\", \"net_unittests\": \"7b80743480538a3bea52244eef0ebe5da3eff806\", \"ozone_gl_unittests\": \"87a6d6883cc215c265e09a8f78b25320cc6cb407\", \"ozone_unittests\": \"af4f5d1e30226325900b10eff98a311e7eef1810\", \"ozone_x11_unittests\": \"df4d18d9c01a2c91b80e8eeb1f13cd50ad00812a\", \"pdf_unittests\": \"8cf06ceb84f5dbe0a188f80ff655986ebddbf962\", \"perfetto_unittests\": \"edca2480a403e64a1842e3c7c580009a1f455937\", \"ppapi_unittests\": \"0867bb5c8fb9a58b8815328ac228b9d81fa7d575\", \"printing_unittests\": \"9c90aec8059fec49ef641b0a93fe5eeec0555df9\", \"remoting_unittests\": \"6d3b13fb7f1ed4dba23727c43f60e9cf57a6a6d8\", \"sandbox_linux_unittests\": \"d8c2f8aa74d8608b29fac99eec27ceab350f1715\", \"service_manager_unittests\": \"ca351e1bcc4cdf7d0247a0cd7656aea4c913403e\", \"services_unittests\": \"c1337affd4aeac8fc6719bc1ce53a240bae6d175\", \"shell_dialogs_unittests\": \"0ddf9c44aa221d8a4ef5c1e39628eac9c450fb6c\", \"shell_encryption_unittests\": \"84ca28c2a8ce0f62c355ae0720656f8ff00464d6\", \"skia_unittests\": \"48d519e60e970bea9a75d3429a64f612374d3191\", \"snapshot_unittests\": \"51cfa1c68404420340f9cb7c3488a195bb752317\", \"sql_unittests\": \"e96bfd31fc4c85b47f59327c1614e3551a770061\", \"storage_unittests\": \"7da5dbb0ac3c75657eaa14fb5b0eaa86b20d4b82\", \"sync_integration_tests\": \"16389bf2dbba70970d81077ed70360132275f099\", \"traffic_annotation_auditor_unittests\": \"4adeab1e169dc9e56d5eea524ccf531b96b7a8c9\", \"ui_base_unittests\": \"568d9c4f8598e62ad19eb82914fcd683d530b88c\", \"ui_chromeos_unittests\": \"16248da93e08b19bdf381649ec399c46839d391d\", \"ui_touch_selection_unittests\": \"114598bf18ff1488d7bdc571c418714a851a955e\", \"unit_tests\": \"b8c2ce038a8a04edfe61c664e5d19a36775adad2\", \"url_unittests\": \"438e1203557e59e133819a951b713d4c483741d9\", \"usage_time_limit_unittests\": \"54c9c1873f4bbb35b42ea27618f5a1eb6336f0c0\", \"views_unittests\": \"59dcc925be2363c5189d11cbaa8be0e681d15937\", \"viz_unittests\": \"d84838d8ca5f10a8a0f3ea7c31144e48d44bca85\", \"wm_unittests\": \"c05ab551a45ad5077b5cae052b2aac388a3107d1\", \"wtf_unittests\": \"ec33b7e7fc0c93e1b80276f3d075303d4dc051d7\", \"zlib_unittests\": \"f4f1585976840937002d3c20bf767f105fac962d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_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-184-d4lj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613525824479543",
"status": "COMPLETED",
"status_changed_ts": "1613532420728228",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22656",
"builder:linux-chromeos-dbg",
"buildset:commit/git/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e4bc36d2194599a2c2f7a0484ee6c0cf5284d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020519325349188736",
"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/8855089263213626688/+/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:51c673ba51011110",
"user_agent:luci-scheduler"
],
"updated_ts": "1613532420741562",
"url": "https://ci.chromium.org/b/8855089263213626688",
"utcnow_ts": "1613532422342786"
}
}
[03:27:02.356] Invocation finished in 1h50m1.380775915s with status SUCCEEDED