[03:09:35.103] New invocation is queued and will start shortly
[03:09:36.218] Starting the invocation (attempt 1)
[03:09:36.255] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:09:36.255] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:09:36.255] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020332307509640704",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c3b3a253da38cdad5255b66f1f49081c82cb05b8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020332307509640704",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"gitiles_ref:refs/heads/master"
]
}
[03:09:36.930] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613704176355888",
"id": "8854902245532672768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c3b3a253da38cdad5255b66f1f49081c82cb05b8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613704176809212",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22688",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020332307509640704",
"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/8854902245532672768/+/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": "1613704176809332",
"url": "https://ci.chromium.org/b/8854902245532672768",
"utcnow_ts": "1613704176922261"
}
}
[03:09:36.931] Task URL: https://ci.chromium.org/b/8854902245532672768
[03:09:36.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:2:0) after 1m0s
[03:10:05.957] Received PubSub notification, asking Buildbucket for the build status
[03:10:06.046] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:36.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:2:0)
[03:10:36.934] Timer tick, asking Buildbucket for the build status
[03:10:37.002] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:37.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:4:0) after 1m0s
[03:11:37.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:4:0)
[03:11:37.030] Timer tick, asking Buildbucket for the build status
[03:11:37.310] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:37.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:5:0) after 1m0s
[03:12:37.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:5:0)
[03:12:37.412] Timer tick, asking Buildbucket for the build status
[03:12:37.506] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:37.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:6:0) after 1m0s
[03:13:37.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:6:0)
[03:13:37.522] Timer tick, asking Buildbucket for the build status
[03:13:37.608] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:37.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:7:0) after 1m0s
[03:14:37.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:7:0)
[03:14:37.581] Timer tick, asking Buildbucket for the build status
[03:14:37.945] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:8:0) after 1m0s
[03:15:38.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:8:0)
[03:15:38.001] Timer tick, asking Buildbucket for the build status
[03:15:38.103] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:9:0) after 1m0s
[03:16:38.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:9:0)
[03:16:38.243] Timer tick, asking Buildbucket for the build status
[03:16:38.327] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:38.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:10:0) after 1m0s
[03:17:38.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:10:0)
[03:17:38.303] Timer tick, asking Buildbucket for the build status
[03:17:38.371] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:38.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:11:0) after 1m0s
[03:18:38.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:11:0)
[03:18:38.408] Timer tick, asking Buildbucket for the build status
[03:18:38.639] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:38.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:12:0) after 1m0s
[03:19:38.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:12:0)
[03:19:38.684] Timer tick, asking Buildbucket for the build status
[03:19:38.807] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:38.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:13:0) after 1m0s
[03:20:38.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:13:0)
[03:20:38.935] Timer tick, asking Buildbucket for the build status
[03:20:39.176] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:39.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:14:0) after 1m0s
[03:21:39.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:14:0)
[03:21:39.227] Timer tick, asking Buildbucket for the build status
[03:21:39.487] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:39.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:15:0) after 1m0s
[03:22:39.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:15:0)
[03:22:39.538] Timer tick, asking Buildbucket for the build status
[03:22:39.611] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:39.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:16:0) after 1m0s
[03:23:39.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:16:0)
[03:23:39.683] Timer tick, asking Buildbucket for the build status
[03:23:39.757] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:39.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:17:0) after 1m0s
[03:24:39.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:17:0)
[03:24:39.794] Timer tick, asking Buildbucket for the build status
[03:24:39.884] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:39.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:18:0) after 1m0s
[03:25:39.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:18:0)
[03:25:39.947] Timer tick, asking Buildbucket for the build status
[03:25:40.030] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:40.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:19:0) after 1m0s
[03:26:40.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:19:0)
[03:26:40.027] Timer tick, asking Buildbucket for the build status
[03:26:40.108] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:40.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:20:0) after 1m0s
[03:27:40.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:20:0)
[03:27:40.156] Timer tick, asking Buildbucket for the build status
[03:27:40.390] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:40.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:21:0) after 1m0s
[03:28:40.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:21:0)
[03:28:40.486] Timer tick, asking Buildbucket for the build status
[03:28:40.562] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:40.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:22:0) after 1m0s
[03:29:40.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:22:0)
[03:29:40.597] Timer tick, asking Buildbucket for the build status
[03:29:40.729] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:40.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:23:0) after 1m0s
[03:30:40.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:23:0)
[03:30:40.730] Timer tick, asking Buildbucket for the build status
[03:30:42.303] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:42.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:24:0) after 1m0s
[03:31:42.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:24:0)
[03:31:42.307] Timer tick, asking Buildbucket for the build status
[03:31:42.442] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:42.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:25:0) after 1m0s
[03:32:42.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:25:0)
[03:32:42.458] Timer tick, asking Buildbucket for the build status
[03:32:42.541] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:42.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:26:0) after 1m0s
[03:33:42.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:26:0)
[03:33:42.546] Timer tick, asking Buildbucket for the build status
[03:33:42.626] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:42.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:27:0) after 1m0s
[03:34:42.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:27:0)
[03:34:42.647] Timer tick, asking Buildbucket for the build status
[03:34:43.005] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:43.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:28:0) after 1m0s
[03:35:43.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:28:0)
[03:35:43.008] Timer tick, asking Buildbucket for the build status
[03:35:43.083] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:43.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:29:0) after 1m0s
[03:36:43.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:29:0)
[03:36:43.096] Timer tick, asking Buildbucket for the build status
[03:36:43.173] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:43.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:30:0) after 1m0s
[03:37:43.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:30:0)
[03:37:43.196] Timer tick, asking Buildbucket for the build status
[03:37:43.266] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:43.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:31:0) after 1m0s
[03:38:43.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:31:0)
[03:38:43.286] Timer tick, asking Buildbucket for the build status
[03:38:43.602] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:43.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:32:0) after 1m0s
[03:39:43.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:32:0)
[03:39:43.734] Timer tick, asking Buildbucket for the build status
[03:39:43.844] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:43.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:33:0) after 1m0s
[03:40:43.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:33:0)
[03:40:43.967] Timer tick, asking Buildbucket for the build status
[03:40:44.055] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:44.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:34:0) after 1m0s
[03:41:44.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:34:0)
[03:41:44.217] Timer tick, asking Buildbucket for the build status
[03:41:44.296] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:44.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:35:0) after 1m0s
[03:42:44.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:35:0)
[03:42:44.398] Timer tick, asking Buildbucket for the build status
[03:42:44.500] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:44.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:36:0) after 1m0s
[03:43:44.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:36:0)
[03:43:44.553] Timer tick, asking Buildbucket for the build status
[03:43:44.800] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:44.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:37:0) after 1m0s
[03:44:44.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:37:0)
[03:44:44.867] Timer tick, asking Buildbucket for the build status
[03:44:44.968] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:44.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:38:0) after 1m0s
[03:45:45.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:38:0)
[03:45:45.065] Timer tick, asking Buildbucket for the build status
[03:45:45.138] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:45.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:39:0) after 1m0s
[03:46:45.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:39:0)
[03:46:45.158] Timer tick, asking Buildbucket for the build status
[03:46:45.303] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:45.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:40:0) after 1m0s
[03:47:45.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:40:0)
[03:47:45.361] Timer tick, asking Buildbucket for the build status
[03:47:45.436] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:45.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:41:0) after 1m0s
[03:48:45.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:41:0)
[03:48:45.460] Timer tick, asking Buildbucket for the build status
[03:48:45.547] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:45.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:42:0) after 1m0s
[03:49:45.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:42:0)
[03:49:45.571] Timer tick, asking Buildbucket for the build status
[03:49:45.661] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:45.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:43:0) after 1m0s
[03:50:45.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:43:0)
[03:50:45.682] Timer tick, asking Buildbucket for the build status
[03:50:45.847] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:45.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:44:0) after 1m0s
[03:51:45.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:44:0)
[03:51:45.825] Timer tick, asking Buildbucket for the build status
[03:51:45.914] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:45.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:45:0) after 1m0s
[03:52:45.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:45:0)
[03:52:45.916] Timer tick, asking Buildbucket for the build status
[03:52:45.997] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:45.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:46:0) after 1m0s
[03:53:46.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:46:0)
[03:53:46.064] Timer tick, asking Buildbucket for the build status
[03:53:46.301] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:47:0) after 1m0s
[03:54:46.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:47:0)
[03:54:46.305] Timer tick, asking Buildbucket for the build status
[03:54:46.542] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:46.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:48:0) after 1m0s
[03:55:46.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:48:0)
[03:55:46.555] Timer tick, asking Buildbucket for the build status
[03:55:46.647] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:46.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:49:0) after 1m0s
[03:56:46.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:49:0)
[03:56:46.746] Timer tick, asking Buildbucket for the build status
[03:56:46.811] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:46.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:50:0) after 1m0s
[03:57:46.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:50:0)
[03:57:46.862] Timer tick, asking Buildbucket for the build status
[03:57:46.930] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:46.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:51:0) after 1m0s
[03:58:46.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:51:0)
[03:58:46.969] Timer tick, asking Buildbucket for the build status
[03:58:47.035] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:47.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:52:0) after 1m0s
[03:59:47.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:52:0)
[03:59:47.160] Timer tick, asking Buildbucket for the build status
[03:59:47.242] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:47.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:53:0) after 1m0s
[04:00:47.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:53:0)
[04:00:47.341] Timer tick, asking Buildbucket for the build status
[04:00:47.436] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:47.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:54:0) after 1m0s
[04:01:47.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:54:0)
[04:01:47.470] Timer tick, asking Buildbucket for the build status
[04:01:47.568] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:47.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:55:0) after 1m0s
[04:02:47.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:55:0)
[04:02:47.674] Timer tick, asking Buildbucket for the build status
[04:02:47.768] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:56:0) after 1m0s
[04:03:47.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:56:0)
[04:03:47.795] Timer tick, asking Buildbucket for the build status
[04:03:47.892] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:47.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:57:0) after 1m0s
[04:04:47.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:57:0)
[04:04:47.933] Timer tick, asking Buildbucket for the build status
[04:04:48.073] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:48.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:58:0) after 1m0s
[04:05:48.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:58:0)
[04:05:48.119] Timer tick, asking Buildbucket for the build status
[04:05:48.202] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:48.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:59:0) after 1m0s
[04:06:48.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:59:0)
[04:06:48.273] Timer tick, asking Buildbucket for the build status
[04:06:48.357] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:48.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:60:0) after 1m0s
[04:07:48.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:60:0)
[04:07:48.385] Timer tick, asking Buildbucket for the build status
[04:07:48.465] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:61:0) after 1m0s
[04:08:48.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:61:0)
[04:08:48.531] Timer tick, asking Buildbucket for the build status
[04:08:48.662] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:48.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:62:0) after 1m0s
[04:09:48.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:62:0)
[04:09:48.711] Timer tick, asking Buildbucket for the build status
[04:09:48.862] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:48.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:63:0) after 1m0s
[04:10:48.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:63:0)
[04:10:48.892] Timer tick, asking Buildbucket for the build status
[04:10:49.212] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:49.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:64:0) after 1m0s
[04:11:49.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:64:0)
[04:11:49.241] Timer tick, asking Buildbucket for the build status
[04:11:49.342] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:49.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:65:0) after 1m0s
[04:12:49.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:65:0)
[04:12:49.406] Timer tick, asking Buildbucket for the build status
[04:12:49.498] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:49.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:66:0) after 1m0s
[04:13:50.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:66:0)
[04:13:50.348] Timer tick, asking Buildbucket for the build status
[04:13:50.495] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:50.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:67:0) after 1m0s
[04:14:50.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:67:0)
[04:14:50.596] Timer tick, asking Buildbucket for the build status
[04:14:50.702] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:50.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:68:0) after 1m0s
[04:15:50.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:68:0)
[04:15:50.749] Timer tick, asking Buildbucket for the build status
[04:15:51.018] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:51.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:69:0) after 1m0s
[04:16:51.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:69:0)
[04:16:51.186] Timer tick, asking Buildbucket for the build status
[04:16:51.296] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:51.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:70:0) after 1m0s
[04:17:51.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:70:0)
[04:17:51.422] Timer tick, asking Buildbucket for the build status
[04:17:51.897] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:51.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:71:0) after 1m0s
[04:18:51.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:71:0)
[04:18:51.926] Timer tick, asking Buildbucket for the build status
[04:18:52.165] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:52.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:72:0) after 1m0s
[04:19:52.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:72:0)
[04:19:52.187] Timer tick, asking Buildbucket for the build status
[04:19:52.307] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:52.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:73:0) after 1m0s
[04:20:52.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:73:0)
[04:20:52.312] Timer tick, asking Buildbucket for the build status
[04:20:52.409] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:52.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:74:0) after 1m0s
[04:21:52.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:74:0)
[04:21:52.432] Timer tick, asking Buildbucket for the build status
[04:21:52.511] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:52.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:75:0) after 1m0s
[04:22:52.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:75:0)
[04:22:52.563] Timer tick, asking Buildbucket for the build status
[04:22:52.724] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:52.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:76:0) after 1m0s
[04:23:52.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:76:0)
[04:23:52.790] Timer tick, asking Buildbucket for the build status
[04:23:53.216] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:53.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:77:0) after 1m0s
[04:24:53.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:77:0)
[04:24:53.310] Timer tick, asking Buildbucket for the build status
[04:24:53.418] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:53.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:78:0) after 1m0s
[04:25:53.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:78:0)
[04:25:53.495] Timer tick, asking Buildbucket for the build status
[04:25:53.575] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:53.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:79:0) after 1m0s
[04:26:53.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:79:0)
[04:26:53.628] Timer tick, asking Buildbucket for the build status
[04:26:54.120] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:54.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:80:0) after 1m0s
[04:27:54.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:80:0)
[04:27:54.188] Timer tick, asking Buildbucket for the build status
[04:27:54.272] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:54.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:81:0) after 1m0s
[04:28:54.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:81:0)
[04:28:54.371] Timer tick, asking Buildbucket for the build status
[04:28:54.679] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:54.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:82:0) after 1m0s
[04:29:54.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:82:0)
[04:29:54.702] Timer tick, asking Buildbucket for the build status
[04:29:54.815] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:54.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:83:0) after 1m0s
[04:30:54.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:83:0)
[04:30:54.905] Timer tick, asking Buildbucket for the build status
[04:30:54.985] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:54.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:84:0) after 1m0s
[04:31:55.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:84:0)
[04:31:55.035] Timer tick, asking Buildbucket for the build status
[04:31:55.212] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:55.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:85:0) after 1m0s
[04:32:55.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:85:0)
[04:32:55.298] Timer tick, asking Buildbucket for the build status
[04:32:56.296] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:56.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:86:0) after 1m0s
[04:33:56.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:86:0)
[04:33:56.334] Timer tick, asking Buildbucket for the build status
[04:33:56.682] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:56.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:87:0) after 1m0s
[04:34:56.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:87:0)
[04:34:56.707] Timer tick, asking Buildbucket for the build status
[04:34:56.819] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:56.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:88:0) after 1m0s
[04:35:56.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:88:0)
[04:35:56.840] Timer tick, asking Buildbucket for the build status
[04:35:56.954] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:89:0) after 1m0s
[04:36:56.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:89:0)
[04:36:56.969] Timer tick, asking Buildbucket for the build status
[04:36:57.078] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:57.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:90:0) after 1m0s
[04:37:57.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:90:0)
[04:37:57.149] Timer tick, asking Buildbucket for the build status
[04:37:57.307] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:57.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:91:0) after 1m0s
[04:38:57.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:91:0)
[04:38:57.384] Timer tick, asking Buildbucket for the build status
[04:38:57.468] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:57.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:92:0) after 1m0s
[04:39:57.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:92:0)
[04:39:57.496] Timer tick, asking Buildbucket for the build status
[04:39:57.666] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:57.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:93:0) after 1m0s
[04:40:57.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:93:0)
[04:40:57.650] Timer tick, asking Buildbucket for the build status
[04:40:57.738] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:57.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:94:0) after 1m0s
[04:41:57.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:94:0)
[04:41:57.826] Timer tick, asking Buildbucket for the build status
[04:41:57.908] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:57.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:95:0) after 1m0s
[04:42:57.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:95:0)
[04:42:57.930] Timer tick, asking Buildbucket for the build status
[04:42:58.025] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:58.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:96:0) after 1m0s
[04:43:58.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:96:0)
[04:43:58.098] Timer tick, asking Buildbucket for the build status
[04:43:58.185] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:58.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:97:0) after 1m0s
[04:44:58.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:97:0)
[04:44:58.175] Timer tick, asking Buildbucket for the build status
[04:44:58.623] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:58.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:98:0) after 1m0s
[04:45:58.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:98:0)
[04:45:58.652] Timer tick, asking Buildbucket for the build status
[04:45:58.737] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:99:0) after 1m0s
[04:46:58.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:99:0)
[04:46:58.766] Timer tick, asking Buildbucket for the build status
[04:46:59.253] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:59.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:100:0) after 1m0s
[04:47:59.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:100:0)
[04:47:59.308] Timer tick, asking Buildbucket for the build status
[04:47:59.649] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:59.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:101:0) after 1m0s
[04:48:59.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:101:0)
[04:48:59.672] Timer tick, asking Buildbucket for the build status
[04:48:59.764] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:59.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:102:0) after 1m0s
[04:49:59.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:102:0)
[04:49:59.806] Timer tick, asking Buildbucket for the build status
[04:49:59.903] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:59.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:103:0) after 1m0s
[04:51:00.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:103:0)
[04:51:00.011] Timer tick, asking Buildbucket for the build status
[04:51:00.154] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:00.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:104:0) after 1m0s
[04:52:00.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:104:0)
[04:52:00.210] Timer tick, asking Buildbucket for the build status
[04:52:00.357] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:00.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:105:0) after 1m0s
[04:53:00.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:105:0)
[04:53:00.394] Timer tick, asking Buildbucket for the build status
[04:53:00.664] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:00.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:106:0) after 1m0s
[04:54:00.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:106:0)
[04:54:00.728] Timer tick, asking Buildbucket for the build status
[04:54:00.843] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:00.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:107:0) after 1m0s
[04:55:01.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:107:0)
[04:55:01.556] Timer tick, asking Buildbucket for the build status
[04:55:01.703] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:01.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:108:0) after 1m0s
[04:56:01.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:108:0)
[04:56:01.737] Timer tick, asking Buildbucket for the build status
[04:56:02.434] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:02.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:109:0) after 1m0s
[04:57:02.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:109:0)
[04:57:02.508] Timer tick, asking Buildbucket for the build status
[04:57:02.655] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:02.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:110:0) after 1m0s
[04:58:02.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:110:0)
[04:58:02.866] Timer tick, asking Buildbucket for the build status
[04:58:03.085] Build 8854902245532672768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:03.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020332307509640704:111:0) after 1m0s
[04:58:28.271] Received PubSub notification, asking Buildbucket for the build status
[04:58:28.381] Build 8854902245532672768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:58:28.381] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613710706215364",
"created_by": "project:chromium",
"created_ts": "1613704176355888",
"id": "8854902245532672768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c3b3a253da38cdad5255b66f1f49081c82cb05b8\"}}",
"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\": \"c3b3a253da38cdad5255b66f1f49081c82cb05b8\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-72-ef90\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22688, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"1024d6e1873cd12280b6d43a78f779a108d57320\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"c3b3a253da38cdad5255b66f1f49081c82cb05b8\", \"got_revision_cp\": \"refs/heads/master@{#855604}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"c3b3a253da38cdad5255b66f1f49081c82cb05b8\", \"swarm_hashes_refs/heads/master(at){#855604}_without_patch\": {\"absl_hardening_tests\": \"08d529fd8efef657c31d7b0b5b47a7490516f6fd\", \"accessibility_unittests\": \"de27a0de7bbc4fbe5f524fd21eb748d66a6a509b\", \"angle_unittests\": \"7353e96793c61289140d7a94fb3873ffde15e279\", \"app_list_unittests\": \"7b95513a74a06ded7ddb1d7960a731575a4abcdf\", \"app_shell_unittests\": \"48c1e567de378099f5ee437646060dc5c2fb9df9\", \"ash_unittests\": \"c599a3e87b9965f8061536117ae04fba897b9302\", \"aura_unittests\": \"64a230b72bc504d221f928d3a4eb790913f7b29e\", \"base_unittests\": \"e1858bb971d594364ea6983f4d25d9095c770881\", \"base_util_unittests\": \"e10749f7f8c3ec00ac4666d738c6b4767940487d\", \"blink_common_unittests\": \"c7ad6db44a4ee27548f48f363662e47aa272cf1a\", \"blink_fuzzer_unittests\": \"8fc7bb3aacce8bcdeff427eac471eba7cf001ef6\", \"blink_heap_unittests\": \"946e96e0fac5521b3a25d19a81535a5ec33f059a\", \"blink_platform_unittests\": \"684e4c7baab2538da21a6bb039a6605c3c4cf427\", \"blink_unittests\": \"966522c7247360d5416bc56c81f8b8020f585e2a\", \"boringssl_crypto_tests\": \"2b08dd083e7d93921cd02b3f2dac198046e06483\", \"boringssl_ssl_tests\": \"3d0609a354d2721560f9b03acbcadbf828bf986a\", \"browser_tests\": \"0bdadc5d8e7c433178a1e8ff92058dc8e35425c3\", \"capture_unittests\": \"a9c7ed4ec6762313e17f04e3b34dc3935569418c\", \"cast_unittests\": \"bdf784737677be3419fec5ad76e59e594658c15c\", \"cc_unittests\": \"08f88140ce248d8629a12841c7671ab29ea9e6ec\", \"chrome_app_unittests\": \"b9583499acf83f002dbc58580f66baefb912aded\", \"chromedriver_unittests\": \"9e9382eb9672e5754e822eef5b685fad9857efbd\", \"chromeos_components_unittests\": \"58dfb9d184686e2e41a91b2abf066d950257794c\", \"chromeos_unittests\": \"04dfe3d52594a39aa891f2c7a79c0f3d178f8a07\", \"components_browsertests\": \"d4e4dfa20e233c581f2feb7d76ae2c51b3d9b3b1\", \"components_unittests\": \"ed7379097f32ce29661633c5684ed226296b5d6d\", \"compositor_unittests\": \"ef006eb81157e8b82845247a8cd872f78e19624f\", \"content_browsertests\": \"5a55b644cf647a8167fa1d1af7e7f8e20023e8ef\", \"content_unittests\": \"d0feb7077907adc2bcc9cd569c519a6ab2b4b5cc\", \"crashpad_tests\": \"27997f45133f02f064b3b6a23f29235ffa96ebbb\", \"crypto_unittests\": \"379e433c63d1c03a3203eca7c04be5def2a2a003\", \"dbus_unittests\": \"c542855bf1b345d7461592a1e22a6780ab7a0133\", \"device_unittests\": \"e0d69af159b5038c64f5ec98ae3144afd853c68d\", \"display_unittests\": \"75517ae650b6e6320166e90616154350073eac85\", \"events_unittests\": \"10f6e8c88e095b541b6a56f1d15756519becae74\", \"exo_unittests\": \"4bba59de188222f7150693ae475dc25c10095e43\", \"extensions_browsertests\": \"0578d886f0011f91630388e010e86bd78e678598\", \"extensions_unittests\": \"2589b4b6f24b911599e216042ea43b468d66be8f\", \"filesystem_service_unittests\": \"e87fbcab74702f9d2a29ea675001da746e297b8c\", \"gcm_unit_tests\": \"bd71e28474051c5c50487ab6e4bc92e1e291b509\", \"gfx_unittests\": \"237eeeecd035685f6cceeb9fc2ed537a36d98268\", \"gin_unittests\": \"fee90a19e5793c4346caf4e04b2b81afaf7f2323\", \"gl_unittests_ozone\": \"39c39f361a0294cf2329e5fff080944a9d4b7db4\", \"google_apis_unittests\": \"ae6b5ae49d8b14c565287518774037dcc211a9b0\", \"gpu_unittests\": \"e6c703505f921b268c5b04157dd4b5598bf00108\", \"gwp_asan_unittests\": \"97d54cf59399b18ec23c240079df03051f6ca312\", \"interactive_ui_tests\": \"adf7ff980a8c8cd0c1632306e6206237c28ebb60\", \"ipc_tests\": \"73acffccf83a7a75241c08d595fe78fa578761ed\", \"jingle_unittests\": \"705b377bc7e0fdecdda9f464311f7fa50f535263\", \"keyboard_unittests\": \"372ffc3fcd507fa9c055b038c6c43ddf5d9fc0e0\", \"latency_unittests\": \"252f63af5a7edef2639d6fb9f91acfa5e2340e67\", \"libjingle_xmpp_unittests\": \"ce8a634e235ae6dec148822a1461d390209edfab\", \"liburlpattern_unittests\": \"e634211c6dfb4a7524649139af8881578fae15d2\", \"media_blink_unittests\": \"831a0990cf2034e50a5f38f8002bad99ba686e5b\", \"media_unittests\": \"c5c274340fd23455cd75f91f4845316669cdba36\", \"message_center_unittests\": \"fa13648a5a7a89995fbd12913b95000a62090754\", \"midi_unittests\": \"95cdb153522ad141c098f3985b76d5554eaf6632\", \"mojo_core_unittests\": \"b7f70cec2bdfbacc73c6f6a99c8b45f156d51a09\", \"mojo_unittests\": \"af1cb56c90fe5421822cbc8aa09f4e2d90f0614b\", \"nacl_helper_nonsfi_unittests\": \"2ef6d946829815e6ac61a5b88544a5d895f5f6c4\", \"nacl_loader_unittests\": \"710af6b5c58040ac8288dda1ec52c4e50585347c\", \"native_theme_unittests\": \"3fbc1e9f00bea563e56ca1d31bbb9646fc96e4fa\", \"net_unittests\": \"b81c5ea0839c668636d8031763fad7c5a5587849\", \"ozone_gl_unittests\": \"e8be4ccfd1c3956725256acbcf46f749655debcd\", \"ozone_unittests\": \"9545e7c8ebf2a0f4c803c7854863c0822c17e722\", \"ozone_x11_unittests\": \"02183b5ea1b88964fa99f98ba00093652059fcd0\", \"pdf_unittests\": \"9caef495d57774620a943e291c163dad5b85ed1a\", \"perfetto_unittests\": \"18193b565bdd4f23c104f3e6a4db17718ef047b8\", \"ppapi_unittests\": \"4d23f2273119b3bba1fa185d5aa742ffa4ad01af\", \"printing_unittests\": \"68f8f92e7a26bc62c06c5709be0166de602457ce\", \"remoting_unittests\": \"f2c273d006f899a425a592223c8cc90be8810c44\", \"sandbox_linux_unittests\": \"acc1529146a2f3168889148bda6b1ada57728269\", \"service_manager_unittests\": \"0844c76f5129ffa7a5d55ab471559bb4f47fa32f\", \"services_unittests\": \"286e79a9c738ab3d37bbf967f81df439fe35941f\", \"shell_dialogs_unittests\": \"c033336de6bc9d753c25ce90773665a358e2fa89\", \"shell_encryption_unittests\": \"b7cc01f722e072dbfc8ed97c2f96ddbe811c856d\", \"skia_unittests\": \"4fc4918dc71bb9bffbb6ca44deac92cdc1c231ce\", \"snapshot_unittests\": \"6e08642b544c641e79d1ebf7e4512c82f1aeacd0\", \"sql_unittests\": \"d4b3c54351c74c083edbb09b9194e2aa5767b9ac\", \"storage_unittests\": \"6f630b19efc3770a217fe3b3688bc91caca87ce3\", \"sync_integration_tests\": \"35cce5a005cb3fbddb9af2b322f6ab1514fc8dbb\", \"traffic_annotation_auditor_unittests\": \"d6d96edcaf4a2b160eba0d05b8cb1caa7e410c2e\", \"ui_base_unittests\": \"508bc6e47e270df0e2e98ea5e865cf9f756df02b\", \"ui_chromeos_unittests\": \"d0cb004d4f34c7cd6fd96f1bb6487dca3b8c418a\", \"ui_touch_selection_unittests\": \"d81fe106b85fb0a736acdcf29edac3d5a9dacbc5\", \"unit_tests\": \"83c99d7240344449acae88353a3f9dc947adcee3\", \"url_unittests\": \"5c9a9c37476b44d502ad17570ec02dc09189c761\", \"usage_time_limit_unittests\": \"691a46246e4a02b0da093f7e292da393060ef6f4\", \"views_unittests\": \"9bcf2fe4ad2ba0310fee755074cdcb0dfe65b081\", \"viz_unittests\": \"05a41d3e32260fccf5b2261e51b118d379be602b\", \"wm_unittests\": \"62b48fcf1ced7f63fff6cf786ab3283a850e78b8\", \"wtf_unittests\": \"d978439bc96b7c4c9c36dbc1b02b48fc0d8649a0\", \"zlib_unittests\": \"1f3118f3c08623fba20d16dbd68cf9ffb28f9639\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_279625ee090c361ea8cf031374b7b020d1191c526e0ef1068ab634999c69ee70_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_a6d905fb3e765cf980c6458181cc20495ddb667b30aa758edddbed3b46166dd6_v2\", \"builder_b14893b55edaf5e4dad6913e524bd3694194da568bc8f7a76820eff0afe1bec5_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-72-ef90\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613704205356901",
"status": "COMPLETED",
"status_changed_ts": "1613710706542764",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22688",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3b3a253da38cdad5255b66f1f49081c82cb05b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020332307509640704",
"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/8854902245532672768/+/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:51d1152dc8144410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613710706547584",
"url": "https://ci.chromium.org/b/8854902245532672768",
"utcnow_ts": "1613710708372467"
}
}
[04:58:28.381] Invocation finished in 1h48m53.294905562s with status SUCCEEDED