[21:35:00.603] New invocation is queued and will start shortly
[21:35:04.623] Starting the invocation (attempt 1)
[21:35:04.664] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:35:04.664] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:35:04.664] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029503650773443056",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4509f70c6dd053a8ff23580c8465d24269c2d5a6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029503650773443056",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"gitiles_ref:refs/heads/master"
]
}
[21:35:05.494] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604957704863545",
"id": "8864073585623826160",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4509f70c6dd053a8ff23580c8465d24269c2d5a6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604957705302715",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21228",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029503650773443056",
"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/8864073585623826160/+/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": "1604957705303151",
"url": "https://ci.chromium.org/b/8864073585623826160",
"utcnow_ts": "1604957705482889"
}
}
[21:35:05.494] Task URL: https://ci.chromium.org/b/8864073585623826160
[21:35:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:2:0) after 1m0s
[21:35:07.248] Received PubSub notification, asking Buildbucket for the build status
[21:35:07.346] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:05.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:2:0)
[21:36:05.516] Timer tick, asking Buildbucket for the build status
[21:36:05.724] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:05.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:4:0) after 1m0s
[21:37:05.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:4:0)
[21:37:05.767] Timer tick, asking Buildbucket for the build status
[21:37:05.877] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:05.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:5:0) after 1m0s
[21:38:05.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:5:0)
[21:38:05.938] Timer tick, asking Buildbucket for the build status
[21:38:06.155] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:06.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:6:0) after 1m0s
[21:39:06.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:6:0)
[21:39:06.233] Timer tick, asking Buildbucket for the build status
[21:39:06.395] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:06.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:7:0) after 1m0s
[21:40:06.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:7:0)
[21:40:06.458] Timer tick, asking Buildbucket for the build status
[21:40:06.940] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:06.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:8:0) after 1m0s
[21:41:06.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:8:0)
[21:41:06.986] Timer tick, asking Buildbucket for the build status
[21:41:07.085] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:07.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:9:0) after 1m0s
[21:42:07.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:9:0)
[21:42:07.154] Timer tick, asking Buildbucket for the build status
[21:42:07.259] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:07.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:10:0) after 1m0s
[21:43:07.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:10:0)
[21:43:07.374] Timer tick, asking Buildbucket for the build status
[21:43:07.448] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:07.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:11:0) after 1m0s
[21:44:07.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:11:0)
[21:44:07.481] Timer tick, asking Buildbucket for the build status
[21:44:07.746] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:07.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:12:0) after 1m0s
[21:45:07.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:12:0)
[21:45:07.859] Timer tick, asking Buildbucket for the build status
[21:45:07.970] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:07.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:13:0) after 1m0s
[21:46:08.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:13:0)
[21:46:08.898] Timer tick, asking Buildbucket for the build status
[21:46:08.990] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:08.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:14:0) after 1m0s
[21:47:09.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:14:0)
[21:47:09.047] Timer tick, asking Buildbucket for the build status
[21:47:09.129] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:09.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:15:0) after 1m0s
[21:48:09.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:15:0)
[21:48:09.261] Timer tick, asking Buildbucket for the build status
[21:48:09.339] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:09.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:16:0) after 1m0s
[21:49:09.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:16:0)
[21:49:09.467] Timer tick, asking Buildbucket for the build status
[21:49:09.900] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:09.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:17:0) after 1m0s
[21:50:10.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:17:0)
[21:50:10.435] Timer tick, asking Buildbucket for the build status
[21:50:10.702] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:10.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:18:0) after 1m0s
[21:51:10.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:18:0)
[21:51:10.857] Timer tick, asking Buildbucket for the build status
[21:51:11.076] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:11.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:19:0) after 1m0s
[21:52:11.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:19:0)
[21:52:11.118] Timer tick, asking Buildbucket for the build status
[21:52:11.190] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:11.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:20:0) after 1m0s
[21:53:11.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:20:0)
[21:53:11.292] Timer tick, asking Buildbucket for the build status
[21:53:11.455] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:11.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:21:0) after 1m0s
[21:54:11.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:21:0)
[21:54:11.516] Timer tick, asking Buildbucket for the build status
[21:54:11.658] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:22:0) after 1m0s
[21:55:11.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:22:0)
[21:55:11.813] Timer tick, asking Buildbucket for the build status
[21:55:11.919] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:11.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:23:0) after 1m0s
[21:56:12.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:23:0)
[21:56:12.072] Timer tick, asking Buildbucket for the build status
[21:56:12.163] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:12.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:24:0) after 1m0s
[21:57:12.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:24:0)
[21:57:12.220] Timer tick, asking Buildbucket for the build status
[21:57:12.353] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:12.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:25:0) after 1m0s
[21:58:12.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:25:0)
[21:58:12.438] Timer tick, asking Buildbucket for the build status
[21:58:12.514] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:12.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:26:0) after 1m0s
[21:59:12.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:26:0)
[21:59:12.675] Timer tick, asking Buildbucket for the build status
[21:59:12.859] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:12.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:27:0) after 1m0s
[22:00:13.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:27:0)
[22:00:13.237] Timer tick, asking Buildbucket for the build status
[22:00:13.565] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:13.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:28:0) after 1m0s
[22:01:13.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:28:0)
[22:01:13.663] Timer tick, asking Buildbucket for the build status
[22:01:13.740] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:13.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:29:0) after 1m0s
[22:02:13.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:29:0)
[22:02:13.766] Timer tick, asking Buildbucket for the build status
[22:02:13.852] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:13.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:30:0) after 1m0s
[22:03:14.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:30:0)
[22:03:14.032] Timer tick, asking Buildbucket for the build status
[22:03:14.600] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:31:0) after 1m0s
[22:04:14.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:31:0)
[22:04:14.837] Timer tick, asking Buildbucket for the build status
[22:04:14.903] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:14.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:32:0) after 1m0s
[22:05:15.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:32:0)
[22:05:15.061] Timer tick, asking Buildbucket for the build status
[22:05:15.237] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:15.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:33:0) after 1m0s
[22:06:15.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:33:0)
[22:06:15.332] Timer tick, asking Buildbucket for the build status
[22:06:15.437] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:15.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:34:0) after 1m0s
[22:07:15.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:34:0)
[22:07:15.519] Timer tick, asking Buildbucket for the build status
[22:07:15.612] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:15.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:35:0) after 1m0s
[22:08:15.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:35:0)
[22:08:15.680] Timer tick, asking Buildbucket for the build status
[22:08:15.751] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:15.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:36:0) after 1m0s
[22:09:15.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:36:0)
[22:09:15.804] Timer tick, asking Buildbucket for the build status
[22:09:15.998] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:15.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:37:0) after 1m0s
[22:10:16.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:37:0)
[22:10:16.041] Timer tick, asking Buildbucket for the build status
[22:10:16.177] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:16.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:38:0) after 1m0s
[22:11:16.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:38:0)
[22:11:16.327] Timer tick, asking Buildbucket for the build status
[22:11:16.423] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:16.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:39:0) after 1m0s
[22:12:16.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:39:0)
[22:12:16.572] Timer tick, asking Buildbucket for the build status
[22:12:16.647] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:40:0) after 1m0s
[22:13:16.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:40:0)
[22:13:16.792] Timer tick, asking Buildbucket for the build status
[22:13:16.864] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:16.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:41:0) after 1m0s
[22:14:16.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:41:0)
[22:14:16.968] Timer tick, asking Buildbucket for the build status
[22:14:17.040] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:42:0) after 1m0s
[22:15:17.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:42:0)
[22:15:17.081] Timer tick, asking Buildbucket for the build status
[22:15:17.176] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:17.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:43:0) after 1m0s
[22:16:17.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:43:0)
[22:16:17.262] Timer tick, asking Buildbucket for the build status
[22:16:17.367] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:17.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:44:0) after 1m0s
[22:17:17.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:44:0)
[22:17:17.402] Timer tick, asking Buildbucket for the build status
[22:17:17.479] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:17.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:45:0) after 1m0s
[22:18:17.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:45:0)
[22:18:17.618] Timer tick, asking Buildbucket for the build status
[22:18:17.891] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:17.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:46:0) after 1m0s
[22:19:17.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:46:0)
[22:19:17.991] Timer tick, asking Buildbucket for the build status
[22:19:18.177] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:18.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:47:0) after 1m0s
[22:20:18.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:47:0)
[22:20:18.306] Timer tick, asking Buildbucket for the build status
[22:20:18.789] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:18.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:48:0) after 1m0s
[22:21:18.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:48:0)
[22:21:18.856] Timer tick, asking Buildbucket for the build status
[22:21:18.961] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:18.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:49:0) after 1m0s
[22:22:19.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:49:0)
[22:22:19.010] Timer tick, asking Buildbucket for the build status
[22:22:19.088] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:19.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:50:0) after 1m0s
[22:23:19.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:50:0)
[22:23:19.193] Timer tick, asking Buildbucket for the build status
[22:23:19.277] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:19.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:51:0) after 1m0s
[22:24:19.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:51:0)
[22:24:19.297] Timer tick, asking Buildbucket for the build status
[22:24:19.879] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:19.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:52:0) after 1m0s
[22:25:20.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:52:0)
[22:25:20.023] Timer tick, asking Buildbucket for the build status
[22:25:20.167] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:20.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:53:0) after 1m0s
[22:26:20.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:53:0)
[22:26:20.266] Timer tick, asking Buildbucket for the build status
[22:26:20.451] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:20.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:54:0) after 1m0s
[22:27:20.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:54:0)
[22:27:20.516] Timer tick, asking Buildbucket for the build status
[22:27:20.668] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:20.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:55:0) after 1m0s
[22:28:20.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:55:0)
[22:28:20.917] Timer tick, asking Buildbucket for the build status
[22:28:21.908] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:21.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:56:0) after 1m0s
[22:29:21.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:56:0)
[22:29:21.961] Timer tick, asking Buildbucket for the build status
[22:29:22.104] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:22.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:57:0) after 1m0s
[22:30:22.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:57:0)
[22:30:22.177] Timer tick, asking Buildbucket for the build status
[22:30:22.544] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:58:0) after 1m0s
[22:31:22.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:58:0)
[22:31:22.614] Timer tick, asking Buildbucket for the build status
[22:31:22.852] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:59:0) after 1m0s
[22:32:22.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:59:0)
[22:32:22.901] Timer tick, asking Buildbucket for the build status
[22:32:23.183] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:23.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:60:0) after 1m0s
[22:33:23.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:60:0)
[22:33:23.225] Timer tick, asking Buildbucket for the build status
[22:33:23.301] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:61:0) after 1m0s
[22:34:23.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:61:0)
[22:34:23.372] Timer tick, asking Buildbucket for the build status
[22:34:23.658] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:23.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:62:0) after 1m0s
[22:35:23.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:62:0)
[22:35:23.715] Timer tick, asking Buildbucket for the build status
[22:35:23.880] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:23.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:63:0) after 1m0s
[22:36:23.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:63:0)
[22:36:23.956] Timer tick, asking Buildbucket for the build status
[22:36:24.164] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:24.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:64:0) after 1m0s
[22:37:24.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:64:0)
[22:37:24.233] Timer tick, asking Buildbucket for the build status
[22:37:24.508] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:24.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:65:0) after 1m0s
[22:38:24.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:65:0)
[22:38:24.652] Timer tick, asking Buildbucket for the build status
[22:38:24.890] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:24.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:66:0) after 1m0s
[22:39:25.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:66:0)
[22:39:25.066] Timer tick, asking Buildbucket for the build status
[22:39:25.210] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:25.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:67:0) after 1m0s
[22:40:25.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:67:0)
[22:40:25.297] Timer tick, asking Buildbucket for the build status
[22:40:25.555] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:25.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:68:0) after 1m0s
[22:41:25.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:68:0)
[22:41:25.663] Timer tick, asking Buildbucket for the build status
[22:41:25.817] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:69:0) after 1m0s
[22:42:25.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:69:0)
[22:42:25.872] Timer tick, asking Buildbucket for the build status
[22:42:25.991] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:25.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:70:0) after 1m0s
[22:43:26.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:70:0)
[22:43:26.094] Timer tick, asking Buildbucket for the build status
[22:43:26.177] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:26.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:71:0) after 1m0s
[22:44:26.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:71:0)
[22:44:26.263] Timer tick, asking Buildbucket for the build status
[22:44:26.406] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:26.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:72:0) after 1m0s
[22:45:26.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:72:0)
[22:45:26.474] Timer tick, asking Buildbucket for the build status
[22:45:26.599] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:26.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:73:0) after 1m0s
[22:46:26.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:73:0)
[22:46:26.617] Timer tick, asking Buildbucket for the build status
[22:46:27.231] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:27.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:74:0) after 1m0s
[22:47:27.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:74:0)
[22:47:27.274] Timer tick, asking Buildbucket for the build status
[22:47:27.835] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:27.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:75:0) after 1m0s
[22:48:27.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:75:0)
[22:48:27.930] Timer tick, asking Buildbucket for the build status
[22:48:28.042] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:28.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:76:0) after 1m0s
[22:49:28.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:76:0)
[22:49:28.061] Timer tick, asking Buildbucket for the build status
[22:49:28.133] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:28.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:77:0) after 1m0s
[22:50:28.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:77:0)
[22:50:28.354] Timer tick, asking Buildbucket for the build status
[22:50:28.535] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:28.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:78:0) after 1m0s
[22:51:28.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:78:0)
[22:51:28.630] Timer tick, asking Buildbucket for the build status
[22:51:28.915] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:28.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:79:0) after 1m0s
[22:52:28.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:79:0)
[22:52:28.983] Timer tick, asking Buildbucket for the build status
[22:52:29.071] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:29.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:80:0) after 1m0s
[22:53:29.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:80:0)
[22:53:29.164] Timer tick, asking Buildbucket for the build status
[22:53:29.239] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:29.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:81:0) after 1m0s
[22:54:29.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:81:0)
[22:54:29.390] Timer tick, asking Buildbucket for the build status
[22:54:29.554] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:29.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:82:0) after 1m0s
[22:55:29.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:82:0)
[22:55:29.652] Timer tick, asking Buildbucket for the build status
[22:55:29.804] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:29.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:83:0) after 1m0s
[22:56:29.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:83:0)
[22:56:29.877] Timer tick, asking Buildbucket for the build status
[22:56:30.124] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:30.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:84:0) after 1m0s
[22:57:30.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:84:0)
[22:57:30.209] Timer tick, asking Buildbucket for the build status
[22:57:30.302] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:30.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:85:0) after 1m0s
[22:58:30.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:85:0)
[22:58:30.447] Timer tick, asking Buildbucket for the build status
[22:58:30.577] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:30.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:86:0) after 1m0s
[22:59:30.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:86:0)
[22:59:30.579] Timer tick, asking Buildbucket for the build status
[22:59:30.650] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:30.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:87:0) after 1m0s
[23:00:30.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:87:0)
[23:00:30.809] Timer tick, asking Buildbucket for the build status
[23:00:31.017] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:31.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:88:0) after 1m0s
[23:01:31.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:88:0)
[23:01:31.277] Timer tick, asking Buildbucket for the build status
[23:01:31.376] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:31.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:89:0) after 1m0s
[23:02:31.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:89:0)
[23:02:31.408] Timer tick, asking Buildbucket for the build status
[23:02:31.802] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:31.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:90:0) after 1m0s
[23:03:32.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:90:0)
[23:03:32.604] Timer tick, asking Buildbucket for the build status
[23:03:32.771] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:91:0) after 1m0s
[23:04:32.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:91:0)
[23:04:32.867] Timer tick, asking Buildbucket for the build status
[23:04:32.945] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:32.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:92:0) after 1m0s
[23:05:33.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:92:0)
[23:05:33.153] Timer tick, asking Buildbucket for the build status
[23:05:34.045] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:34.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:93:0) after 1m0s
[23:06:34.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:93:0)
[23:06:34.273] Timer tick, asking Buildbucket for the build status
[23:06:34.359] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:94:0) after 1m0s
[23:07:34.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:94:0)
[23:07:34.543] Timer tick, asking Buildbucket for the build status
[23:07:35.121] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:35.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:95:0) after 1m0s
[23:08:35.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:95:0)
[23:08:35.186] Timer tick, asking Buildbucket for the build status
[23:08:35.819] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:35.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:96:0) after 1m0s
[23:09:35.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:96:0)
[23:09:35.901] Timer tick, asking Buildbucket for the build status
[23:09:36.189] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:36.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:97:0) after 1m0s
[23:10:36.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:97:0)
[23:10:36.290] Timer tick, asking Buildbucket for the build status
[23:10:36.422] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:36.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:98:0) after 1m0s
[23:11:36.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:98:0)
[23:11:36.475] Timer tick, asking Buildbucket for the build status
[23:11:36.571] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:36.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:99:0) after 1m0s
[23:12:36.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:99:0)
[23:12:36.744] Timer tick, asking Buildbucket for the build status
[23:12:37.292] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:37.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:100:0) after 1m0s
[23:13:37.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:100:0)
[23:13:37.434] Timer tick, asking Buildbucket for the build status
[23:13:37.513] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:37.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:101:0) after 1m0s
[23:14:37.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:101:0)
[23:14:37.628] Timer tick, asking Buildbucket for the build status
[23:14:37.910] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:37.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:102:0) after 1m0s
[23:15:37.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:102:0)
[23:15:37.904] Timer tick, asking Buildbucket for the build status
[23:15:38.017] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:38.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:103:0) after 1m0s
[23:16:38.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:103:0)
[23:16:38.007] Timer tick, asking Buildbucket for the build status
[23:16:38.080] Build 8864073585623826160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029503650773443056:104:0) after 1m0s
[23:17:19.680] Received PubSub notification, asking Buildbucket for the build status
[23:17:20.207] Build 8864073585623826160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:17:20.207] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604963838392048",
"created_by": "project:chromium",
"created_ts": "1604957704863545",
"id": "8864073585623826160",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4509f70c6dd053a8ff23580c8465d24269c2d5a6\"}}",
"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\": \"4509f70c6dd053a8ff23580c8465d24269c2d5a6\", \"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-102-p9wv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21228, \"got_angle_revision\": \"9217d49db032476b003472b539b5c76fff234be1\", \"got_dawn_revision\": \"0053fef8a47d72a1a240df80395d5a4bf9f6170c\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"4509f70c6dd053a8ff23580c8465d24269c2d5a6\", \"got_revision_cp\": \"refs/heads/master@{#825476}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"c19c1b2ce2a08246c5ffd51bc78dfb63c8d8183d\", \"got_v8_revision_cp\": \"refs/heads/8.8.264@{#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\": \"4509f70c6dd053a8ff23580c8465d24269c2d5a6\", \"swarm_hashes_refs/heads/master(at){#825476}_without_patch\": {\"absl_hardening_tests\": \"f752bb97cb6abea9b02cb0929ef46fcb7e87e2f3\", \"accessibility_unittests\": \"c67781f5d8a01016a02bf984bb5cb0b103678e70\", \"angle_unittests\": \"a823a5f8265a2b8988c25d5ff3bee098105a85b3\", \"app_list_unittests\": \"59e9b0884c5f4ccd7886d6a67eb3a465cd59ccd6\", \"app_shell_unittests\": \"a29f8b3ebee4df3ccbc6e4f3dac0e7f9848a0f99\", \"ash_unittests\": \"84992b0861fdfd3ab15201043e82e3434418dfb5\", \"aura_unittests\": \"d706149f807f85aa7f8aafaa7677b370cf42f882\", \"base_unittests\": \"e1562d6e9ad523980f70b35584c8b21d2fadffbc\", \"base_util_unittests\": \"f7d16d03fdfaacc91ea7dceaacb9dbe5c3942c0c\", \"blink_common_unittests\": \"e9744be2e8fbd6cb3026757a407f76f17eb62cef\", \"blink_fuzzer_unittests\": \"d94e59e9afb5e322192b9ac6672f71fb671a4330\", \"blink_heap_unittests\": \"3922f082b218159e636eb2a1645a2137c78369db\", \"blink_platform_unittests\": \"6f17d1b9400350ddb092543fda9fd6a653480825\", \"blink_unittests\": \"e8f848d21477c531c5e735dffcf83c43aae5c4ae\", \"boringssl_crypto_tests\": \"65282cdd34e3c49f620f284dc847e881553e4875\", \"boringssl_ssl_tests\": \"485fec2f74e174aaaabdbc2d516cc9a0dce5aece\", \"browser_tests\": \"8a1707e0175441ab3658b98a5d69870ed1cebcfe\", \"capture_unittests\": \"c2abb4851fdc95f18f9ba13a5576d533e1783aab\", \"cast_unittests\": \"3ac0f6b5252a52f09a1d74c2e2c652b890771f83\", \"cc_unittests\": \"dfe5b38ce7972543ef17610cdf70875093966d81\", \"chrome_app_unittests\": \"3b548415f866748697371a18ffdbc01cf0e13136\", \"chromedriver_unittests\": \"1952c55596adbd89c4a74a5677f79f444aed74d9\", \"chromeos_components_unittests\": \"10afe08a2f31d6b4b676b08ab985d57cc3287bf5\", \"chromeos_unittests\": \"a34cfc75c2d4efd4a6c5ccfa8550099d921f10c6\", \"components_browsertests\": \"f3b7fea31c910e6b9cabb30f200cbc935c661b32\", \"components_unittests\": \"e5743f99a103cfaae8408eb350d9550f7f2e3898\", \"compositor_unittests\": \"707d8c0a2675e75b3e62e847098f91fd398ba821\", \"content_browsertests\": \"63be04899d694e23e4e075d8ef16ddcd0e8dd632\", \"content_unittests\": \"723ff384d8f4b8e63c01a53ed6341f769b1bd63e\", \"crypto_unittests\": \"fc2b0aa150b1669d306a0c79f5d03f9e70b82b9c\", \"dbus_unittests\": \"ed2fce31b01a0acfbe4ac0989f25d84fdadc9e03\", \"device_unittests\": \"1f8e04b39ff68e711006307f7f5cedf091402c61\", \"display_unittests\": \"959469dc194cc09bda85c478a88b3baceb458007\", \"events_unittests\": \"9695904b59b9ab29f79384e1807c845b17be190f\", \"exo_unittests\": \"c3f082dcf23539a9147f2d4e8e7e74887d10fcdb\", \"extensions_browsertests\": \"fc5a1472302db636b5114d06d1dcf52ea96c66cd\", \"extensions_unittests\": \"db2a6dc7ee7f9c19f24224336197d615ad13a3ce\", \"filesystem_service_unittests\": \"ceb75ab74f601c821aa2ba5226141fd3f719d90d\", \"gcm_unit_tests\": \"e4b73a97067ed023f9515d2ae1e2850b2be8f52e\", \"gfx_unittests\": \"9ebb4737c4227cf4ed6d16f912b70913b7facdaa\", \"gin_unittests\": \"3b0b4abb4d1d0abaada3e200ba9275994356e4b5\", \"gl_unittests_ozone\": \"26f4007f61b98fe7223af52acbe157f56bf95be3\", \"google_apis_unittests\": \"f1a285d89727db763421b674abc477f19683ff68\", \"gpu_unittests\": \"4d7e1ebcced05b01f174249fa5592173ba7472f9\", \"gwp_asan_unittests\": \"c7989da2d7c1e7e6878c596da58c5c821c69cd56\", \"interactive_ui_tests\": \"d9db20f2fdb4ea5048f4f91bfe2f167af2c6336e\", \"ipc_tests\": \"6eaeb4cf7bd75a54721c4c0ea5b4b479ef4790c6\", \"jingle_unittests\": \"a03097bdd4976b80ee81969c724dcfc335d32c01\", \"keyboard_unittests\": \"72eba9ff1352bf9bc4220b766ebc7f61ff95d999\", \"latency_unittests\": \"8f88f453cd72cf5b2a781b9a84325bc06b3d743f\", \"libjingle_xmpp_unittests\": \"b2619baee2488a9432f18306fc5b9ef6e78c1e44\", \"liburlpattern_unittests\": \"2aa1c65cb61b7b68305924942b37d3a604707f7e\", \"media_blink_unittests\": \"e2e5737ba61d8985253634ae1d0ba36dd2b46640\", \"media_unittests\": \"b28794eb9258788a387ec8a1198f7c23e425b902\", \"message_center_unittests\": \"2c0c5677ca1cc37fbc0451d37534a38a6546a8d1\", \"midi_unittests\": \"b1409d7df2d20bcb61c34802f6522044d2880189\", \"mojo_core_unittests\": \"808c162297706908cb416ab41920bd4e6732da6a\", \"mojo_unittests\": \"37838f49328bd5ad0d7e4f5be0ddb1214391a079\", \"nacl_helper_nonsfi_unittests\": \"a0f9f32b13cb406139e43ba37df03b2fc73305aa\", \"nacl_loader_unittests\": \"b8d358488551e9935244b96745cd45a836965d85\", \"native_theme_unittests\": \"4271e81e398d9576b0bdb9537bff99cf340c9ca8\", \"net_unittests\": \"79ce609a8cdf3b3e19641c27f0452c01e3309c59\", \"ozone_gl_unittests\": \"eec583a9b52241d3b1645fb2656465414f772e6c\", \"ozone_unittests\": \"b15112bfbd5a81005f137294f745a56808792c91\", \"ozone_x11_unittests\": \"0a548cab85084b1b9b98ac1ebf2b2873d9dc4810\", \"pdf_unittests\": \"dd1de9f03d2b6c0c09d6b1c54edd4f00b46dff4c\", \"perfetto_unittests\": \"dfe7f5005e6bd267e7452bcb0bb47f4bb1951532\", \"ppapi_unittests\": \"3d554a87c8c3e53b0c8da2da7f94294d190cdf40\", \"printing_unittests\": \"9626d8381b6dcf3f1fd9905abddce780d60a3504\", \"remoting_unittests\": \"3e28c4bf2d8f699dd2ea097ff63137b533b8482a\", \"sandbox_linux_unittests\": \"e354246b2a8e439b8cb78a834cfc976b1fa661b1\", \"service_manager_unittests\": \"7d7e1b2dd5d26315f6f040676c23676a7b24ba30\", \"services_unittests\": \"67c65129a000081b7618bafbfc3df887823006e0\", \"shell_dialogs_unittests\": \"327e83b3ae00f65d009dd9b944452409ac24a4b6\", \"skia_unittests\": \"b63239b64208120b9db0ec9de911c30deb2bd188\", \"snapshot_unittests\": \"743f3754c84df3707d1e29fa78e362871750b3d5\", \"sql_unittests\": \"e3ae27f40b477c7e27a5697c4e5184b63200fbad\", \"storage_unittests\": \"58ce5660b07b5685d4191fb95efcee9abb9aa645\", \"sync_integration_tests\": \"6592a5db2bffff8bb0e25b2c015185935f663965\", \"traffic_annotation_auditor_unittests\": \"de9130c6491308c405659fc6b6757254a1767052\", \"ui_base_unittests\": \"af7177686a89c01709058ad17b26ed6e07162073\", \"ui_chromeos_unittests\": \"ac644885990e868bf60c523e972bf494b985e056\", \"ui_touch_selection_unittests\": \"8e20841c540d78416307015baf2584faba76fe30\", \"unit_tests\": \"5d4cf9a34e051bafc9383e53b13e0d33d5564a9f\", \"url_unittests\": \"38d5ac2ff11295c5734f293885253783f0f90a50\", \"usage_time_limit_unittests\": \"718a0d4163ee1af51bfcf811596ed7168167bc2b\", \"views_unittests\": \"3eb7a68cbdb6ce4eacddbe37b1674f8cfa555b6d\", \"viz_unittests\": \"6509d950f2e0b0ffba23c2f833af75f262e38c51\", \"wm_unittests\": \"a69441856fa277e3ed3bd65e1aa8e25270f1c0be\", \"wtf_unittests\": \"d51ea5ea1d2af9bef52032e324345c66a5133ee2\", \"zlib_unittests\": \"17fb1886c2afbc8d3a7e60741656beeb7f1cdda6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-102-p9wv\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604957706446092",
"status": "COMPLETED",
"status_changed_ts": "1604963838793763",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21228",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4509f70c6dd053a8ff23580c8465d24269c2d5a6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029503650773443056",
"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/8864073585623826160/+/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:4fc7c09dd26e6a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604963838798139",
"url": "https://ci.chromium.org/b/8864073585623826160",
"utcnow_ts": "1604963840185375"
}
}
[23:17:20.208] Invocation finished in 1h42m19.639745587s with status SUCCEEDED