[21:40:33.557] New invocation is queued and will start shortly
[21:40:34.629] Starting the invocation (attempt 1)
[21:40:34.666] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:40:34.666] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:40:34.666] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023070917011136080",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6b78ae9c8966b012c5fdb457fa408bc92b38e715\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023070917011136080",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"gitiles_ref:refs/heads/master"
]
}
[21:40:35.909] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611092434801517",
"id": "8857640855044670096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b78ae9c8966b012c5fdb457fa408bc92b38e715\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611092435586546",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22262",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023070917011136080",
"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/8857640855044670096/+/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": "1611092435586747",
"url": "https://ci.chromium.org/b/8857640855044670096",
"utcnow_ts": "1611092435795643"
}
}
[21:40:35.909] Task URL: https://ci.chromium.org/b/8857640855044670096
[21:40:35.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:2:0) after 1m0s
[21:41:35.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:2:0)
[21:41:35.981] Timer tick, asking Buildbucket for the build status
[21:41:36.211] Build 8857640855044670096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:36.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:3:0) after 1m0s
[21:42:36.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:3:0)
[21:42:36.313] Timer tick, asking Buildbucket for the build status
[21:42:36.492] Build 8857640855044670096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:36.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:4:0) after 1m0s
[21:42:45.837] Received PubSub notification, asking Buildbucket for the build status
[21:42:45.932] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:36.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:4:0)
[21:43:36.565] Timer tick, asking Buildbucket for the build status
[21:43:36.802] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:36.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:6:0) after 1m0s
[21:44:36.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:6:0)
[21:44:36.782] Timer tick, asking Buildbucket for the build status
[21:44:36.834] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:36.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:7:0) after 1m0s
[21:45:36.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:7:0)
[21:45:36.858] Timer tick, asking Buildbucket for the build status
[21:45:37.017] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:37.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:8:0) after 1m0s
[21:46:37.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:8:0)
[21:46:37.039] Timer tick, asking Buildbucket for the build status
[21:46:37.207] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:37.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:9:0) after 1m0s
[21:47:37.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:9:0)
[21:47:37.287] Timer tick, asking Buildbucket for the build status
[21:47:37.463] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:37.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:10:0) after 1m0s
[21:48:37.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:10:0)
[21:48:37.579] Timer tick, asking Buildbucket for the build status
[21:48:37.676] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:37.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:11:0) after 1m0s
[21:49:37.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:11:0)
[21:49:37.722] Timer tick, asking Buildbucket for the build status
[21:49:37.916] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:37.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:12:0) after 1m0s
[21:50:38.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:12:0)
[21:50:38.019] Timer tick, asking Buildbucket for the build status
[21:50:38.327] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:38.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:13:0) after 1m0s
[21:51:38.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:13:0)
[21:51:38.507] Timer tick, asking Buildbucket for the build status
[21:51:38.697] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:38.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:14:0) after 1m0s
[21:52:38.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:14:0)
[21:52:38.699] Timer tick, asking Buildbucket for the build status
[21:52:38.756] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:38.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:15:0) after 1m0s
[21:53:38.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:15:0)
[21:53:38.799] Timer tick, asking Buildbucket for the build status
[21:53:39.076] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:16:0) after 1m0s
[21:54:39.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:16:0)
[21:54:39.146] Timer tick, asking Buildbucket for the build status
[21:54:39.258] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:39.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:17:0) after 1m0s
[21:55:39.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:17:0)
[21:55:39.269] Timer tick, asking Buildbucket for the build status
[21:55:39.438] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:39.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:18:0) after 1m0s
[21:56:39.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:18:0)
[21:56:39.564] Timer tick, asking Buildbucket for the build status
[21:56:40.295] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:40.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:19:0) after 1m0s
[21:57:40.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:19:0)
[21:57:40.361] Timer tick, asking Buildbucket for the build status
[21:57:40.468] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:40.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:20:0) after 1m0s
[21:58:40.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:20:0)
[21:58:40.533] Timer tick, asking Buildbucket for the build status
[21:58:40.629] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:40.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:21:0) after 1m0s
[21:59:40.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:21:0)
[21:59:40.724] Timer tick, asking Buildbucket for the build status
[21:59:40.807] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:40.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:22:0) after 1m0s
[22:00:40.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:22:0)
[22:00:40.832] Timer tick, asking Buildbucket for the build status
[22:00:41.519] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:41.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:23:0) after 1m0s
[22:01:41.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:23:0)
[22:01:41.556] Timer tick, asking Buildbucket for the build status
[22:01:42.293] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:42.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:24:0) after 1m0s
[22:02:42.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:24:0)
[22:02:42.303] Timer tick, asking Buildbucket for the build status
[22:02:42.457] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:42.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:25:0) after 1m0s
[22:03:42.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:25:0)
[22:03:42.487] Timer tick, asking Buildbucket for the build status
[22:03:42.553] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:42.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:26:0) after 1m0s
[22:04:42.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:26:0)
[22:04:42.583] Timer tick, asking Buildbucket for the build status
[22:04:42.652] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:42.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:27:0) after 1m0s
[22:05:42.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:27:0)
[22:05:42.748] Timer tick, asking Buildbucket for the build status
[22:05:42.840] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:28:0) after 1m0s
[22:06:42.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:28:0)
[22:06:42.887] Timer tick, asking Buildbucket for the build status
[22:06:42.955] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:42.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:29:0) after 1m0s
[22:07:42.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:29:0)
[22:07:42.959] Timer tick, asking Buildbucket for the build status
[22:07:43.312] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:43.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:30:0) after 1m0s
[22:08:43.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:30:0)
[22:08:43.346] Timer tick, asking Buildbucket for the build status
[22:08:43.419] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:43.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:31:0) after 1m0s
[22:09:43.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:31:0)
[22:09:43.466] Timer tick, asking Buildbucket for the build status
[22:09:43.535] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:43.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:32:0) after 1m0s
[22:10:43.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:32:0)
[22:10:43.696] Timer tick, asking Buildbucket for the build status
[22:10:43.825] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:43.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:33:0) after 1m0s
[22:11:43.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:33:0)
[22:11:43.934] Timer tick, asking Buildbucket for the build status
[22:11:44.010] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:34:0) after 1m0s
[22:12:44.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:34:0)
[22:12:44.138] Timer tick, asking Buildbucket for the build status
[22:12:44.344] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:44.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:35:0) after 1m0s
[22:13:44.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:35:0)
[22:13:44.415] Timer tick, asking Buildbucket for the build status
[22:13:44.495] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:44.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:36:0) after 1m0s
[22:14:44.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:36:0)
[22:14:44.475] Timer tick, asking Buildbucket for the build status
[22:14:44.554] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:44.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:37:0) after 1m0s
[22:15:44.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:37:0)
[22:15:44.632] Timer tick, asking Buildbucket for the build status
[22:15:44.798] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:44.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:38:0) after 1m0s
[22:16:44.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:38:0)
[22:16:44.907] Timer tick, asking Buildbucket for the build status
[22:16:45.179] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:45.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:39:0) after 1m0s
[22:17:45.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:39:0)
[22:17:45.263] Timer tick, asking Buildbucket for the build status
[22:17:45.325] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:45.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:40:0) after 1m0s
[22:18:45.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:40:0)
[22:18:45.314] Timer tick, asking Buildbucket for the build status
[22:18:45.382] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:45.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:41:0) after 1m0s
[22:19:45.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:41:0)
[22:19:45.405] Timer tick, asking Buildbucket for the build status
[22:19:45.463] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:45.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:42:0) after 1m0s
[22:20:45.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:42:0)
[22:20:45.532] Timer tick, asking Buildbucket for the build status
[22:20:45.693] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:43:0) after 1m0s
[22:21:45.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:43:0)
[22:21:45.712] Timer tick, asking Buildbucket for the build status
[22:21:45.795] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:45.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:44:0) after 1m0s
[22:22:45.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:44:0)
[22:22:45.843] Timer tick, asking Buildbucket for the build status
[22:22:46.332] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:46.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:45:0) after 1m0s
[22:23:46.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:45:0)
[22:23:46.382] Timer tick, asking Buildbucket for the build status
[22:23:46.523] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:46:0) after 1m0s
[22:24:46.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:46:0)
[22:24:46.650] Timer tick, asking Buildbucket for the build status
[22:24:47.139] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:47.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:47:0) after 1m0s
[22:25:47.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:47:0)
[22:25:47.218] Timer tick, asking Buildbucket for the build status
[22:25:47.576] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:47.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:48:0) after 1m0s
[22:26:47.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:48:0)
[22:26:47.641] Timer tick, asking Buildbucket for the build status
[22:26:47.823] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:47.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:49:0) after 1m0s
[22:27:47.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:49:0)
[22:27:47.827] Timer tick, asking Buildbucket for the build status
[22:27:47.888] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:47.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:50:0) after 1m0s
[22:28:47.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:50:0)
[22:28:47.937] Timer tick, asking Buildbucket for the build status
[22:28:48.004] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:48.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:51:0) after 1m0s
[22:29:48.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:51:0)
[22:29:48.077] Timer tick, asking Buildbucket for the build status
[22:29:48.146] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:48.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:52:0) after 1m0s
[22:30:48.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:52:0)
[22:30:48.271] Timer tick, asking Buildbucket for the build status
[22:30:48.405] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:48.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:53:0) after 1m0s
[22:31:49.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:53:0)
[22:31:49.106] Timer tick, asking Buildbucket for the build status
[22:31:49.211] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:49.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:54:0) after 1m0s
[22:32:49.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:54:0)
[22:32:49.419] Timer tick, asking Buildbucket for the build status
[22:32:49.576] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:49.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:55:0) after 1m0s
[22:33:49.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:55:0)
[22:33:49.846] Timer tick, asking Buildbucket for the build status
[22:33:50.006] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:50.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:56:0) after 1m0s
[22:34:50.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:56:0)
[22:34:50.159] Timer tick, asking Buildbucket for the build status
[22:34:50.272] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:50.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:57:0) after 1m0s
[22:35:50.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:57:0)
[22:35:50.531] Timer tick, asking Buildbucket for the build status
[22:35:50.668] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:50.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:58:0) after 1m0s
[22:36:50.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:58:0)
[22:36:50.799] Timer tick, asking Buildbucket for the build status
[22:36:50.898] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:50.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:59:0) after 1m0s
[22:37:50.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:59:0)
[22:37:50.942] Timer tick, asking Buildbucket for the build status
[22:37:51.072] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:51.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:60:0) after 1m0s
[22:38:51.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:60:0)
[22:38:51.189] Timer tick, asking Buildbucket for the build status
[22:38:51.322] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:51.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:61:0) after 1m0s
[22:39:51.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:61:0)
[22:39:51.461] Timer tick, asking Buildbucket for the build status
[22:39:51.731] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:51.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:62:0) after 1m0s
[22:40:51.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:62:0)
[22:40:51.914] Timer tick, asking Buildbucket for the build status
[22:40:52.042] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:52.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:63:0) after 1m0s
[22:41:52.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:63:0)
[22:41:52.177] Timer tick, asking Buildbucket for the build status
[22:41:52.452] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:52.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:64:0) after 1m0s
[22:42:52.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:64:0)
[22:42:52.596] Timer tick, asking Buildbucket for the build status
[22:42:52.858] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:65:0) after 1m0s
[22:43:52.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:65:0)
[22:43:52.963] Timer tick, asking Buildbucket for the build status
[22:43:53.525] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:53.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:66:0) after 1m0s
[22:44:53.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:66:0)
[22:44:53.638] Timer tick, asking Buildbucket for the build status
[22:44:53.793] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:53.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:67:0) after 1m0s
[22:45:53.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:67:0)
[22:45:53.873] Timer tick, asking Buildbucket for the build status
[22:45:53.987] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:53.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:68:0) after 1m0s
[22:46:54.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:68:0)
[22:46:54.060] Timer tick, asking Buildbucket for the build status
[22:46:54.144] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:54.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:69:0) after 1m0s
[22:47:54.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:69:0)
[22:47:54.162] Timer tick, asking Buildbucket for the build status
[22:47:54.491] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:54.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:70:0) after 1m0s
[22:48:54.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:70:0)
[22:48:54.572] Timer tick, asking Buildbucket for the build status
[22:48:54.716] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:54.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:71:0) after 1m0s
[22:49:54.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:71:0)
[22:49:54.764] Timer tick, asking Buildbucket for the build status
[22:49:54.926] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:54.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:72:0) after 1m0s
[22:50:54.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:72:0)
[22:50:54.966] Timer tick, asking Buildbucket for the build status
[22:50:55.982] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:55.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:73:0) after 1m0s
[22:51:56.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:73:0)
[22:51:56.161] Timer tick, asking Buildbucket for the build status
[22:51:56.233] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:56.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:74:0) after 1m0s
[22:52:56.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:74:0)
[22:52:56.341] Timer tick, asking Buildbucket for the build status
[22:52:56.666] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:56.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:75:0) after 1m0s
[22:53:56.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:75:0)
[22:53:56.814] Timer tick, asking Buildbucket for the build status
[22:53:57.151] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:57.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:76:0) after 1m0s
[22:54:57.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:76:0)
[22:54:57.259] Timer tick, asking Buildbucket for the build status
[22:54:57.371] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:57.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:77:0) after 1m0s
[22:55:57.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:77:0)
[22:55:57.542] Timer tick, asking Buildbucket for the build status
[22:55:57.732] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:57.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:78:0) after 1m0s
[22:56:58.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:78:0)
[22:56:58.612] Timer tick, asking Buildbucket for the build status
[22:56:58.878] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:58.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:79:0) after 1m0s
[22:57:59.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:79:0)
[22:57:59.132] Timer tick, asking Buildbucket for the build status
[22:57:59.299] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:59.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:80:0) after 1m0s
[22:58:59.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:80:0)
[22:58:59.452] Timer tick, asking Buildbucket for the build status
[22:58:59.535] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:81:0) after 1m0s
[22:59:59.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:81:0)
[22:59:59.668] Timer tick, asking Buildbucket for the build status
[22:59:59.743] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:59.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:82:0) after 1m0s
[23:00:59.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:82:0)
[23:00:59.837] Timer tick, asking Buildbucket for the build status
[23:01:00.198] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:00.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:83:0) after 1m0s
[23:02:00.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:83:0)
[23:02:00.261] Timer tick, asking Buildbucket for the build status
[23:02:00.355] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:00.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:84:0) after 1m0s
[23:03:01.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:84:0)
[23:03:01.682] Timer tick, asking Buildbucket for the build status
[23:03:01.750] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:01.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:85:0) after 1m0s
[23:04:01.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:85:0)
[23:04:01.802] Timer tick, asking Buildbucket for the build status
[23:04:02.132] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:02.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:86:0) after 1m0s
[23:05:02.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:86:0)
[23:05:02.182] Timer tick, asking Buildbucket for the build status
[23:05:02.836] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:02.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:87:0) after 1m0s
[23:06:02.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:87:0)
[23:06:02.887] Timer tick, asking Buildbucket for the build status
[23:06:03.001] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:03.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:88:0) after 1m0s
[23:07:03.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:88:0)
[23:07:03.053] Timer tick, asking Buildbucket for the build status
[23:07:03.407] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:03.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:89:0) after 1m0s
[23:08:03.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:89:0)
[23:08:03.477] Timer tick, asking Buildbucket for the build status
[23:08:03.636] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:03.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:90:0) after 1m0s
[23:09:03.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:90:0)
[23:09:03.652] Timer tick, asking Buildbucket for the build status
[23:09:04.390] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:04.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:91:0) after 1m0s
[23:10:04.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:91:0)
[23:10:04.558] Timer tick, asking Buildbucket for the build status
[23:10:05.132] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:05.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:92:0) after 1m0s
[23:11:05.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:92:0)
[23:11:05.167] Timer tick, asking Buildbucket for the build status
[23:11:05.363] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:05.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:93:0) after 1m0s
[23:12:05.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:93:0)
[23:12:05.424] Timer tick, asking Buildbucket for the build status
[23:12:05.544] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:05.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:94:0) after 1m0s
[23:13:05.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:94:0)
[23:13:05.599] Timer tick, asking Buildbucket for the build status
[23:13:05.671] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:95:0) after 1m0s
[23:14:05.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:95:0)
[23:14:05.789] Timer tick, asking Buildbucket for the build status
[23:14:05.936] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:05.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:96:0) after 1m0s
[23:15:05.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:96:0)
[23:15:05.937] Timer tick, asking Buildbucket for the build status
[23:15:06.023] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:06.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:97:0) after 1m0s
[23:16:06.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:97:0)
[23:16:06.049] Timer tick, asking Buildbucket for the build status
[23:16:06.670] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:06.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:98:0) after 1m0s
[23:17:06.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:98:0)
[23:17:06.701] Timer tick, asking Buildbucket for the build status
[23:17:06.800] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:06.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:99:0) after 1m0s
[23:18:06.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:99:0)
[23:18:06.785] Timer tick, asking Buildbucket for the build status
[23:18:06.969] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:06.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:100:0) after 1m0s
[23:19:06.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:100:0)
[23:19:06.990] Timer tick, asking Buildbucket for the build status
[23:19:07.072] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:101:0) after 1m0s
[23:20:07.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:101:0)
[23:20:07.109] Timer tick, asking Buildbucket for the build status
[23:20:07.194] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:07.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:102:0) after 1m0s
[23:21:07.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:102:0)
[23:21:07.262] Timer tick, asking Buildbucket for the build status
[23:21:07.405] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:07.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:103:0) after 1m0s
[23:22:07.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:103:0)
[23:22:07.426] Timer tick, asking Buildbucket for the build status
[23:22:07.564] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:07.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:104:0) after 1m0s
[23:23:07.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:104:0)
[23:23:07.590] Timer tick, asking Buildbucket for the build status
[23:23:07.697] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:07.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:105:0) after 1m0s
[23:24:07.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:105:0)
[23:24:07.687] Timer tick, asking Buildbucket for the build status
[23:24:08.119] Build 8857640855044670096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:08.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023070917011136080:106:0) after 1m0s
[23:24:54.049] Received PubSub notification, asking Buildbucket for the build status
[23:24:54.130] Build 8857640855044670096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:24:54.130] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611098692145489",
"created_by": "project:chromium",
"created_ts": "1611092434801517",
"id": "8857640855044670096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b78ae9c8966b012c5fdb457fa408bc92b38e715\"}}",
"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\": \"6b78ae9c8966b012c5fdb457fa408bc92b38e715\", \"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-86-wu7l\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22262, \"got_angle_revision\": \"e670fc72a5aec91c7b0249c6512993a77f3ac14d\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"6b78ae9c8966b012c5fdb457fa408bc92b38e715\", \"got_revision_cp\": \"refs/heads/master@{#844913}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"870bd0b9a8bc7aa777926e94b031264fcddca0d1\", \"got_v8_revision_cp\": \"refs/heads/9.0.15@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"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\": \"6b78ae9c8966b012c5fdb457fa408bc92b38e715\", \"swarm_hashes_refs/heads/master(at){#844913}_without_patch\": {\"absl_hardening_tests\": \"f507254870a66da721d776f282bac06cce775a6f\", \"accessibility_unittests\": \"11d075ff87398e40b6f6de7a837649304c963352\", \"angle_unittests\": \"ab191e7fb00cc3600a7cb31310be3d31224fe7fa\", \"app_list_unittests\": \"5e6706c762d8331bfe9fd81cc2910b8d8c7babe3\", \"app_shell_unittests\": \"c4cc24a45f85ba5e2defc5937f89bd2a162542c7\", \"ash_unittests\": \"8391bae4baa3c7a5a2511f616d6c0e39388af458\", \"aura_unittests\": \"60c60cc8fa39ab062e33095f1d22cb4b0c2d122f\", \"base_unittests\": \"a5676fe2da160962f6ac7c565ab0a6d028a66caf\", \"base_util_unittests\": \"35aef6ceb19f3396a357c8a445cfd070cf8e09f7\", \"blink_common_unittests\": \"bed4a51650e0369ee5153d15fb5fd877afead152\", \"blink_fuzzer_unittests\": \"7e1c9437ca1c3d54c6d68a5a23f395ce78d17c09\", \"blink_heap_unittests\": \"7ea4b86dfb5c7728d76075852e4bdff5410ed428\", \"blink_platform_unittests\": \"3e56c321f40cc78012726d2b41f3a3924595804d\", \"blink_unittests\": \"740c4a79b2a272269a1edb40bb0ff8f6edf36bda\", \"boringssl_crypto_tests\": \"e63aa6b4c7f5cbc8458ea033a0591f2abd071d66\", \"boringssl_ssl_tests\": \"39cd58b84d023b7afb91f19d5707f841b0752d57\", \"browser_tests\": \"d09be272e6851affabbd73d65c0d0de88013dc73\", \"capture_unittests\": \"cdb41efeb1c89e3aafc79d63c815f3a5e3d79580\", \"cast_unittests\": \"5399e9fa79c1835ef4d5b3e2059daba81672dce0\", \"cc_unittests\": \"a984600522307a01d16c98dcdeb8adbd752d904a\", \"chrome_app_unittests\": \"59a9dca3775ea982c7325fae8b12debe9ec8fca7\", \"chromedriver_unittests\": \"98c824ae9548b145eb16fdbe689aca2f60f84b70\", \"chromeos_components_unittests\": \"9f62ec687f55fc9ac94615a8b568b2ce2be8d2ea\", \"chromeos_unittests\": \"977ed0f585a2772034d22447d0832480443b4c22\", \"components_browsertests\": \"7c7b765c5f10673c1ce8ec341288d992f6fad644\", \"components_unittests\": \"6b02575077f18ff9f2002f620e5ea8d39368d1e1\", \"compositor_unittests\": \"9fdc53d871a4cfb84a11a3f5b14d9fe87c8abf43\", \"content_browsertests\": \"aa048c0268f4dace6e4b95c98e2804a447322692\", \"content_unittests\": \"e1a79d115e079d440be4f442f8171000123bbd68\", \"crashpad_tests\": \"1cb6801e3fdf3bee55646957dd21e5bfffdbb465\", \"crypto_unittests\": \"96d6979e9f18369ad034ba9d3b1341fa0fc1375d\", \"dbus_unittests\": \"9a79654461ee96f2770aaa215e284be5762ad01c\", \"device_unittests\": \"18c5221341e868e9f9f7ba53c37f7b2b56a8b41e\", \"display_unittests\": \"e4a6f8f17e87fe6c2a09460bc00bdc11d95634bc\", \"events_unittests\": \"31e78273706c44af2dff9d7f37fad2c73271c903\", \"exo_unittests\": \"a73415af7e3e990e55126b0709eade0851476ba2\", \"extensions_browsertests\": \"8b025fa2ec2d0ad2072e9ba934381f882291e8b0\", \"extensions_unittests\": \"853242dd9d512bdef220f054e0954c7ed7386018\", \"filesystem_service_unittests\": \"b5516a03468d3e19bef64393893d742acd62030e\", \"gcm_unit_tests\": \"ebcebdccfac78624bd231fcd36f277ea59b8f62f\", \"gfx_unittests\": \"032216730c9566c920285cc56b4a09c738c60d7c\", \"gin_unittests\": \"204de85f3398cd55304f63bfc0e1b9cef275a688\", \"gl_unittests_ozone\": \"ed42e1251e12ce98049e7a42f5ee018b4ec24367\", \"google_apis_unittests\": \"5544ae981a04056c713a23e9740cea777b2a6508\", \"gpu_unittests\": \"18925147806db0a6559128f453ba9861cc9b9f60\", \"gwp_asan_unittests\": \"c7a8437fe89b5fec2179176b83fc85729f74ca2d\", \"interactive_ui_tests\": \"d3b461ee91206e7e8723ca0be6e24d40b40992d0\", \"ipc_tests\": \"8dd2cc1e9ce0cf94f016c0e2f4cce25d09943ec0\", \"jingle_unittests\": \"5fee24ee29fe039766ead41fe1bec99410a46702\", \"keyboard_unittests\": \"5ea5d182b7cf9db84b41d6ab62a721d5c38e87e3\", \"latency_unittests\": \"fd637459b632b500ca2c1f2caaf06ace2b759c24\", \"libjingle_xmpp_unittests\": \"4c0b388725afa24ddc4bb03985fad7f986eb1e61\", \"liburlpattern_unittests\": \"cf0162613240a2dcb8563cec669e5d6e513b3c5c\", \"media_blink_unittests\": \"930bfc4e5af30ca1b8bcf1f48babcfd04ba1a456\", \"media_unittests\": \"f0fd304dd7c708246f3257c161423b4dd1bf6c75\", \"message_center_unittests\": \"ce129bd8c7d6bb74836e10e19af06a35432c7cb9\", \"midi_unittests\": \"6e259027fc3e897472aa25c935c205d1f7f43d84\", \"mojo_core_unittests\": \"93bfa3357c41140bebc8215f43976b878074a8ab\", \"mojo_unittests\": \"165a9183b91393cfdc73fcd655d33b9d00d1754b\", \"nacl_helper_nonsfi_unittests\": \"27d0d7725516ff7440dca9a897b9c7e3c3b3a5f0\", \"nacl_loader_unittests\": \"1a09e1dcb073f11a6e1cabdd4ace0d3ec406279d\", \"native_theme_unittests\": \"6dd9d7992a819e948ccd73dd4e57a879e0f5bb9a\", \"net_unittests\": \"575811aaed1efc660a35be7289a83adcf201f1de\", \"ozone_gl_unittests\": \"4c9d784cc6c2d690bd72d2a64a5c084082300e5b\", \"ozone_unittests\": \"751aa7dc6ca7b0e2cb6030786ef9349dda6e8e6b\", \"ozone_x11_unittests\": \"c8b843a4a65fd859b7c7ed6e3427fcaf6c50b91a\", \"pdf_unittests\": \"d9be619dcd994f72fa3319c240f2902df02801e8\", \"perfetto_unittests\": \"37a236427588a0f1320c373bae8c224bee4f77f7\", \"ppapi_unittests\": \"8aa49e6cae22ad1bd2a996ea5baa00f935866c70\", \"printing_unittests\": \"343cc0c7e5ce3c3a3dd28f458e058baca532cc74\", \"remoting_unittests\": \"4097387fd3b06b32e53475ad6ac1154fd71dce0c\", \"sandbox_linux_unittests\": \"4acb8130c64e89793a6db26e6904966030a7e258\", \"service_manager_unittests\": \"6a01c20a0779e3f3beae32fce7a543c0066d9eb1\", \"services_unittests\": \"c5b8e1f5f1af3babb581ff4388231bdd78d6b545\", \"shell_dialogs_unittests\": \"07f8008fb128d5987367db9e0129fcd02a36a20d\", \"shell_encryption_unittests\": \"6d31eaa8538792da637fca0035a1d3e899cd8d82\", \"skia_unittests\": \"119ae1bbe06abea474f9f79b8b3c4dd17f076995\", \"snapshot_unittests\": \"429076672ebf3783eaf00aeaa406a79b979be0fb\", \"sql_unittests\": \"42a479e020e26e8d5260fd6969ec45f1b7c2c559\", \"storage_unittests\": \"977f02f8308a9bc1f07ee97ebf370d6de0a89539\", \"sync_integration_tests\": \"ad7bc3c7c99ab0b7febb82c22a4d8cc429730d4f\", \"traffic_annotation_auditor_unittests\": \"34a3e6469d583aad98b92713e69e97e020ee6a4b\", \"ui_base_unittests\": \"7606d868eb1e41344203de056efb67259a94fb3c\", \"ui_chromeos_unittests\": \"21c62bb4599244459044cfe7fb0e2d014f1d9006\", \"ui_touch_selection_unittests\": \"83d65e395d7ee2be4e5e242edcfd375bf0cfbbef\", \"unit_tests\": \"f3aa1f0ca802dee9da9f0cacb4de5bea3395db45\", \"url_unittests\": \"09649d9809a76fc3df65d04ef0b9c0c1463754dd\", \"usage_time_limit_unittests\": \"6721d42a2351fefc7be8385534a26ac6f027843a\", \"views_unittests\": \"f30f7b475d6bf069211cbca72365bd0fb5cc0525\", \"viz_unittests\": \"afed0d24633e109e4c98cb10a9a854daf0ae27bc\", \"wm_unittests\": \"0d56156473228d0417afd60534a8d8929c630297\", \"wtf_unittests\": \"69881f64560afb5a035859e5243ab6ac61951644\", \"zlib_unittests\": \"20605de5845071bf4391eb184015ceedc544ddb1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-86-wu7l\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611092562421011",
"status": "COMPLETED",
"status_changed_ts": "1611098692610476",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22262",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b78ae9c8966b012c5fdb457fa408bc92b38e715",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023070917011136080",
"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/8857640855044670096/+/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:5135692c5a095410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611098692696165",
"url": "https://ci.chromium.org/b/8857640855044670096",
"utcnow_ts": "1611098694121749"
}
}
[23:24:54.130] Invocation finished in 1h44m20.587664554s with status SUCCEEDED