[22:40:10.122] New invocation is queued and will start shortly
[22:40:11.354] Starting the invocation (attempt 1)
[22:40:11.411] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:40:11.412] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:40:11.412] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022523584916139136",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6d3db3e155577f936b17886b02ce1d63aa8a0192\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022523584916139136",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"gitiles_ref:refs/heads/master"
]
}
[22:40:12.141] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611614411509807",
"id": "8857093522795981616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d3db3e155577f936b17886b02ce1d63aa8a0192\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611614412019593",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22343",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022523584916139136",
"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/8857093522795981616/+/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": "1611614412019770",
"url": "https://ci.chromium.org/b/8857093522795981616",
"utcnow_ts": "1611614412133427"
}
}
[22:40:12.141] Task URL: https://ci.chromium.org/b/8857093522795981616
[22:40:12.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:2:0) after 1m0s
[22:40:25.487] Received PubSub notification, asking Buildbucket for the build status
[22:40:28.208] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:12.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:2:0)
[22:41:12.137] Timer tick, asking Buildbucket for the build status
[22:41:12.360] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:12.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:4:0) after 1m0s
[22:42:12.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:4:0)
[22:42:12.345] Timer tick, asking Buildbucket for the build status
[22:42:13.160] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:13.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:5:0) after 1m0s
[22:43:13.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:5:0)
[22:43:13.236] Timer tick, asking Buildbucket for the build status
[22:43:13.532] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:13.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:6:0) after 1m0s
[22:44:13.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:6:0)
[22:44:13.573] Timer tick, asking Buildbucket for the build status
[22:44:15.746] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:15.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:7:0) after 1m0s
[22:45:15.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:7:0)
[22:45:15.839] Timer tick, asking Buildbucket for the build status
[22:45:16.434] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:16.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:8:0) after 1m0s
[22:46:16.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:8:0)
[22:46:16.469] Timer tick, asking Buildbucket for the build status
[22:46:16.800] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:16.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:9:0) after 1m0s
[22:47:16.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:9:0)
[22:47:16.813] Timer tick, asking Buildbucket for the build status
[22:47:17.022] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:17.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:10:0) after 1m0s
[22:48:17.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:10:0)
[22:48:17.094] Timer tick, asking Buildbucket for the build status
[22:48:17.352] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:17.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:11:0) after 1m0s
[22:49:17.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:11:0)
[22:49:17.443] Timer tick, asking Buildbucket for the build status
[22:49:17.502] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:17.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:12:0) after 1m0s
[22:50:17.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:12:0)
[22:50:17.558] Timer tick, asking Buildbucket for the build status
[22:50:17.626] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:17.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:13:0) after 1m0s
[22:51:17.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:13:0)
[22:51:17.749] Timer tick, asking Buildbucket for the build status
[22:51:17.918] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:17.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:14:0) after 1m0s
[22:52:18.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:14:0)
[22:52:18.000] Timer tick, asking Buildbucket for the build status
[22:52:18.253] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:18.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:15:0) after 1m0s
[22:53:18.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:15:0)
[22:53:18.338] Timer tick, asking Buildbucket for the build status
[22:53:18.425] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:18.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:16:0) after 1m0s
[22:54:18.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:16:0)
[22:54:18.496] Timer tick, asking Buildbucket for the build status
[22:54:19.442] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:19.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:17:0) after 1m0s
[22:55:19.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:17:0)
[22:55:19.470] Timer tick, asking Buildbucket for the build status
[22:55:19.772] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:19.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:18:0) after 1m0s
[22:56:19.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:18:0)
[22:56:19.773] Timer tick, asking Buildbucket for the build status
[22:56:19.879] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:19.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:19:0) after 1m0s
[22:57:19.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:19:0)
[22:57:19.979] Timer tick, asking Buildbucket for the build status
[22:57:20.156] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:20.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:20:0) after 1m0s
[22:58:20.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:20:0)
[22:58:20.131] Timer tick, asking Buildbucket for the build status
[22:58:20.308] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:20.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:21:0) after 1m0s
[22:59:20.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:21:0)
[22:59:20.332] Timer tick, asking Buildbucket for the build status
[22:59:20.403] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:20.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:22:0) after 1m0s
[23:00:20.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:22:0)
[23:00:20.457] Timer tick, asking Buildbucket for the build status
[23:00:20.558] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:20.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:23:0) after 1m0s
[23:01:20.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:23:0)
[23:01:20.681] Timer tick, asking Buildbucket for the build status
[23:01:20.930] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:20.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:24:0) after 1m0s
[23:02:21.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:24:0)
[23:02:21.096] Timer tick, asking Buildbucket for the build status
[23:02:21.206] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:21.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:25:0) after 1m0s
[23:03:21.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:25:0)
[23:03:21.331] Timer tick, asking Buildbucket for the build status
[23:03:21.430] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:21.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:26:0) after 1m0s
[23:04:21.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:26:0)
[23:04:21.680] Timer tick, asking Buildbucket for the build status
[23:04:21.776] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:21.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:27:0) after 1m0s
[23:05:21.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:27:0)
[23:05:21.887] Timer tick, asking Buildbucket for the build status
[23:05:23.481] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:23.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:28:0) after 1m0s
[23:06:23.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:28:0)
[23:06:23.857] Timer tick, asking Buildbucket for the build status
[23:06:23.921] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:29:0) after 1m0s
[23:07:24.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:29:0)
[23:07:24.033] Timer tick, asking Buildbucket for the build status
[23:07:24.155] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:24.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:30:0) after 1m0s
[23:08:24.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:30:0)
[23:08:24.342] Timer tick, asking Buildbucket for the build status
[23:08:24.542] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:24.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:31:0) after 1m0s
[23:09:24.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:31:0)
[23:09:24.691] Timer tick, asking Buildbucket for the build status
[23:09:24.751] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:24.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:32:0) after 1m0s
[23:10:24.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:32:0)
[23:10:24.826] Timer tick, asking Buildbucket for the build status
[23:10:24.996] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:33:0) after 1m0s
[23:11:25.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:33:0)
[23:11:25.127] Timer tick, asking Buildbucket for the build status
[23:11:25.510] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:25.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:34:0) after 1m0s
[23:12:25.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:34:0)
[23:12:25.571] Timer tick, asking Buildbucket for the build status
[23:12:25.650] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:25.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:35:0) after 1m0s
[23:13:25.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:35:0)
[23:13:25.720] Timer tick, asking Buildbucket for the build status
[23:13:26.092] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:26.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:36:0) after 1m0s
[23:14:26.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:36:0)
[23:14:26.068] Timer tick, asking Buildbucket for the build status
[23:14:26.137] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:26.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:37:0) after 1m0s
[23:15:26.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:37:0)
[23:15:26.171] Timer tick, asking Buildbucket for the build status
[23:15:26.297] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:26.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:38:0) after 1m0s
[23:16:26.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:38:0)
[23:16:26.407] Timer tick, asking Buildbucket for the build status
[23:16:26.888] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:26.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:39:0) after 1m0s
[23:17:26.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:39:0)
[23:17:26.920] Timer tick, asking Buildbucket for the build status
[23:17:26.984] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:26.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:40:0) after 1m0s
[23:18:27.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:40:0)
[23:18:27.198] Timer tick, asking Buildbucket for the build status
[23:18:27.348] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:41:0) after 1m0s
[23:19:27.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:41:0)
[23:19:27.403] Timer tick, asking Buildbucket for the build status
[23:19:27.538] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:27.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:42:0) after 1m0s
[23:20:27.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:42:0)
[23:20:27.611] Timer tick, asking Buildbucket for the build status
[23:20:27.714] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:27.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:43:0) after 1m0s
[23:21:27.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:43:0)
[23:21:27.820] Timer tick, asking Buildbucket for the build status
[23:21:27.893] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:27.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:44:0) after 1m0s
[23:22:27.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:44:0)
[23:22:27.987] Timer tick, asking Buildbucket for the build status
[23:22:28.099] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:28.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:45:0) after 1m0s
[23:23:28.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:45:0)
[23:23:28.224] Timer tick, asking Buildbucket for the build status
[23:23:28.509] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:28.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:46:0) after 1m0s
[23:24:28.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:46:0)
[23:24:28.641] Timer tick, asking Buildbucket for the build status
[23:24:28.761] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:28.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:47:0) after 1m0s
[23:25:28.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:47:0)
[23:25:28.899] Timer tick, asking Buildbucket for the build status
[23:25:30.268] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:48:0) after 1m0s
[23:26:30.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:48:0)
[23:26:30.495] Timer tick, asking Buildbucket for the build status
[23:26:30.908] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:30.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:49:0) after 1m0s
[23:27:31.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:49:0)
[23:27:31.008] Timer tick, asking Buildbucket for the build status
[23:27:31.169] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:50:0) after 1m0s
[23:28:31.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:50:0)
[23:28:31.283] Timer tick, asking Buildbucket for the build status
[23:28:31.462] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:31.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:51:0) after 1m0s
[23:29:31.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:51:0)
[23:29:31.579] Timer tick, asking Buildbucket for the build status
[23:29:31.805] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:31.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:52:0) after 1m0s
[23:30:31.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:52:0)
[23:30:31.994] Timer tick, asking Buildbucket for the build status
[23:30:32.299] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:32.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:53:0) after 1m0s
[23:31:32.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:53:0)
[23:31:32.768] Timer tick, asking Buildbucket for the build status
[23:31:33.004] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:33.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:54:0) after 1m0s
[23:32:33.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:54:0)
[23:32:33.194] Timer tick, asking Buildbucket for the build status
[23:32:33.394] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:33.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:55:0) after 1m0s
[23:33:33.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:55:0)
[23:33:33.521] Timer tick, asking Buildbucket for the build status
[23:33:33.616] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:33.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:56:0) after 1m0s
[23:34:33.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:56:0)
[23:34:33.754] Timer tick, asking Buildbucket for the build status
[23:34:35.397] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:57:0) after 1m0s
[23:35:35.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:57:0)
[23:35:35.490] Timer tick, asking Buildbucket for the build status
[23:35:35.671] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:35.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:58:0) after 1m0s
[23:36:35.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:58:0)
[23:36:35.784] Timer tick, asking Buildbucket for the build status
[23:36:35.905] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:35.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:59:0) after 1m0s
[23:37:36.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:59:0)
[23:37:36.120] Timer tick, asking Buildbucket for the build status
[23:37:38.500] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:38.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:60:0) after 1m0s
[23:38:38.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:60:0)
[23:38:38.655] Timer tick, asking Buildbucket for the build status
[23:38:39.187] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:39.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:61:0) after 1m0s
[23:39:39.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:61:0)
[23:39:39.227] Timer tick, asking Buildbucket for the build status
[23:39:39.320] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:39.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:62:0) after 1m0s
[23:40:39.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:62:0)
[23:40:39.338] Timer tick, asking Buildbucket for the build status
[23:40:39.690] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:39.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:63:0) after 1m0s
[23:41:39.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:63:0)
[23:41:39.774] Timer tick, asking Buildbucket for the build status
[23:41:39.849] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:39.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:64:0) after 1m0s
[23:42:39.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:64:0)
[23:42:39.894] Timer tick, asking Buildbucket for the build status
[23:42:40.016] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:40.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:65:0) after 1m0s
[23:43:40.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:65:0)
[23:43:40.102] Timer tick, asking Buildbucket for the build status
[23:43:40.393] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:40.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:66:0) after 1m0s
[23:44:40.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:66:0)
[23:44:40.430] Timer tick, asking Buildbucket for the build status
[23:44:41.102] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:41.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:67:0) after 1m0s
[23:45:41.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:67:0)
[23:45:41.148] Timer tick, asking Buildbucket for the build status
[23:45:41.259] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:41.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:68:0) after 1m0s
[23:46:41.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:68:0)
[23:46:41.278] Timer tick, asking Buildbucket for the build status
[23:46:41.369] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:41.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:69:0) after 1m0s
[23:47:41.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:69:0)
[23:47:41.386] Timer tick, asking Buildbucket for the build status
[23:47:41.843] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:41.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:70:0) after 1m0s
[23:48:41.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:70:0)
[23:48:41.873] Timer tick, asking Buildbucket for the build status
[23:48:42.427] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:42.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:71:0) after 1m0s
[23:49:42.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:71:0)
[23:49:42.463] Timer tick, asking Buildbucket for the build status
[23:49:43.372] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:43.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:72:0) after 1m0s
[23:50:43.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:72:0)
[23:50:43.480] Timer tick, asking Buildbucket for the build status
[23:50:43.620] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:43.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:73:0) after 1m0s
[23:51:43.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:73:0)
[23:51:43.728] Timer tick, asking Buildbucket for the build status
[23:51:43.829] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:43.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:74:0) after 1m0s
[23:52:43.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:74:0)
[23:52:43.882] Timer tick, asking Buildbucket for the build status
[23:52:43.960] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:75:0) after 1m0s
[23:53:43.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:75:0)
[23:53:43.940] Timer tick, asking Buildbucket for the build status
[23:53:44.021] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:76:0) after 1m0s
[23:54:44.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:76:0)
[23:54:44.014] Timer tick, asking Buildbucket for the build status
[23:54:45.387] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:45.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:77:0) after 1m0s
[23:55:45.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:77:0)
[23:55:45.409] Timer tick, asking Buildbucket for the build status
[23:55:45.628] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:45.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:78:0) after 1m0s
[23:56:45.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:78:0)
[23:56:45.657] Timer tick, asking Buildbucket for the build status
[23:56:45.747] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:45.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:79:0) after 1m0s
[23:57:45.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:79:0)
[23:57:45.750] Timer tick, asking Buildbucket for the build status
[23:57:45.821] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:45.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:80:0) after 1m0s
[23:58:45.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:80:0)
[23:58:45.827] Timer tick, asking Buildbucket for the build status
[23:58:45.970] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:45.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:81:0) after 1m0s
[23:59:45.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:81:0)
[23:59:45.972] Timer tick, asking Buildbucket for the build status
[23:59:48.200] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:48.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:82:0) after 1m0s
[00:00:48.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:82:0)
[00:00:48.258] Timer tick, asking Buildbucket for the build status
[00:00:48.896] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:48.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:83:0) after 1m0s
[00:01:48.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:83:0)
[00:01:48.967] Timer tick, asking Buildbucket for the build status
[00:01:49.076] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:49.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:84:0) after 1m0s
[00:02:49.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:84:0)
[00:02:49.082] Timer tick, asking Buildbucket for the build status
[00:02:49.334] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:49.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:85:0) after 1m0s
[00:03:49.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:85:0)
[00:03:49.402] Timer tick, asking Buildbucket for the build status
[00:03:49.475] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:49.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:86:0) after 1m0s
[00:04:49.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:86:0)
[00:04:49.639] Timer tick, asking Buildbucket for the build status
[00:04:49.787] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:49.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:87:0) after 1m0s
[00:05:49.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:87:0)
[00:05:49.832] Timer tick, asking Buildbucket for the build status
[00:05:50.423] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:50.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:88:0) after 1m0s
[00:06:50.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:88:0)
[00:06:50.543] Timer tick, asking Buildbucket for the build status
[00:06:50.962] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:50.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:89:0) after 1m0s
[00:07:51.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:89:0)
[00:07:51.044] Timer tick, asking Buildbucket for the build status
[00:07:51.124] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:51.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:90:0) after 1m0s
[00:08:51.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:90:0)
[00:08:51.148] Timer tick, asking Buildbucket for the build status
[00:08:51.240] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:51.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:91:0) after 1m0s
[00:09:51.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:91:0)
[00:09:51.361] Timer tick, asking Buildbucket for the build status
[00:09:51.698] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:51.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:92:0) after 1m0s
[00:10:51.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:92:0)
[00:10:51.762] Timer tick, asking Buildbucket for the build status
[00:10:51.892] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:51.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:93:0) after 1m0s
[00:11:51.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:93:0)
[00:11:51.964] Timer tick, asking Buildbucket for the build status
[00:11:52.093] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:52.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:94:0) after 1m0s
[00:12:52.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:94:0)
[00:12:52.136] Timer tick, asking Buildbucket for the build status
[00:12:53.072] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:53.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:95:0) after 1m0s
[00:13:53.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:95:0)
[00:13:53.731] Timer tick, asking Buildbucket for the build status
[00:13:53.949] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:53.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:96:0) after 1m0s
[00:14:54.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:96:0)
[00:14:54.099] Timer tick, asking Buildbucket for the build status
[00:14:54.714] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:97:0) after 1m0s
[00:15:55.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:97:0)
[00:15:55.233] Timer tick, asking Buildbucket for the build status
[00:15:55.421] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:55.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:98:0) after 1m0s
[00:16:55.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:98:0)
[00:16:55.680] Timer tick, asking Buildbucket for the build status
[00:16:55.835] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:55.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:99:0) after 1m0s
[00:17:55.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:99:0)
[00:17:55.931] Timer tick, asking Buildbucket for the build status
[00:17:56.002] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:56.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:100:0) after 1m0s
[00:18:56.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:100:0)
[00:18:56.106] Timer tick, asking Buildbucket for the build status
[00:18:56.311] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:56.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:101:0) after 1m0s
[00:19:56.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:101:0)
[00:19:56.546] Timer tick, asking Buildbucket for the build status
[00:19:56.644] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:56.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:102:0) after 1m0s
[00:20:56.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:102:0)
[00:20:56.737] Timer tick, asking Buildbucket for the build status
[00:20:56.914] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:103:0) after 1m0s
[00:21:56.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:103:0)
[00:21:56.945] Timer tick, asking Buildbucket for the build status
[00:21:57.073] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:104:0) after 1m0s
[00:22:57.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:104:0)
[00:22:57.107] Timer tick, asking Buildbucket for the build status
[00:22:57.219] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:57.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:105:0) after 1m0s
[00:23:57.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:105:0)
[00:23:57.360] Timer tick, asking Buildbucket for the build status
[00:23:57.550] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:57.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:106:0) after 1m0s
[00:24:57.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:106:0)
[00:24:57.618] Timer tick, asking Buildbucket for the build status
[00:24:57.745] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:57.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:107:0) after 1m0s
[00:25:57.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:107:0)
[00:25:57.896] Timer tick, asking Buildbucket for the build status
[00:25:58.504] Build 8857093522795981616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:58.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022523584916139136:108:0) after 1m0s
[00:26:14.196] Received PubSub notification, asking Buildbucket for the build status
[00:26:14.323] Build 8857093522795981616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:26:14.323] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611620772036742",
"created_by": "project:chromium",
"created_ts": "1611614411509807",
"id": "8857093522795981616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d3db3e155577f936b17886b02ce1d63aa8a0192\"}}",
"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\": \"6d3db3e155577f936b17886b02ce1d63aa8a0192\", \"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-197-j1hi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22343, \"got_angle_revision\": \"3623868e656d0685f0ec3f7d13a2e9c1e348ba53\", \"got_dawn_revision\": \"c00276b2029b85b0cca43ced05173993beaf43e7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"6d3db3e155577f936b17886b02ce1d63aa8a0192\", \"got_revision_cp\": \"refs/heads/master@{#846924}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"727b659625f9387fe8286da2390bedff96334f13\", \"got_v8_revision_cp\": \"refs/heads/9.0.62@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"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\": \"6d3db3e155577f936b17886b02ce1d63aa8a0192\", \"swarm_hashes_refs/heads/master(at){#846924}_without_patch\": {\"absl_hardening_tests\": \"13baac96d7695b2ddde77c1ecc82ed875faa61f5\", \"accessibility_unittests\": \"18983ac493e7340ed1c008ae238ccff41780b0bc\", \"angle_unittests\": \"6436585032de7f0395ea9ae1cd3c6b37a205e8c2\", \"app_list_unittests\": \"f4595d2b57897b2be7319654fb0f68deab3b1c2b\", \"app_shell_unittests\": \"67b7fd8d30f5232c924748666447c9d4c56cbc17\", \"ash_unittests\": \"e6ce0e67df28edd94928da8520d18f4e4d4ffda6\", \"aura_unittests\": \"f034c807492d3e8fe0c9fd3f1e78c8a0332d0b81\", \"base_unittests\": \"49895b023ea66b0727cd9a715b429404e04cd85b\", \"base_util_unittests\": \"b8436f4bed0ee081ab7c489d181e7bd8cd548718\", \"blink_common_unittests\": \"59080523fd18fc61c9bc13bfca01f84a7c4932fd\", \"blink_fuzzer_unittests\": \"9bcf369b80ad9598c90a1009c27b811af7dd5751\", \"blink_heap_unittests\": \"713493ad69c345c4f2e91b87b32fc185d6bbfa75\", \"blink_platform_unittests\": \"e5a73fdc3625a2fefa28be16e21b2df0e91f15dc\", \"blink_unittests\": \"ee6c6955d88eedf5a7347b869cd273be6140adf8\", \"boringssl_crypto_tests\": \"1bb258f149c452953ee002048ecb376e836ec084\", \"boringssl_ssl_tests\": \"80aaa4fc943ec45c365247c75e50d9eed2c5a1e0\", \"browser_tests\": \"eb8521502f3a12c1dde916c949ab8871402cf2eb\", \"capture_unittests\": \"2cac9115736b1e204a58a00e6a4adeb3a36959cc\", \"cast_unittests\": \"4141363671df00b6af23fbcd5fb8841da5169434\", \"cc_unittests\": \"4cace64303f70bd25f26084a66f91c86799650a4\", \"chrome_app_unittests\": \"c690b607789d45e86666d540c05d7e4ee6a769d6\", \"chromedriver_unittests\": \"2f14bdba79bfafeaeb8f0b8d6860db4193bf512a\", \"chromeos_components_unittests\": \"2148e0c5b70a6344f3f329127755144a2c0a8fb3\", \"chromeos_unittests\": \"eb9ddd85fc13b2e940df4c7f7f515b243abef3e5\", \"components_browsertests\": \"30b4d5f5f68561467c5b501f7f6a79015edca5c7\", \"components_unittests\": \"7f80326254deedf1f4b2c3a7293d26b4186e8065\", \"compositor_unittests\": \"5f4398d43ed46d0810f1fd22aba331179d286f1b\", \"content_browsertests\": \"02de15e1584ce26819a5e32ee6a8d506b723de82\", \"content_unittests\": \"e4c87e3294f466e84e86fb800d380f49e73830ad\", \"crashpad_tests\": \"c4189fb4c0d530e7087e3b48b7719adfa1fbed8c\", \"crypto_unittests\": \"7e69c37db456ffa78525c7c20dcd607d2eaa7bd2\", \"dbus_unittests\": \"f31fe462616e0e118d1e3c5c38cfde90bf2879e2\", \"device_unittests\": \"a26c2bdae0d9608a2a0038c288b18d8a0781fc31\", \"display_unittests\": \"bfaa5a2f3168c336144cb89d279b5e6c039d1bd2\", \"events_unittests\": \"86d3b1deb368932303dcc6bdb8b1d5fa93064219\", \"exo_unittests\": \"faac1e3f3f4fd2c20e504777719fa00d8e344490\", \"extensions_browsertests\": \"9671a0c1419de0eb27e8a99fa172a9799ebcf4c5\", \"extensions_unittests\": \"f6b7fe0f1711ea33277580f24036677c0fdc4959\", \"filesystem_service_unittests\": \"10a16bf558b03cdc27fc11b079f1c9ed8553040d\", \"gcm_unit_tests\": \"5922b1c38862a5439428b4279375049fd915f662\", \"gfx_unittests\": \"7307fba239abf8a9c04c553a4f61173520fdad79\", \"gin_unittests\": \"69dddde01ff5b36dca5277845573332e2a03a944\", \"gl_unittests_ozone\": \"ba0c89cacc035ef4b8c173d0e5b8f3e45b893a1c\", \"google_apis_unittests\": \"7a61abeb88877a90d98acec1e7963b0eea7dc0c2\", \"gpu_unittests\": \"26c07b9bbc104fe229433647272f1cddeee3c048\", \"gwp_asan_unittests\": \"1e018e4ddef3f54efa9ab24b06c178fdd3282219\", \"interactive_ui_tests\": \"7b10f969833dd38b9362960bc080f6e34206ac13\", \"ipc_tests\": \"da4c8a3708184ae4f3e0838796b0993a31902a73\", \"jingle_unittests\": \"a9d20f3ed3f847e66b4afe8676d4fa5304cc0a75\", \"keyboard_unittests\": \"4feadd370dcde777936381e3de8a46aaaf19b94f\", \"latency_unittests\": \"f6655b6e38fbbe74279e36e608043ad5f38d949d\", \"libjingle_xmpp_unittests\": \"97cdc00efc5d5a4d3567cd767a0c78db5172dfdc\", \"liburlpattern_unittests\": \"37219d9ad032e2a26a31e50aeeaa879349a94167\", \"media_blink_unittests\": \"9ee8a097a3a161ec9d1b6436c174c689e9887638\", \"media_unittests\": \"417433ed84498cd4fb10b16c76a1ecfca9dbeff6\", \"message_center_unittests\": \"da76ed16c3bcdc3fabe40e365f83e7f57e1a621f\", \"midi_unittests\": \"bc44491124e600f4f6cb499f384137e6335b0538\", \"mojo_core_unittests\": \"37c1606545ce59e6432c4f328ed17cdd0922d17f\", \"mojo_unittests\": \"b592e09a2e6f1fd23a008bc59cae07d6ba774237\", \"nacl_helper_nonsfi_unittests\": \"1fa203488459b21242a7ca716fb384ca070e833b\", \"nacl_loader_unittests\": \"23256be8201c6643b4b54353109da4efb0558f55\", \"native_theme_unittests\": \"a081a4158a661fbc34949220425d235f62f72435\", \"net_unittests\": \"bc8d72db76dc6b99c79459a8c768e6b539529372\", \"ozone_gl_unittests\": \"0d7975d5de81f75ebaa3b62f603082fe4c69092c\", \"ozone_unittests\": \"f879456c62e9e33a8e208ea6fa6642dc30b342b6\", \"ozone_x11_unittests\": \"6076b3578280fb670cb2614eee2e477d2b85d230\", \"pdf_unittests\": \"c6c1e8d594a0e0877afe8bb37c836dc64d61beb4\", \"perfetto_unittests\": \"d1c165f7fcdecf18a78483c6fe1c9f939483c664\", \"ppapi_unittests\": \"2fbea941036e695ae01c02f5b45fa4b7d5756f0a\", \"printing_unittests\": \"cecf74aaca5a3ca067fbcf4c3ce764d632650ae1\", \"remoting_unittests\": \"73ff99f199850f99b722631fd3c61ebc2eb52dba\", \"sandbox_linux_unittests\": \"477c81e5e19ae31898e41448e589e88d084aa10d\", \"service_manager_unittests\": \"f4a8ae7d722848754139fd4e8095675af0bedf0c\", \"services_unittests\": \"4781a4182053a88740c5bf58d3ed5c59e8c75169\", \"shell_dialogs_unittests\": \"1e2a5bbfa67ac522f93de66cebc473ddebed8219\", \"shell_encryption_unittests\": \"6dd654b300687424ddf1500bed6365b0c293634f\", \"skia_unittests\": \"c6b31f53532e309ee6c644e7a651e2fbedbb3f98\", \"snapshot_unittests\": \"45989a8a521b82740209c4be28a7be4758309c01\", \"sql_unittests\": \"81f1290440dacadfff73713963369a8494072ac1\", \"storage_unittests\": \"3e7155a8dfa5aee8c1ce82b9c95023936342635c\", \"sync_integration_tests\": \"d2c5a00751189a6da124dbd88e4c3f4289defbe1\", \"traffic_annotation_auditor_unittests\": \"a840ee047d0b0b2421d4adc8ba8edaeb265f1b18\", \"ui_base_unittests\": \"2633a5bf3ffc9651b3ef8af21e54b4465b2770ee\", \"ui_chromeos_unittests\": \"e774ff80c5a7ac6c052e4ea89a0e4452dbaf9895\", \"ui_touch_selection_unittests\": \"f4fefb34052df2975753105d81560f6a57ddd59b\", \"unit_tests\": \"b58628106c67ddc2dcf1c4621d70a4d63bb54c75\", \"url_unittests\": \"adb3cd7277d708b8fb91d6e1b23ab7942a7ef055\", \"usage_time_limit_unittests\": \"f4ce3c8a03329dde91e7ae71f40bc78758cd685c\", \"views_unittests\": \"462fdc5da77fe6e5db14c4a1de9cabd046add80b\", \"viz_unittests\": \"5c7bb9dd51d3ee5302340fe4527892fa81d69d85\", \"wm_unittests\": \"16bea0d667e791f88f5af80eeb483da26729f077\", \"wtf_unittests\": \"e397d03287cb5e4007839e70e96c2a665ab0d8cd\", \"zlib_unittests\": \"dff38f04328d5e6008d802181abdc297e64deda9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-197-j1hi\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611614424814691",
"status": "COMPLETED",
"status_changed_ts": "1611620772784487",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22343",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d3db3e155577f936b17886b02ce1d63aa8a0192",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022523584916139136",
"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/8857093522795981616/+/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:515486014fb8b510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611620772815997",
"url": "https://ci.chromium.org/b/8857093522795981616",
"utcnow_ts": "1611620774300687"
}
}
[00:26:14.323] Invocation finished in 1h46m4.220670696s with status SUCCEEDED