[12:34:59.348] New invocation is queued and will start shortly
[12:35:01.266] Starting the invocation (attempt 1)
[12:35:01.306] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:35:01.306] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:35:01.306] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021927480756065824",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f1916dbb9a5f0b983ab2c84763446f28ee819b16\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021927480756065824",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"gitiles_ref:refs/heads/master"
]
}
[12:35:02.247] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612182901430315",
"id": "8856497417908476000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1916dbb9a5f0b983ab2c84763446f28ee819b16\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612182902054189",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22429",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021927480756065824",
"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/8856497417908476000/+/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": "1612182902054295",
"url": "https://ci.chromium.org/b/8856497417908476000",
"utcnow_ts": "1612182902239211"
}
}
[12:35:02.247] Task URL: https://ci.chromium.org/b/8856497417908476000
[12:35:02.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:2:0) after 1m0s
[12:36:02.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:2:0)
[12:36:02.237] Timer tick, asking Buildbucket for the build status
[12:36:02.546] Build 8856497417908476000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:36:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:3:0) after 1m0s
[12:37:02.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:3:0)
[12:37:02.569] Timer tick, asking Buildbucket for the build status
[12:37:02.668] Build 8856497417908476000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:37:02.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:4:0) after 1m0s
[12:38:02.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:4:0)
[12:38:02.732] Timer tick, asking Buildbucket for the build status
[12:38:02.844] Build 8856497417908476000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:02.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:5:0) after 1m0s
[12:39:02.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:5:0)
[12:39:02.941] Timer tick, asking Buildbucket for the build status
[12:39:03.138] Build 8856497417908476000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:6:0) after 1m0s
[12:40:03.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:6:0)
[12:40:03.183] Timer tick, asking Buildbucket for the build status
[12:40:03.613] Build 8856497417908476000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:03.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:7:0) after 1m0s
[12:40:11.793] Received PubSub notification, asking Buildbucket for the build status
[12:40:12.093] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:03.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:7:0)
[12:41:03.807] Timer tick, asking Buildbucket for the build status
[12:41:04.028] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:04.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:9:0) after 1m0s
[12:42:04.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:9:0)
[12:42:04.102] Timer tick, asking Buildbucket for the build status
[12:42:04.201] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:04.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:10:0) after 1m0s
[12:43:04.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:10:0)
[12:43:04.352] Timer tick, asking Buildbucket for the build status
[12:43:04.651] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:04.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:11:0) after 1m0s
[12:44:04.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:11:0)
[12:44:04.695] Timer tick, asking Buildbucket for the build status
[12:44:04.756] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:04.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:12:0) after 1m0s
[12:45:04.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:12:0)
[12:45:04.852] Timer tick, asking Buildbucket for the build status
[12:45:04.961] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:04.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:13:0) after 1m0s
[12:46:04.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:13:0)
[12:46:04.999] Timer tick, asking Buildbucket for the build status
[12:46:05.076] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:14:0) after 1m0s
[12:47:05.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:14:0)
[12:47:05.112] Timer tick, asking Buildbucket for the build status
[12:47:05.183] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:05.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:15:0) after 1m0s
[12:48:05.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:15:0)
[12:48:05.240] Timer tick, asking Buildbucket for the build status
[12:48:05.342] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:05.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:16:0) after 1m0s
[12:49:05.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:16:0)
[12:49:05.427] Timer tick, asking Buildbucket for the build status
[12:49:05.584] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:05.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:17:0) after 1m0s
[12:50:05.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:17:0)
[12:50:05.780] Timer tick, asking Buildbucket for the build status
[12:50:06.828] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:06.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:18:0) after 1m0s
[12:51:06.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:18:0)
[12:51:06.855] Timer tick, asking Buildbucket for the build status
[12:51:06.925] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:06.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:19:0) after 1m0s
[12:52:07.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:19:0)
[12:52:07.440] Timer tick, asking Buildbucket for the build status
[12:52:07.619] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:07.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:20:0) after 1m0s
[12:53:07.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:20:0)
[12:53:07.693] Timer tick, asking Buildbucket for the build status
[12:53:07.755] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:07.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:21:0) after 1m0s
[12:54:07.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:21:0)
[12:54:07.806] Timer tick, asking Buildbucket for the build status
[12:54:08.776] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:22:0) after 1m0s
[12:55:08.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:22:0)
[12:55:08.798] Timer tick, asking Buildbucket for the build status
[12:55:08.886] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:08.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:23:0) after 1m0s
[12:56:08.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:23:0)
[12:56:08.908] Timer tick, asking Buildbucket for the build status
[12:56:08.989] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:08.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:24:0) after 1m0s
[12:57:09.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:24:0)
[12:57:09.087] Timer tick, asking Buildbucket for the build status
[12:57:09.259] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:09.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:25:0) after 1m0s
[12:58:09.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:25:0)
[12:58:09.329] Timer tick, asking Buildbucket for the build status
[12:58:09.402] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:09.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:26:0) after 1m0s
[12:59:09.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:26:0)
[12:59:09.466] Timer tick, asking Buildbucket for the build status
[12:59:09.556] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:09.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:27:0) after 1m0s
[13:00:09.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:27:0)
[13:00:09.666] Timer tick, asking Buildbucket for the build status
[13:00:09.834] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:09.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:28:0) after 1m0s
[13:01:10.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:28:0)
[13:01:10.589] Timer tick, asking Buildbucket for the build status
[13:01:10.817] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:10.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:29:0) after 1m0s
[13:02:10.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:29:0)
[13:02:10.917] Timer tick, asking Buildbucket for the build status
[13:02:11.009] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:11.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:30:0) after 1m0s
[13:03:11.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:30:0)
[13:03:11.025] Timer tick, asking Buildbucket for the build status
[13:03:11.075] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:11.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:31:0) after 1m0s
[13:04:11.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:31:0)
[13:04:11.139] Timer tick, asking Buildbucket for the build status
[13:04:11.423] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:11.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:32:0) after 1m0s
[13:05:11.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:32:0)
[13:05:11.508] Timer tick, asking Buildbucket for the build status
[13:05:11.702] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:11.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:33:0) after 1m0s
[13:06:11.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:33:0)
[13:06:11.771] Timer tick, asking Buildbucket for the build status
[13:06:12.305] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:12.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:34:0) after 1m0s
[13:07:12.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:34:0)
[13:07:12.381] Timer tick, asking Buildbucket for the build status
[13:07:12.456] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:12.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:35:0) after 1m0s
[13:08:12.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:35:0)
[13:08:12.487] Timer tick, asking Buildbucket for the build status
[13:08:12.582] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:12.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:36:0) after 1m0s
[13:09:12.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:36:0)
[13:09:12.595] Timer tick, asking Buildbucket for the build status
[13:09:12.657] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:12.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:37:0) after 1m0s
[13:10:12.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:37:0)
[13:10:12.700] Timer tick, asking Buildbucket for the build status
[13:10:12.831] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:12.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:38:0) after 1m0s
[13:11:12.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:38:0)
[13:11:12.827] Timer tick, asking Buildbucket for the build status
[13:11:12.907] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:12.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:39:0) after 1m0s
[13:12:12.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:39:0)
[13:12:12.957] Timer tick, asking Buildbucket for the build status
[13:12:13.047] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:13.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:40:0) after 1m0s
[13:13:13.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:40:0)
[13:13:13.212] Timer tick, asking Buildbucket for the build status
[13:13:13.294] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:13.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:41:0) after 1m0s
[13:14:13.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:41:0)
[13:14:13.320] Timer tick, asking Buildbucket for the build status
[13:14:13.392] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:13.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:42:0) after 1m0s
[13:15:13.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:42:0)
[13:15:13.550] Timer tick, asking Buildbucket for the build status
[13:15:13.704] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:13.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:43:0) after 1m0s
[13:16:13.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:43:0)
[13:16:13.805] Timer tick, asking Buildbucket for the build status
[13:16:13.864] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:13.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:44:0) after 1m0s
[13:17:13.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:44:0)
[13:17:13.940] Timer tick, asking Buildbucket for the build status
[13:17:14.004] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:14.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:45:0) after 1m0s
[13:18:14.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:45:0)
[13:18:14.028] Timer tick, asking Buildbucket for the build status
[13:18:14.096] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:46:0) after 1m0s
[13:19:14.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:46:0)
[13:19:14.145] Timer tick, asking Buildbucket for the build status
[13:19:14.215] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:14.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:47:0) after 1m0s
[13:20:14.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:47:0)
[13:20:14.309] Timer tick, asking Buildbucket for the build status
[13:20:14.439] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:14.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:48:0) after 1m0s
[13:21:14.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:48:0)
[13:21:14.549] Timer tick, asking Buildbucket for the build status
[13:21:14.625] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:14.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:49:0) after 1m0s
[13:22:14.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:49:0)
[13:22:14.704] Timer tick, asking Buildbucket for the build status
[13:22:14.828] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:14.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:50:0) after 1m0s
[13:23:17.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:50:0)
[13:23:17.202] Timer tick, asking Buildbucket for the build status
[13:23:17.341] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:17.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:51:0) after 1m0s
[13:24:17.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:51:0)
[13:24:17.389] Timer tick, asking Buildbucket for the build status
[13:24:17.476] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:17.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:52:0) after 1m0s
[13:25:17.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:52:0)
[13:25:17.501] Timer tick, asking Buildbucket for the build status
[13:25:17.635] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:17.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:53:0) after 1m0s
[13:26:17.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:53:0)
[13:26:17.783] Timer tick, asking Buildbucket for the build status
[13:26:18.214] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:18.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:54:0) after 1m0s
[13:27:18.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:54:0)
[13:27:18.314] Timer tick, asking Buildbucket for the build status
[13:27:18.424] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:18.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:55:0) after 1m0s
[13:28:18.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:55:0)
[13:28:18.477] Timer tick, asking Buildbucket for the build status
[13:28:18.572] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:18.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:56:0) after 1m0s
[13:29:18.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:56:0)
[13:29:18.617] Timer tick, asking Buildbucket for the build status
[13:29:18.789] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:18.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:57:0) after 1m0s
[13:30:18.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:57:0)
[13:30:18.871] Timer tick, asking Buildbucket for the build status
[13:30:18.980] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:18.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:58:0) after 1m0s
[13:31:19.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:58:0)
[13:31:19.106] Timer tick, asking Buildbucket for the build status
[13:31:19.176] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:59:0) after 1m0s
[13:32:19.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:59:0)
[13:32:19.360] Timer tick, asking Buildbucket for the build status
[13:32:19.505] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:19.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:60:0) after 1m0s
[13:33:19.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:60:0)
[13:33:19.561] Timer tick, asking Buildbucket for the build status
[13:33:19.688] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:19.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:61:0) after 1m0s
[13:34:19.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:61:0)
[13:34:19.805] Timer tick, asking Buildbucket for the build status
[13:34:20.231] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:20.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:62:0) after 1m0s
[13:35:20.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:62:0)
[13:35:20.419] Timer tick, asking Buildbucket for the build status
[13:35:20.619] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:20.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:63:0) after 1m0s
[13:36:20.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:63:0)
[13:36:20.878] Timer tick, asking Buildbucket for the build status
[13:36:21.081] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:21.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:64:0) after 1m0s
[13:37:21.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:64:0)
[13:37:21.251] Timer tick, asking Buildbucket for the build status
[13:37:21.550] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:21.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:65:0) after 1m0s
[13:38:21.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:65:0)
[13:38:21.783] Timer tick, asking Buildbucket for the build status
[13:38:22.262] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:22.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:66:0) after 1m0s
[13:39:22.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:66:0)
[13:39:22.315] Timer tick, asking Buildbucket for the build status
[13:39:22.551] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:22.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:67:0) after 1m0s
[13:40:22.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:67:0)
[13:40:22.612] Timer tick, asking Buildbucket for the build status
[13:40:22.752] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:22.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:68:0) after 1m0s
[13:41:22.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:68:0)
[13:41:22.814] Timer tick, asking Buildbucket for the build status
[13:41:22.925] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:22.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:69:0) after 1m0s
[13:42:23.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:69:0)
[13:42:23.015] Timer tick, asking Buildbucket for the build status
[13:42:23.120] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:23.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:70:0) after 1m0s
[13:43:23.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:70:0)
[13:43:23.199] Timer tick, asking Buildbucket for the build status
[13:43:23.332] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:23.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:71:0) after 1m0s
[13:44:23.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:71:0)
[13:44:23.391] Timer tick, asking Buildbucket for the build status
[13:44:23.830] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:23.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:72:0) after 1m0s
[13:45:23.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:72:0)
[13:45:23.963] Timer tick, asking Buildbucket for the build status
[13:45:28.482] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:73:0) after 1m0s
[13:46:28.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:73:0)
[13:46:28.575] Timer tick, asking Buildbucket for the build status
[13:46:29.108] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:29.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:74:0) after 1m0s
[13:47:29.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:74:0)
[13:47:29.131] Timer tick, asking Buildbucket for the build status
[13:47:29.338] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:29.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:75:0) after 1m0s
[13:48:29.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:75:0)
[13:48:29.352] Timer tick, asking Buildbucket for the build status
[13:48:29.419] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:29.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:76:0) after 1m0s
[13:49:29.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:76:0)
[13:49:29.421] Timer tick, asking Buildbucket for the build status
[13:49:29.489] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:29.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:77:0) after 1m0s
[13:50:29.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:77:0)
[13:50:29.523] Timer tick, asking Buildbucket for the build status
[13:50:29.865] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:29.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:78:0) after 1m0s
[13:51:29.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:78:0)
[13:51:29.893] Timer tick, asking Buildbucket for the build status
[13:51:29.985] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:29.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:79:0) after 1m0s
[13:52:30.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:79:0)
[13:52:30.047] Timer tick, asking Buildbucket for the build status
[13:52:30.199] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:30.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:80:0) after 1m0s
[13:53:30.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:80:0)
[13:53:30.223] Timer tick, asking Buildbucket for the build status
[13:53:30.302] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:30.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:81:0) after 1m0s
[13:54:30.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:81:0)
[13:54:30.347] Timer tick, asking Buildbucket for the build status
[13:54:30.650] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:30.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:82:0) after 1m0s
[13:55:30.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:82:0)
[13:55:30.687] Timer tick, asking Buildbucket for the build status
[13:55:30.819] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:30.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:83:0) after 1m0s
[13:56:30.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:83:0)
[13:56:30.840] Timer tick, asking Buildbucket for the build status
[13:56:31.128] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:31.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:84:0) after 1m0s
[13:57:31.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:84:0)
[13:57:31.152] Timer tick, asking Buildbucket for the build status
[13:57:31.743] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:31.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:85:0) after 1m0s
[13:58:31.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:85:0)
[13:58:31.806] Timer tick, asking Buildbucket for the build status
[13:58:31.880] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:31.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:86:0) after 1m0s
[13:59:31.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:86:0)
[13:59:31.908] Timer tick, asking Buildbucket for the build status
[13:59:32.016] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:32.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:87:0) after 1m0s
[14:00:32.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:87:0)
[14:00:32.162] Timer tick, asking Buildbucket for the build status
[14:00:33.092] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:33.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:88:0) after 1m0s
[14:01:33.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:88:0)
[14:01:33.117] Timer tick, asking Buildbucket for the build status
[14:01:34.360] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:34.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:89:0) after 1m0s
[14:02:34.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:89:0)
[14:02:34.425] Timer tick, asking Buildbucket for the build status
[14:02:34.764] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:34.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:90:0) after 1m0s
[14:03:34.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:90:0)
[14:03:34.816] Timer tick, asking Buildbucket for the build status
[14:03:34.940] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:34.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:91:0) after 1m0s
[14:04:34.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:91:0)
[14:04:34.959] Timer tick, asking Buildbucket for the build status
[14:04:35.025] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:35.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:92:0) after 1m0s
[14:05:35.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:92:0)
[14:05:35.083] Timer tick, asking Buildbucket for the build status
[14:05:35.442] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:35.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:93:0) after 1m0s
[14:06:35.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:93:0)
[14:06:35.506] Timer tick, asking Buildbucket for the build status
[14:06:35.589] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:35.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:94:0) after 1m0s
[14:07:35.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:94:0)
[14:07:35.769] Timer tick, asking Buildbucket for the build status
[14:07:36.013] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:95:0) after 1m0s
[14:08:36.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:95:0)
[14:08:36.034] Timer tick, asking Buildbucket for the build status
[14:08:36.142] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:36.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:96:0) after 1m0s
[14:09:36.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:96:0)
[14:09:36.181] Timer tick, asking Buildbucket for the build status
[14:09:36.389] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:36.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:97:0) after 1m0s
[14:10:36.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:97:0)
[14:10:36.424] Timer tick, asking Buildbucket for the build status
[14:10:36.563] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:36.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:98:0) after 1m0s
[14:11:36.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:98:0)
[14:11:36.641] Timer tick, asking Buildbucket for the build status
[14:11:36.732] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:99:0) after 1m0s
[14:12:36.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:99:0)
[14:12:36.760] Timer tick, asking Buildbucket for the build status
[14:12:36.913] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:36.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:100:0) after 1m0s
[14:13:36.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:100:0)
[14:13:36.951] Timer tick, asking Buildbucket for the build status
[14:13:37.083] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:37.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:101:0) after 1m0s
[14:14:37.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:101:0)
[14:14:37.106] Timer tick, asking Buildbucket for the build status
[14:14:37.178] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:102:0) after 1m0s
[14:15:37.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:102:0)
[14:15:37.230] Timer tick, asking Buildbucket for the build status
[14:15:37.342] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:37.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:103:0) after 1m0s
[14:16:37.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:103:0)
[14:16:37.387] Timer tick, asking Buildbucket for the build status
[14:16:37.509] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:104:0) after 1m0s
[14:17:37.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:104:0)
[14:17:37.549] Timer tick, asking Buildbucket for the build status
[14:17:37.643] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:37.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:105:0) after 1m0s
[14:18:37.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:105:0)
[14:18:37.675] Timer tick, asking Buildbucket for the build status
[14:18:37.743] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:37.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:106:0) after 1m0s
[14:19:37.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:106:0)
[14:19:37.745] Timer tick, asking Buildbucket for the build status
[14:19:37.828] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:37.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:107:0) after 1m0s
[14:20:37.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:107:0)
[14:20:37.844] Timer tick, asking Buildbucket for the build status
[14:20:38.546] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:38.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:108:0) after 1m0s
[14:21:38.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:108:0)
[14:21:38.525] Timer tick, asking Buildbucket for the build status
[14:21:38.615] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:38.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:109:0) after 1m0s
[14:22:38.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:109:0)
[14:22:38.671] Timer tick, asking Buildbucket for the build status
[14:22:38.748] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:38.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:110:0) after 1m0s
[14:23:38.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:110:0)
[14:23:38.795] Timer tick, asking Buildbucket for the build status
[14:23:38.917] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:38.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:111:0) after 1m0s
[14:24:38.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:111:0)
[14:24:38.944] Timer tick, asking Buildbucket for the build status
[14:24:39.138] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:39.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:112:0) after 1m0s
[14:25:39.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:112:0)
[14:25:39.176] Timer tick, asking Buildbucket for the build status
[14:25:39.282] Build 8856497417908476000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:39.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021927480756065824:113:0) after 1m0s
[14:26:11.976] Received PubSub notification, asking Buildbucket for the build status
[14:26:12.307] Build 8856497417908476000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:26:12.307] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612189570062429",
"created_by": "project:chromium",
"created_ts": "1612182901430315",
"id": "8856497417908476000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1916dbb9a5f0b983ab2c84763446f28ee819b16\"}}",
"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\": \"f1916dbb9a5f0b983ab2c84763446f28ee819b16\", \"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-93-pui4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22429, \"got_angle_revision\": \"b15de455066b37c2e59f477f6e6819f911e2ba00\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"f1916dbb9a5f0b983ab2c84763446f28ee819b16\", \"got_revision_cp\": \"refs/heads/master@{#849075}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8b4cf1c2491d56cf9eda153b5455e4b295732b7c\", \"got_v8_revision\": \"6c4d607a0aaf63ff4b68202d6d7bced976023ae7\", \"got_v8_revision_cp\": \"refs/heads/9.0.103@{#1}\", \"got_webrtc_revision\": \"1f1e190acc8012657965ec3e2c51c7ac72470af7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33118}\", \"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\": \"f1916dbb9a5f0b983ab2c84763446f28ee819b16\", \"swarm_hashes_refs/heads/master(at){#849075}_without_patch\": {\"absl_hardening_tests\": \"d00bb68609c3af685deaac5f02ea87be3dbadc29\", \"accessibility_unittests\": \"a6c7ad8efec519c9353dad62dba57695f57aa1f5\", \"angle_unittests\": \"6876e70e7483bc6d8559ce110106c3353e5a2ba7\", \"app_list_unittests\": \"3d4fdfa3c0cd04db4f7d4f4678ed9d2829e55bb0\", \"app_shell_unittests\": \"2c3a693c22743a7595189ffa99f5ec61ac725d0e\", \"ash_unittests\": \"7795e3ada6ef388a6c8e5b5c6f205a9de2874035\", \"aura_unittests\": \"7f692772daa9e402dfc6c13800d236c2ce6b8e45\", \"base_unittests\": \"9f442819b6699c89a52b18ed47f271294d58e583\", \"base_util_unittests\": \"fedff7fa86630a035fc3a5a25a8bd8bb115463e7\", \"blink_common_unittests\": \"2a05cc54036c4dc1269f9d000c2a781836b691c1\", \"blink_fuzzer_unittests\": \"baa2c7145b6988472bd43b2e544463b1edce4f66\", \"blink_heap_unittests\": \"f2bace03275c217a82b5cb468721e6781fe0a47c\", \"blink_platform_unittests\": \"1106eecddc0e3779f6423aabf32ed82e76b95053\", \"blink_unittests\": \"ae19b6e1218a8fa6b2f95d19139cf53fc27d3500\", \"boringssl_crypto_tests\": \"4e2b1c4517cbf2d01ec66faed86f9cc241939965\", \"boringssl_ssl_tests\": \"356abbec0b6b7bb8725eef6f653a207b76997152\", \"browser_tests\": \"2b7981f03b22a066ae07bdd4b87c7f3402dd7dc3\", \"capture_unittests\": \"d9247bfb2132b9bfa212ca3bc17f1fd0f577b6c4\", \"cast_unittests\": \"47ab2e15f9847c7d20c4ae4d038e9a1f9a930066\", \"cc_unittests\": \"5ff0881780651f114a05bc8ce607b3968c8899f3\", \"chrome_app_unittests\": \"5ce7ad9916a1d7989cb2e61e9c3e54fb35f39308\", \"chromedriver_unittests\": \"08bb3d4b746b4524c4357b7d27c08bcea1cfd747\", \"chromeos_components_unittests\": \"bb415f4ec8c9c3af6b8924b27c1c7a8449e02b9f\", \"chromeos_unittests\": \"9b039ff8f8726dc34bb46f42a1de6912948a8095\", \"components_browsertests\": \"a83fe9c1c7e09a089c693faadcd37e2edaa1b86b\", \"components_unittests\": \"81443884bd103a6b4734e9d95472ac04ab5411b2\", \"compositor_unittests\": \"2129a771f4ca4c71c3e8948ce9f0b2a730f80f2c\", \"content_browsertests\": \"b81605d5c796706fde428bbe75c0f3f3c569b2ea\", \"content_unittests\": \"8f4f78dac83b37f9516af6f2476a4ceb062bec17\", \"crashpad_tests\": \"e42f5f98b317a38fedb5d6e1a93849825934ebd9\", \"crypto_unittests\": \"4c63b42ab0b173c700e954d691de8e8c75723d37\", \"dbus_unittests\": \"627ca441536d6dcf5bd8aa62fcdef3e4943a2a15\", \"device_unittests\": \"bea0d6e3f59b6f4b6c0a6811fba50ef240a21d78\", \"display_unittests\": \"2b0cff4167e4e96e70ab163d488658275466d388\", \"events_unittests\": \"a4c0f4529eaf4fd830098872b66d0e649c51e8f5\", \"exo_unittests\": \"df0eab78c8b3bce90d3625138e68c465b901c72f\", \"extensions_browsertests\": \"ad2cdc82d987d6d9714090718b6758be42af9d46\", \"extensions_unittests\": \"56f08336ef89f2061dc552549f933017e64349c0\", \"filesystem_service_unittests\": \"ced82bbebaf53ad2a06930721ae92faa966ca31e\", \"gcm_unit_tests\": \"b88d8232d3da0603c5d37c123c7afa68bff6cdda\", \"gfx_unittests\": \"8b66a69d911c90e37aad5f993f1d90ccc36cbe4f\", \"gin_unittests\": \"33ee9c5d82a57508f318a53235ed44ac37876e71\", \"gl_unittests_ozone\": \"07f652d1c5542320e76e4b3c69ce669e28e2b0f2\", \"google_apis_unittests\": \"5e21af37f40588a1f30397cf1df219234f7d9da1\", \"gpu_unittests\": \"0d84dd93218dc91a7692b8a5519145c598dad7ba\", \"gwp_asan_unittests\": \"16aa0dfd48bda05fcf6f222f2da2a50d72a3cac4\", \"interactive_ui_tests\": \"01857065da1aba61c85de11e0e3b59f21f6ace0e\", \"ipc_tests\": \"6ab5d2dd85f9ee1f1b0de713cb1044e7b45c6d31\", \"jingle_unittests\": \"c624e1839b556c4bf79de85e697f2c9963746e1d\", \"keyboard_unittests\": \"2504cc805da66bed534afaa4abf295085ed074ff\", \"latency_unittests\": \"08d67121cd59dfff1c1a0bbfdf4967849cc340dc\", \"libjingle_xmpp_unittests\": \"edeeb21cb147960e1f960d84dcf0e5377955ef79\", \"liburlpattern_unittests\": \"67f0cf114fd561227d0d0af3ad5e7598a7853440\", \"media_blink_unittests\": \"9732203bb4e7421bc1e3d2f9f349c0c519ab5e12\", \"media_unittests\": \"7b129dbe2ef2df1768eeec664d725c799ec4c71f\", \"message_center_unittests\": \"bcdb4615b28d4816ddd6e6e758193414643c488d\", \"midi_unittests\": \"ee814e66c1e56044d11bb44a99132e2f5a7afce2\", \"mojo_core_unittests\": \"344734df707f2e8a9b57e3967cd4473426ee43ac\", \"mojo_unittests\": \"90e2b31c33ff7c5fe8455f10d0c20d832d0d3957\", \"nacl_helper_nonsfi_unittests\": \"9ea42b894853b51202b964b94973334ac3ca734d\", \"nacl_loader_unittests\": \"521be4655fc643ce877d39c61cd768175ac56f3f\", \"native_theme_unittests\": \"f2d3bb5ea7206ac4efb56b22bc6edada7f9ae1be\", \"net_unittests\": \"836b2b5d2a76fdc75b02b83f7da491b41efa4135\", \"ozone_gl_unittests\": \"c88b5f90241bdf013c00a9b2198f82f9846dd474\", \"ozone_unittests\": \"e35781b6bf95309bce5aafba82ec589f6724a795\", \"ozone_x11_unittests\": \"0f97777b610d043875e54496327cd154ad969b5b\", \"pdf_unittests\": \"f5e62482ea1994fae5ac0631dd3dc6cd2a6a7c3d\", \"perfetto_unittests\": \"c16a16c8efb525e4f75dd106d710789e98f2207a\", \"ppapi_unittests\": \"1bb44486fd031dd2babe29635fa7e23afca7ecab\", \"printing_unittests\": \"af3b64032f95fce4709b3a13e854f6dbd50a5c47\", \"remoting_unittests\": \"17b85836575379a40a7f35c3128c9f165032ec3f\", \"sandbox_linux_unittests\": \"c5217c38c3790edf7a23158de8cfe646d3692503\", \"service_manager_unittests\": \"a2e70e8402b8671215e7be85e7f5de93777e3c52\", \"services_unittests\": \"ad85b2f63280b67158f9ea2dff4dc7b3157bbf00\", \"shell_dialogs_unittests\": \"1c3ff50f0860a5d4cc6a4b74a2353f37ac1e9e9a\", \"shell_encryption_unittests\": \"2749b3546f22a38fc398f937a6ba5c8fad87f4cd\", \"skia_unittests\": \"78c733a2be91a325e882e2998655b5ccd8258b1b\", \"snapshot_unittests\": \"29c5c9be187d325524620d809927c4f2fc6479ef\", \"sql_unittests\": \"ac91bd3e76afb1bddec2d404710d757383cb92b1\", \"storage_unittests\": \"9d8023b8dbae2df357661f04e38ca2cd8673e401\", \"sync_integration_tests\": \"7995a14920c8144788f0bfb47fd735c4e01ec40a\", \"traffic_annotation_auditor_unittests\": \"fc4de931899db3a8a58eb9d69d4e03fe9bcbacc6\", \"ui_base_unittests\": \"71e5c5d201ab47bded83e6fcd98d893cf9487e11\", \"ui_chromeos_unittests\": \"bd90085108e3a7f3f63aac7bbafebbd7ab744b62\", \"ui_touch_selection_unittests\": \"beb05e2eecfc21f16b78a3ab661c2eddd4d8ccd5\", \"unit_tests\": \"3ae2418e254d632613bf5d044073197a7710c76c\", \"url_unittests\": \"41b257f73573870cce8dacdff8f02de00f339457\", \"usage_time_limit_unittests\": \"6f3c2d63ba145c891b9b0f82faf0679ec0f3ea78\", \"views_unittests\": \"b88e03befa628636325354bf5cdbee0d870be93e\", \"viz_unittests\": \"70acaf9b0571c6d4d2baed7bbca6a0edf4c1b9d4\", \"wm_unittests\": \"3b2beff5620dc24d8c66cfd1174cff7dbdeb744e\", \"wtf_unittests\": \"51a08ed209a54856fdcfd4a85fed2e17fda33dc2\", \"zlib_unittests\": \"b227ff121b905fe6c5e41ebcca0dac79dbccdbd7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-93-pui4\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612183210746579",
"status": "COMPLETED",
"status_changed_ts": "1612189570385431",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22429",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1916dbb9a5f0b983ab2c84763446f28ee819b16",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021927480756065824",
"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/8856497417908476000/+/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:5176685e376f1210",
"user_agent:luci-scheduler"
],
"updated_ts": "1612189570389397",
"url": "https://ci.chromium.org/b/8856497417908476000",
"utcnow_ts": "1612189572246583"
}
}
[14:26:12.307] Invocation finished in 1h51m12.975798059s with status SUCCEEDED