[23:48:41.176] New invocation is queued and will start shortly
[23:48:42.441] Starting the invocation (attempt 1)
[23:48:42.480] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:48:42.480] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:48:42.480] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020344946966378176",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020344946966378176",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master"
]
}
[23:48:43.203] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613692122616516",
"id": "8854914884793963440",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613692123039627",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22686",
"builder:linux-chromeos-dbg",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020344946966378176",
"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/8854914884793963440/+/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": "1613692123039755",
"url": "https://ci.chromium.org/b/8854914884793963440",
"utcnow_ts": "1613692123194612"
}
}
[23:48:43.203] Task URL: https://ci.chromium.org/b/8854914884793963440
[23:48:43.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:2:0) after 1m0s
[23:49:22.010] Received PubSub notification, asking Buildbucket for the build status
[23:49:22.308] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:43.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:2:0)
[23:49:43.320] Timer tick, asking Buildbucket for the build status
[23:49:43.414] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:4:0) after 1m0s
[23:50:43.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:4:0)
[23:50:43.464] Timer tick, asking Buildbucket for the build status
[23:50:43.549] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:43.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:5:0) after 1m0s
[23:51:43.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:5:0)
[23:51:43.580] Timer tick, asking Buildbucket for the build status
[23:51:43.887] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:43.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:6:0) after 1m0s
[23:52:44.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:6:0)
[23:52:44.054] Timer tick, asking Buildbucket for the build status
[23:52:44.131] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:44.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:7:0) after 1m0s
[23:53:44.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:7:0)
[23:53:44.276] Timer tick, asking Buildbucket for the build status
[23:53:44.610] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:44.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:8:0) after 1m0s
[23:54:44.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:8:0)
[23:54:44.910] Timer tick, asking Buildbucket for the build status
[23:54:45.027] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:45.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:9:0) after 1m0s
[23:55:45.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:9:0)
[23:55:45.050] Timer tick, asking Buildbucket for the build status
[23:55:45.131] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:45.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:10:0) after 1m0s
[23:56:45.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:10:0)
[23:56:45.245] Timer tick, asking Buildbucket for the build status
[23:56:45.355] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:45.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:11:0) after 1m0s
[23:57:45.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:11:0)
[23:57:45.371] Timer tick, asking Buildbucket for the build status
[23:57:45.455] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:45.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:12:0) after 1m0s
[23:58:45.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:12:0)
[23:58:45.474] Timer tick, asking Buildbucket for the build status
[23:58:45.731] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:45.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:13:0) after 1m0s
[23:59:45.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:13:0)
[23:59:45.757] Timer tick, asking Buildbucket for the build status
[23:59:45.831] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:45.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:14:0) after 1m0s
[00:00:45.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:14:0)
[00:00:45.833] Timer tick, asking Buildbucket for the build status
[00:00:45.925] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:45.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:15:0) after 1m0s
[00:01:45.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:15:0)
[00:01:45.994] Timer tick, asking Buildbucket for the build status
[00:01:46.273] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:46.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:16:0) after 1m0s
[00:02:46.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:16:0)
[00:02:46.309] Timer tick, asking Buildbucket for the build status
[00:02:46.458] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:17:0) after 1m0s
[00:03:46.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:17:0)
[00:03:46.550] Timer tick, asking Buildbucket for the build status
[00:03:47.022] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:47.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:18:0) after 1m0s
[00:04:47.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:18:0)
[00:04:47.066] Timer tick, asking Buildbucket for the build status
[00:04:47.302] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:47.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:19:0) after 1m0s
[00:05:47.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:19:0)
[00:05:47.315] Timer tick, asking Buildbucket for the build status
[00:05:47.515] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:47.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:20:0) after 1m0s
[00:06:47.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:20:0)
[00:06:47.640] Timer tick, asking Buildbucket for the build status
[00:06:48.692] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:48.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:21:0) after 1m0s
[00:07:48.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:21:0)
[00:07:48.849] Timer tick, asking Buildbucket for the build status
[00:07:48.941] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:22:0) after 1m0s
[00:08:49.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:22:0)
[00:08:49.059] Timer tick, asking Buildbucket for the build status
[00:08:49.409] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:49.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:23:0) after 1m0s
[00:09:49.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:23:0)
[00:09:49.461] Timer tick, asking Buildbucket for the build status
[00:09:49.539] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:24:0) after 1m0s
[00:10:49.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:24:0)
[00:10:49.618] Timer tick, asking Buildbucket for the build status
[00:10:49.730] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:49.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:25:0) after 1m0s
[00:11:49.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:25:0)
[00:11:49.832] Timer tick, asking Buildbucket for the build status
[00:11:49.939] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:49.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:26:0) after 1m0s
[00:12:50.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:26:0)
[00:12:50.080] Timer tick, asking Buildbucket for the build status
[00:12:50.212] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:50.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:27:0) after 1m0s
[00:13:50.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:27:0)
[00:13:50.285] Timer tick, asking Buildbucket for the build status
[00:13:50.381] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:50.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:28:0) after 1m0s
[00:14:50.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:28:0)
[00:14:50.438] Timer tick, asking Buildbucket for the build status
[00:14:50.502] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:50.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:29:0) after 1m0s
[00:15:50.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:29:0)
[00:15:50.524] Timer tick, asking Buildbucket for the build status
[00:15:50.677] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:30:0) after 1m0s
[00:16:50.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:30:0)
[00:16:50.726] Timer tick, asking Buildbucket for the build status
[00:16:50.911] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:50.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:31:0) after 1m0s
[00:17:50.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:31:0)
[00:17:50.927] Timer tick, asking Buildbucket for the build status
[00:17:51.028] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:51.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:32:0) after 1m0s
[00:18:51.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:32:0)
[00:18:51.075] Timer tick, asking Buildbucket for the build status
[00:18:51.185] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:33:0) after 1m0s
[00:19:51.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:33:0)
[00:19:51.206] Timer tick, asking Buildbucket for the build status
[00:19:51.294] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:51.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:34:0) after 1m0s
[00:20:51.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:34:0)
[00:20:51.287] Timer tick, asking Buildbucket for the build status
[00:20:51.379] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:51.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:35:0) after 1m0s
[00:21:51.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:35:0)
[00:21:51.464] Timer tick, asking Buildbucket for the build status
[00:21:51.712] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:51.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:36:0) after 1m0s
[00:22:51.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:36:0)
[00:22:51.754] Timer tick, asking Buildbucket for the build status
[00:22:51.833] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:51.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:37:0) after 1m0s
[00:23:51.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:37:0)
[00:23:51.900] Timer tick, asking Buildbucket for the build status
[00:23:51.996] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:51.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:38:0) after 1m0s
[00:24:52.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:38:0)
[00:24:52.087] Timer tick, asking Buildbucket for the build status
[00:24:52.204] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:52.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:39:0) after 1m0s
[00:25:52.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:39:0)
[00:25:52.247] Timer tick, asking Buildbucket for the build status
[00:25:52.337] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:52.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:40:0) after 1m0s
[00:26:52.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:40:0)
[00:26:52.354] Timer tick, asking Buildbucket for the build status
[00:26:52.892] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:52.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:41:0) after 1m0s
[00:27:52.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:41:0)
[00:27:52.961] Timer tick, asking Buildbucket for the build status
[00:27:53.491] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:42:0) after 1m0s
[00:28:53.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:42:0)
[00:28:53.615] Timer tick, asking Buildbucket for the build status
[00:28:53.714] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:53.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:43:0) after 1m0s
[00:29:53.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:43:0)
[00:29:53.752] Timer tick, asking Buildbucket for the build status
[00:29:53.825] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:53.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:44:0) after 1m0s
[00:30:53.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:44:0)
[00:30:53.915] Timer tick, asking Buildbucket for the build status
[00:30:53.987] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:53.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:45:0) after 1m0s
[00:31:54.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:45:0)
[00:31:54.079] Timer tick, asking Buildbucket for the build status
[00:31:54.156] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:54.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:46:0) after 1m0s
[00:32:54.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:46:0)
[00:32:54.254] Timer tick, asking Buildbucket for the build status
[00:32:54.325] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:54.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:47:0) after 1m0s
[00:33:54.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:47:0)
[00:33:54.353] Timer tick, asking Buildbucket for the build status
[00:33:54.542] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:54.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:48:0) after 1m0s
[00:34:54.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:48:0)
[00:34:54.546] Timer tick, asking Buildbucket for the build status
[00:34:54.750] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:54.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:49:0) after 1m0s
[00:35:54.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:49:0)
[00:35:54.805] Timer tick, asking Buildbucket for the build status
[00:35:54.901] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:54.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:50:0) after 1m0s
[00:36:54.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:50:0)
[00:36:54.933] Timer tick, asking Buildbucket for the build status
[00:36:55.026] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:55.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:51:0) after 1m0s
[00:37:55.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:51:0)
[00:37:55.040] Timer tick, asking Buildbucket for the build status
[00:37:55.139] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:52:0) after 1m0s
[00:38:55.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:52:0)
[00:38:55.184] Timer tick, asking Buildbucket for the build status
[00:38:55.280] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:55.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:53:0) after 1m0s
[00:39:55.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:53:0)
[00:39:55.289] Timer tick, asking Buildbucket for the build status
[00:39:55.380] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:55.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:54:0) after 1m0s
[00:40:55.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:54:0)
[00:40:55.402] Timer tick, asking Buildbucket for the build status
[00:40:55.481] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:55.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:55:0) after 1m0s
[00:41:55.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:55:0)
[00:41:55.502] Timer tick, asking Buildbucket for the build status
[00:41:56.007] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:56.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:56:0) after 1m0s
[00:42:56.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:56:0)
[00:42:56.063] Timer tick, asking Buildbucket for the build status
[00:42:56.249] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:56.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:57:0) after 1m0s
[00:43:56.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:57:0)
[00:43:56.313] Timer tick, asking Buildbucket for the build status
[00:43:56.520] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:56.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:58:0) after 1m0s
[00:44:56.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:58:0)
[00:44:56.523] Timer tick, asking Buildbucket for the build status
[00:44:56.620] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:56.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:59:0) after 1m0s
[00:45:56.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:59:0)
[00:45:56.614] Timer tick, asking Buildbucket for the build status
[00:45:56.723] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:56.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:60:0) after 1m0s
[00:46:56.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:60:0)
[00:46:56.795] Timer tick, asking Buildbucket for the build status
[00:46:56.889] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:56.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:61:0) after 1m0s
[00:47:56.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:61:0)
[00:47:56.859] Timer tick, asking Buildbucket for the build status
[00:47:56.948] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:56.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:62:0) after 1m0s
[00:48:56.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:62:0)
[00:48:56.975] Timer tick, asking Buildbucket for the build status
[00:48:57.089] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:57.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:63:0) after 1m0s
[00:49:57.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:63:0)
[00:49:57.081] Timer tick, asking Buildbucket for the build status
[00:49:57.687] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:57.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:64:0) after 1m0s
[00:50:57.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:64:0)
[00:50:57.711] Timer tick, asking Buildbucket for the build status
[00:50:57.940] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:57.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:65:0) after 1m0s
[00:51:57.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:65:0)
[00:51:57.970] Timer tick, asking Buildbucket for the build status
[00:51:58.733] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:58.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:66:0) after 1m0s
[00:52:58.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:66:0)
[00:52:58.815] Timer tick, asking Buildbucket for the build status
[00:52:58.950] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:58.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:67:0) after 1m0s
[00:53:59.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:67:0)
[00:53:59.848] Timer tick, asking Buildbucket for the build status
[00:53:59.956] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:59.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:68:0) after 1m0s
[00:55:00.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:68:0)
[00:55:00.172] Timer tick, asking Buildbucket for the build status
[00:55:00.291] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:00.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:69:0) after 1m0s
[00:56:00.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:69:0)
[00:56:00.418] Timer tick, asking Buildbucket for the build status
[00:56:00.575] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:00.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:70:0) after 1m0s
[00:57:00.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:70:0)
[00:57:00.612] Timer tick, asking Buildbucket for the build status
[00:57:01.328] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:01.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:71:0) after 1m0s
[00:58:01.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:71:0)
[00:58:01.396] Timer tick, asking Buildbucket for the build status
[00:58:01.922] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:01.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:72:0) after 1m0s
[00:59:01.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:72:0)
[00:59:01.944] Timer tick, asking Buildbucket for the build status
[00:59:02.399] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:02.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:73:0) after 1m0s
[01:00:02.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:73:0)
[01:00:02.536] Timer tick, asking Buildbucket for the build status
[01:00:02.714] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:02.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:74:0) after 1m0s
[01:01:02.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:74:0)
[01:01:02.798] Timer tick, asking Buildbucket for the build status
[01:01:02.879] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:02.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:75:0) after 1m0s
[01:02:02.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:75:0)
[01:02:02.904] Timer tick, asking Buildbucket for the build status
[01:02:02.982] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:02.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:76:0) after 1m0s
[01:03:03.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:76:0)
[01:03:03.018] Timer tick, asking Buildbucket for the build status
[01:03:03.168] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:03.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:77:0) after 1m0s
[01:04:03.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:77:0)
[01:04:03.303] Timer tick, asking Buildbucket for the build status
[01:04:04.036] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:04.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:78:0) after 1m0s
[01:05:04.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:78:0)
[01:05:04.141] Timer tick, asking Buildbucket for the build status
[01:05:04.449] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:04.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:79:0) after 1m0s
[01:06:04.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:79:0)
[01:06:04.467] Timer tick, asking Buildbucket for the build status
[01:06:04.555] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:04.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:80:0) after 1m0s
[01:07:04.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:80:0)
[01:07:04.606] Timer tick, asking Buildbucket for the build status
[01:07:04.704] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:04.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:81:0) after 1m0s
[01:08:04.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:81:0)
[01:08:04.761] Timer tick, asking Buildbucket for the build status
[01:08:05.227] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:05.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:82:0) after 1m0s
[01:09:05.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:82:0)
[01:09:05.276] Timer tick, asking Buildbucket for the build status
[01:09:05.442] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:05.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:83:0) after 1m0s
[01:10:05.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:83:0)
[01:10:05.551] Timer tick, asking Buildbucket for the build status
[01:10:05.671] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:84:0) after 1m0s
[01:11:05.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:84:0)
[01:11:05.712] Timer tick, asking Buildbucket for the build status
[01:11:05.794] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:85:0) after 1m0s
[01:12:05.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:85:0)
[01:12:05.855] Timer tick, asking Buildbucket for the build status
[01:12:05.995] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:86:0) after 1m0s
[01:13:06.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:86:0)
[01:13:06.107] Timer tick, asking Buildbucket for the build status
[01:13:06.267] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:87:0) after 1m0s
[01:14:06.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:87:0)
[01:14:06.321] Timer tick, asking Buildbucket for the build status
[01:14:06.449] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:88:0) after 1m0s
[01:15:06.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:88:0)
[01:15:06.485] Timer tick, asking Buildbucket for the build status
[01:15:06.716] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:89:0) after 1m0s
[01:16:06.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:89:0)
[01:16:06.790] Timer tick, asking Buildbucket for the build status
[01:16:06.888] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:90:0) after 1m0s
[01:17:06.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:90:0)
[01:17:06.947] Timer tick, asking Buildbucket for the build status
[01:17:07.026] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:07.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:91:0) after 1m0s
[01:18:07.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:91:0)
[01:18:07.187] Timer tick, asking Buildbucket for the build status
[01:18:07.360] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:92:0) after 1m0s
[01:19:07.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:92:0)
[01:19:07.516] Timer tick, asking Buildbucket for the build status
[01:19:07.624] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:93:0) after 1m0s
[01:20:07.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:93:0)
[01:20:07.743] Timer tick, asking Buildbucket for the build status
[01:20:08.425] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:08.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:94:0) after 1m0s
[01:21:08.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:94:0)
[01:21:08.520] Timer tick, asking Buildbucket for the build status
[01:21:08.607] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:95:0) after 1m0s
[01:22:08.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:95:0)
[01:22:08.692] Timer tick, asking Buildbucket for the build status
[01:22:08.778] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:96:0) after 1m0s
[01:23:08.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:96:0)
[01:23:08.865] Timer tick, asking Buildbucket for the build status
[01:23:09.464] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:09.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:97:0) after 1m0s
[01:24:09.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:97:0)
[01:24:09.586] Timer tick, asking Buildbucket for the build status
[01:24:09.688] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:09.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:98:0) after 1m0s
[01:25:09.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:98:0)
[01:25:09.786] Timer tick, asking Buildbucket for the build status
[01:25:09.958] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:09.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:99:0) after 1m0s
[01:26:10.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:99:0)
[01:26:10.068] Timer tick, asking Buildbucket for the build status
[01:26:10.156] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:10.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:100:0) after 1m0s
[01:27:10.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:100:0)
[01:27:10.303] Timer tick, asking Buildbucket for the build status
[01:27:10.590] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:101:0) after 1m0s
[01:28:10.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:101:0)
[01:28:10.634] Timer tick, asking Buildbucket for the build status
[01:28:10.718] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:102:0) after 1m0s
[01:29:11.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:102:0)
[01:29:11.267] Timer tick, asking Buildbucket for the build status
[01:29:11.406] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:11.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:103:0) after 1m0s
[01:30:11.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:103:0)
[01:30:11.631] Timer tick, asking Buildbucket for the build status
[01:30:11.726] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:11.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:104:0) after 1m0s
[01:31:11.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:104:0)
[01:31:11.924] Timer tick, asking Buildbucket for the build status
[01:31:12.226] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:12.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:105:0) after 1m0s
[01:32:12.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:105:0)
[01:32:12.251] Timer tick, asking Buildbucket for the build status
[01:32:12.357] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:12.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:106:0) after 1m0s
[01:33:12.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:106:0)
[01:33:12.529] Timer tick, asking Buildbucket for the build status
[01:33:12.609] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:12.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:107:0) after 1m0s
[01:34:12.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:107:0)
[01:34:12.694] Timer tick, asking Buildbucket for the build status
[01:34:12.850] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:12.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:108:0) after 1m0s
[01:35:13.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:108:0)
[01:35:13.117] Timer tick, asking Buildbucket for the build status
[01:35:13.389] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:13.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:109:0) after 1m0s
[01:36:13.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:109:0)
[01:36:13.628] Timer tick, asking Buildbucket for the build status
[01:36:13.711] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:110:0) after 1m0s
[01:37:13.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:110:0)
[01:37:13.904] Timer tick, asking Buildbucket for the build status
[01:37:14.024] Build 8854914884793963440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:14.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020344946966378176:111:0) after 1m0s
[01:38:07.558] Received PubSub notification, asking Buildbucket for the build status
[01:38:07.709] Build 8854914884793963440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:38:07.709] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613698685947061",
"created_by": "project:chromium",
"created_ts": "1613692122616516",
"id": "8854914884793963440",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"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\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"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-129-eosp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22686, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"got_revision_cp\": \"refs/heads/master@{#855514}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"swarm_hashes_refs/heads/master(at){#855514}_without_patch\": {\"absl_hardening_tests\": \"9f554d4f7421b7491644818780ffea9e4afc7e57\", \"accessibility_unittests\": \"597e69d283556bb6ba1d9093da25edafd79e1029\", \"angle_unittests\": \"5137b23aa0b0c3cc00d9a0dbeb20f642a832150f\", \"app_list_unittests\": \"b89374ecbf0984d0d68e17a1fe66326d3f218aa1\", \"app_shell_unittests\": \"73d64a95981b54d91aadbe8e9d6058cf76a150f4\", \"ash_unittests\": \"9159afaed8562fc02f790ff4f7c44ceab35f017c\", \"aura_unittests\": \"5aba21cc46a5de3b61426af6842a5c4ed0d350ca\", \"base_unittests\": \"88e333709ebe31edd604499ecc3020889b75515b\", \"base_util_unittests\": \"e0974b544d47e7291a9ea68accf4671ef0c5cf7d\", \"blink_common_unittests\": \"272ed9c8842686fc9a94042be359f7be57f8c1e6\", \"blink_fuzzer_unittests\": \"496cd7fdef2790d636a29356ee5310cc98860a70\", \"blink_heap_unittests\": \"b74e850dfd9f9bffac0eeb6a1997f1eada18b768\", \"blink_platform_unittests\": \"1e666bc2f9f73e6b2f881d36d04a4e228bd9057d\", \"blink_unittests\": \"97a1c4eaa48bb53773a3c2744f381668ab32834a\", \"boringssl_crypto_tests\": \"093fab26f54e16c73a4733e873fcc94fb778d3a4\", \"boringssl_ssl_tests\": \"2887f14bb44f3973543176301ee21ee926304683\", \"browser_tests\": \"9186d7f325284eee2bb83bf844e0807a566c47a3\", \"capture_unittests\": \"3f4d9c0d2cfca4dc8a92d01853d6b7e8f40fcd97\", \"cast_unittests\": \"8d9d6aec5e9ae7c3b63d11b694b64fa5c473f4b8\", \"cc_unittests\": \"e6599cfe893b7d025c1ab758413d681d460606f7\", \"chrome_app_unittests\": \"c28a5f7a19e42945fd90b5148aa2b506415d0d15\", \"chromedriver_unittests\": \"b95f404459bb28e30b4e4b2826c0aa340879d61a\", \"chromeos_components_unittests\": \"f76fcb87609910e7d88bb65e51978ca3faa6ba91\", \"chromeos_unittests\": \"9e05b5d5af9c9c0e636cfa5853b0a0c4d229852a\", \"components_browsertests\": \"0e6ad828c08998b9393d9a0ae7bc8efbfcb623c4\", \"components_unittests\": \"54de058a772cd060188dde743ec43ae9c7bf4f4e\", \"compositor_unittests\": \"dca4d93abc872806dd3b9578e549f6e29666f2bb\", \"content_browsertests\": \"c01742e26ada7ab4990d05912ad9d364cba50b6e\", \"content_unittests\": \"2fe9178baf0a3f2058ae3ae98274d902803218c1\", \"crashpad_tests\": \"3b5ac8862999ac700036aba97de39d519db8bd50\", \"crypto_unittests\": \"fde6f3a24178fbe4d8fa6ded71739f52fc1d4b19\", \"dbus_unittests\": \"2ad6b09246b1ce9c8ffb5da9794caae07eca4ad8\", \"device_unittests\": \"eed11157fef4f73d44511273fef1f54e939a9e24\", \"display_unittests\": \"e27ede231b799b73c7e334b55f948f3871428a74\", \"events_unittests\": \"24607c4b5d44c5995959028b9344ed8f143ee860\", \"exo_unittests\": \"51f9a907b5d6b96d6e72596325be29d33a0da55e\", \"extensions_browsertests\": \"3c746102b3acc91d4661707113231c6e729ef5b6\", \"extensions_unittests\": \"aa1199f623be1d0b2b43f6db3772d3056d9219e7\", \"filesystem_service_unittests\": \"e9aebfa0d3c11798be2322c621fe69a5b515bea9\", \"gcm_unit_tests\": \"2a139e130adf425d9f4e92926341ee1d23dc6b30\", \"gfx_unittests\": \"5ec534042fddc7fb9d709ba7eefb3208d6d55a20\", \"gin_unittests\": \"90b32e1833ad7e2b5dd66faaefd4c6e175a9adb8\", \"gl_unittests_ozone\": \"4ed488020bb85915c691d767fc09cfaff3e4aa76\", \"google_apis_unittests\": \"2510009b88d05df95e7298c4ba5523b7f0151d6f\", \"gpu_unittests\": \"174930c40e72d51fcfb0fdb8137408b2eed721c2\", \"gwp_asan_unittests\": \"1722ee6485d91383ae594ab8cde22af98ec66e89\", \"interactive_ui_tests\": \"8c1cb331656c12e9843c93e70d791f611c8b26a6\", \"ipc_tests\": \"82094527959f08952e1ada7d6599c48beea37938\", \"jingle_unittests\": \"60a6d8852e14312d05a085cf987a8c06b2420d3c\", \"keyboard_unittests\": \"001f2ea4126d04209bd92da58539e29b6967b598\", \"latency_unittests\": \"e02cf2e6108bf5212b6dd4cfa9afa51c110ba7d6\", \"libjingle_xmpp_unittests\": \"b85e626870f42ac2b8116cf9c9e6da6d5979640c\", \"liburlpattern_unittests\": \"06a7e9a2ef3733591c1b107768de38c77e6178b2\", \"media_blink_unittests\": \"d070b6742bacdb45aaeef1acd9c8b87338ffe15b\", \"media_unittests\": \"4d41fc27ff73cbd67489c4ae0ec1f6b16e0d8289\", \"message_center_unittests\": \"4e896e45c205c7e507e3a893564975a93eace581\", \"midi_unittests\": \"932771d2447dde27abfd94c45c01651072a58028\", \"mojo_core_unittests\": \"e5ef95e8aa8bf900f367fe275f7d6e80fb607bad\", \"mojo_unittests\": \"e69478a84dddcd70b12994151bc289db0ba470e8\", \"nacl_helper_nonsfi_unittests\": \"e10681e38bebe365733525fb5b2de406a72cb666\", \"nacl_loader_unittests\": \"e8fe832fd9687f1272baa41423e53ef512a27344\", \"native_theme_unittests\": \"8ee95b08fe6fc49ee45de7797c09e789e2481f60\", \"net_unittests\": \"9b9360eb72de7bb5e14aefe78626a0608357963f\", \"ozone_gl_unittests\": \"1b48324b39bcf2d13e5ed2f8d77c3a64d00c1853\", \"ozone_unittests\": \"e30280d8d7aa0961340bffd2bd8a5870522c639d\", \"ozone_x11_unittests\": \"fa35847eb83e8e07d3efc21cc7fa829623416918\", \"pdf_unittests\": \"360dae017aac7b6c14506a99cc81ba252e2abe1e\", \"perfetto_unittests\": \"917b53b705e29a7c8677938320d64f4cd6958a34\", \"ppapi_unittests\": \"aaa979e7deb39fc15f468b64e473f4c775915dc1\", \"printing_unittests\": \"07d7ab74a4151beb4bd9e1454dc69ed17262be99\", \"remoting_unittests\": \"cf91e5d5cb52932939bbead22f14992391856c9e\", \"sandbox_linux_unittests\": \"f16b487431ccc25335d31b0c3703bc94d7de3746\", \"service_manager_unittests\": \"7c66a34a2c187d30d578fd2f11a3708a449501c1\", \"services_unittests\": \"1221ec461f2a05226a3445267bfdb77899b28f6c\", \"shell_dialogs_unittests\": \"718faba7761dccc4288298f4e4b1588d4b1009b7\", \"shell_encryption_unittests\": \"a1e31e41f54d303d540a1e6ca2f4dbd46978a22a\", \"skia_unittests\": \"e1a3b19bad409a986dbe3792c372cb35d50d9215\", \"snapshot_unittests\": \"f57c2aab02e71f824d434e08a4964f5f0dbfdf8e\", \"sql_unittests\": \"c047c92fda816a609e27b5ea5f61ae820dc02554\", \"storage_unittests\": \"ac9a96352517fc52ecf8aa6b423372577cbc3b25\", \"sync_integration_tests\": \"331a71c8df5905a9454e569bd5601954b54bca66\", \"traffic_annotation_auditor_unittests\": \"609eebd205c969d2ed4d951a8b3c2f049b9cfae2\", \"ui_base_unittests\": \"cdae11d9d7ad8f12c32f85404dfdfb7024c4091b\", \"ui_chromeos_unittests\": \"2043350b963fe5703702d0eaff28620123161b70\", \"ui_touch_selection_unittests\": \"e2d817c2864154d681a901c189223d7ac564eb0e\", \"unit_tests\": \"e984eb3aaad194ae6fc6312d0f14d0d1b8d9b3d3\", \"url_unittests\": \"22cf27439f7f5e1b22632689965835b603069154\", \"usage_time_limit_unittests\": \"92d3076c65b096f65fc4a089d07615eafdba5c45\", \"views_unittests\": \"eb610ceaa483503d6bc46a12d633bc25200096a8\", \"viz_unittests\": \"984c99dced4e7141f1e2972faf9b4939868258fc\", \"wm_unittests\": \"89446a81f474971457c7baf06346991644d73e99\", \"wtf_unittests\": \"e8a03dba6a472d5868785146ebb45105f2bb73a4\", \"zlib_unittests\": \"33c436e16f1e6e3d58d83259432a8e3ffe524b23\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_d1071779fa62103c126fbddd8eb4d0fa2c72f39bcf76fe56968d2607dc4a05dd_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_db66d224f5e060c065cb4a49cc418612a90bf947378d00f79622922b6c0b5060_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-129-eosp\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613692158287350",
"status": "COMPLETED",
"status_changed_ts": "1613698686327694",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22686",
"builder:linux-chromeos-dbg",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020344946966378176",
"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/8854914884793963440/+/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:51d05d44a1540710",
"user_agent:luci-scheduler"
],
"updated_ts": "1613698686332893",
"url": "https://ci.chromium.org/b/8854914884793963440",
"utcnow_ts": "1613698687701920"
}
}
[01:38:07.709] Invocation finished in 1h49m26.548066738s with status SUCCEEDED