[15:08:52.963] New invocation is queued and will start shortly
[15:08:54.167] Starting the invocation (attempt 1)
[15:08:54.228] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:08:54.228] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:08:54.228] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029618540755678944",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dbd091f2f20ac98be38683aa1292b39593a687e7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029618540755678944",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/dbd091f2f20ac98be38683aa1292b39593a687e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dbd091f2f20ac98be38683aa1292b39593a687e7",
"gitiles_ref:refs/heads/master"
]
}
[15:08:54.838] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604848134329667",
"id": "8864188478655813296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dbd091f2f20ac98be38683aa1292b39593a687e7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604848134724114",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21208",
"builder:linux-chromeos-dbg",
"buildset:commit/git/dbd091f2f20ac98be38683aa1292b39593a687e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dbd091f2f20ac98be38683aa1292b39593a687e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029618540755678944",
"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/8864188478655813296/+/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": "1604848134724252",
"url": "https://ci.chromium.org/b/8864188478655813296",
"utcnow_ts": "1604848134825644"
}
}
[15:08:54.838] Task URL: https://ci.chromium.org/b/8864188478655813296
[15:08:54.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:2:0) after 1m0s
[15:09:54.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:2:0)
[15:09:54.873] Timer tick, asking Buildbucket for the build status
[15:09:54.974] Build 8864188478655813296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:54.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:3:0) after 1m0s
[15:10:54.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:3:0)
[15:10:54.995] Timer tick, asking Buildbucket for the build status
[15:10:55.073] Build 8864188478655813296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:55.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:4:0) after 1m0s
[15:11:55.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:4:0)
[15:11:55.138] Timer tick, asking Buildbucket for the build status
[15:11:55.415] Build 8864188478655813296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:55.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:5:0) after 1m0s
[15:12:55.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:5:0)
[15:12:55.462] Timer tick, asking Buildbucket for the build status
[15:12:55.635] Build 8864188478655813296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:55.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:6:0) after 1m0s
[15:13:07.112] Received PubSub notification, asking Buildbucket for the build status
[15:13:07.195] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:55.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:6:0)
[15:13:55.675] Timer tick, asking Buildbucket for the build status
[15:13:55.781] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:55.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:8:0) after 1m0s
[15:14:55.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:8:0)
[15:14:55.767] Timer tick, asking Buildbucket for the build status
[15:14:56.057] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:56.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:9:0) after 1m0s
[15:15:56.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:9:0)
[15:15:56.111] Timer tick, asking Buildbucket for the build status
[15:15:56.179] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:56.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:10:0) after 1m0s
[15:16:56.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:10:0)
[15:16:56.253] Timer tick, asking Buildbucket for the build status
[15:16:56.527] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:56.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:11:0) after 1m0s
[15:17:56.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:11:0)
[15:17:56.559] Timer tick, asking Buildbucket for the build status
[15:17:58.698] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:58.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:12:0) after 1m0s
[15:18:58.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:12:0)
[15:18:58.836] Timer tick, asking Buildbucket for the build status
[15:18:58.963] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:58.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:13:0) after 1m0s
[15:19:59.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:13:0)
[15:19:59.106] Timer tick, asking Buildbucket for the build status
[15:19:59.360] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:59.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:14:0) after 1m0s
[15:20:59.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:14:0)
[15:20:59.416] Timer tick, asking Buildbucket for the build status
[15:20:59.484] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:59.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:15:0) after 1m0s
[15:21:59.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:15:0)
[15:21:59.547] Timer tick, asking Buildbucket for the build status
[15:21:59.637] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:59.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:16:0) after 1m0s
[15:22:59.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:16:0)
[15:22:59.678] Timer tick, asking Buildbucket for the build status
[15:22:59.779] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:59.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:17:0) after 1m0s
[15:23:59.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:17:0)
[15:23:59.828] Timer tick, asking Buildbucket for the build status
[15:23:59.928] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:59.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:18:0) after 1m0s
[15:24:59.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:18:0)
[15:24:59.959] Timer tick, asking Buildbucket for the build status
[15:25:00.238] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:00.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:19:0) after 1m0s
[15:26:00.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:19:0)
[15:26:00.260] Timer tick, asking Buildbucket for the build status
[15:26:00.364] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:00.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:20:0) after 1m0s
[15:27:00.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:20:0)
[15:27:00.430] Timer tick, asking Buildbucket for the build status
[15:27:00.498] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:00.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:21:0) after 1m0s
[15:28:00.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:21:0)
[15:28:00.548] Timer tick, asking Buildbucket for the build status
[15:28:00.617] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:00.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:22:0) after 1m0s
[15:29:10.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:22:0)
[15:29:10.335] Timer tick, asking Buildbucket for the build status
[15:29:10.437] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:10.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:23:0) after 1m0s
[15:30:10.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:23:0)
[15:30:10.473] Timer tick, asking Buildbucket for the build status
[15:30:10.618] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:10.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:24:0) after 1m0s
[15:31:10.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:24:0)
[15:31:10.884] Timer tick, asking Buildbucket for the build status
[15:31:10.984] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:10.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:25:0) after 1m0s
[15:32:11.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:25:0)
[15:32:11.357] Timer tick, asking Buildbucket for the build status
[15:32:11.647] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:11.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:26:0) after 1m0s
[15:33:11.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:26:0)
[15:33:11.715] Timer tick, asking Buildbucket for the build status
[15:33:11.976] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:11.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:27:0) after 1m0s
[15:34:12.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:27:0)
[15:34:12.061] Timer tick, asking Buildbucket for the build status
[15:34:12.167] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:12.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:28:0) after 1m0s
[15:35:12.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:28:0)
[15:35:12.250] Timer tick, asking Buildbucket for the build status
[15:35:12.378] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:12.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:29:0) after 1m0s
[15:36:12.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:29:0)
[15:36:12.412] Timer tick, asking Buildbucket for the build status
[15:36:12.541] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:12.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:30:0) after 1m0s
[15:37:12.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:30:0)
[15:37:12.703] Timer tick, asking Buildbucket for the build status
[15:37:12.776] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:12.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:31:0) after 1m0s
[15:38:12.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:31:0)
[15:38:12.846] Timer tick, asking Buildbucket for the build status
[15:38:12.922] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:12.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:32:0) after 1m0s
[15:39:13.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:32:0)
[15:39:13.019] Timer tick, asking Buildbucket for the build status
[15:39:13.119] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:13.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:33:0) after 1m0s
[15:40:13.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:33:0)
[15:40:13.239] Timer tick, asking Buildbucket for the build status
[15:40:13.297] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:13.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:34:0) after 1m0s
[15:41:13.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:34:0)
[15:41:13.481] Timer tick, asking Buildbucket for the build status
[15:41:13.544] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:13.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:35:0) after 1m0s
[15:42:13.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:35:0)
[15:42:13.596] Timer tick, asking Buildbucket for the build status
[15:42:13.673] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:13.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:36:0) after 1m0s
[15:43:13.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:36:0)
[15:43:13.727] Timer tick, asking Buildbucket for the build status
[15:43:13.807] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:13.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:37:0) after 1m0s
[15:44:13.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:37:0)
[15:44:13.867] Timer tick, asking Buildbucket for the build status
[15:44:14.126] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:14.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:38:0) after 1m0s
[15:45:14.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:38:0)
[15:45:14.120] Timer tick, asking Buildbucket for the build status
[15:45:14.199] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:14.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:39:0) after 1m0s
[15:46:14.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:39:0)
[15:46:14.244] Timer tick, asking Buildbucket for the build status
[15:46:14.364] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:14.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:40:0) after 1m0s
[15:47:14.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:40:0)
[15:47:14.424] Timer tick, asking Buildbucket for the build status
[15:47:14.498] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:14.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:41:0) after 1m0s
[15:48:14.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:41:0)
[15:48:14.619] Timer tick, asking Buildbucket for the build status
[15:48:14.687] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:14.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:42:0) after 1m0s
[15:49:14.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:42:0)
[15:49:14.887] Timer tick, asking Buildbucket for the build status
[15:49:15.000] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:15.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:43:0) after 1m0s
[15:50:15.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:43:0)
[15:50:15.025] Timer tick, asking Buildbucket for the build status
[15:50:15.081] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:15.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:44:0) after 1m0s
[15:51:15.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:44:0)
[15:51:15.109] Timer tick, asking Buildbucket for the build status
[15:51:15.173] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:15.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:45:0) after 1m0s
[15:52:15.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:45:0)
[15:52:15.247] Timer tick, asking Buildbucket for the build status
[15:52:15.338] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:15.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:46:0) after 1m0s
[15:53:15.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:46:0)
[15:53:15.438] Timer tick, asking Buildbucket for the build status
[15:53:15.569] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:15.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:47:0) after 1m0s
[15:54:15.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:47:0)
[15:54:15.618] Timer tick, asking Buildbucket for the build status
[15:54:15.733] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:15.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:48:0) after 1m0s
[15:55:15.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:48:0)
[15:55:15.777] Timer tick, asking Buildbucket for the build status
[15:55:15.858] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:49:0) after 1m0s
[15:56:15.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:49:0)
[15:56:15.933] Timer tick, asking Buildbucket for the build status
[15:56:16.052] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:16.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:50:0) after 1m0s
[15:57:16.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:50:0)
[15:57:16.079] Timer tick, asking Buildbucket for the build status
[15:57:16.261] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:16.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:51:0) after 1m0s
[15:58:16.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:51:0)
[15:58:16.334] Timer tick, asking Buildbucket for the build status
[15:58:16.490] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:16.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:52:0) after 1m0s
[15:59:16.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:52:0)
[15:59:16.692] Timer tick, asking Buildbucket for the build status
[15:59:16.804] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:16.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:53:0) after 1m0s
[16:00:16.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:53:0)
[16:00:16.954] Timer tick, asking Buildbucket for the build status
[16:00:17.555] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:17.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:54:0) after 1m0s
[16:01:17.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:54:0)
[16:01:17.628] Timer tick, asking Buildbucket for the build status
[16:01:17.968] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:17.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:55:0) after 1m0s
[16:02:18.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:55:0)
[16:02:18.070] Timer tick, asking Buildbucket for the build status
[16:02:18.231] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:18.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:56:0) after 1m0s
[16:03:18.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:56:0)
[16:03:18.269] Timer tick, asking Buildbucket for the build status
[16:03:18.375] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:18.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:57:0) after 1m0s
[16:04:18.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:57:0)
[16:04:18.416] Timer tick, asking Buildbucket for the build status
[16:04:18.516] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:18.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:58:0) after 1m0s
[16:05:18.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:58:0)
[16:05:18.568] Timer tick, asking Buildbucket for the build status
[16:05:18.691] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:18.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:59:0) after 1m0s
[16:06:18.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:59:0)
[16:06:18.791] Timer tick, asking Buildbucket for the build status
[16:06:18.939] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:18.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:60:0) after 1m0s
[16:07:19.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:60:0)
[16:07:19.001] Timer tick, asking Buildbucket for the build status
[16:07:19.129] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:19.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:61:0) after 1m0s
[16:08:19.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:61:0)
[16:08:19.252] Timer tick, asking Buildbucket for the build status
[16:08:19.386] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:19.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:62:0) after 1m0s
[16:09:19.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:62:0)
[16:09:19.494] Timer tick, asking Buildbucket for the build status
[16:09:20.002] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:20.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:63:0) after 1m0s
[16:10:20.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:63:0)
[16:10:20.026] Timer tick, asking Buildbucket for the build status
[16:10:20.107] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:20.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:64:0) after 1m0s
[16:11:20.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:64:0)
[16:11:20.135] Timer tick, asking Buildbucket for the build status
[16:11:20.223] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:20.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:65:0) after 1m0s
[16:12:20.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:65:0)
[16:12:20.276] Timer tick, asking Buildbucket for the build status
[16:12:20.353] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:66:0) after 1m0s
[16:13:20.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:66:0)
[16:13:20.467] Timer tick, asking Buildbucket for the build status
[16:13:20.611] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:20.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:67:0) after 1m0s
[16:14:20.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:67:0)
[16:14:20.686] Timer tick, asking Buildbucket for the build status
[16:14:20.860] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:20.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:68:0) after 1m0s
[16:15:20.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:68:0)
[16:15:20.904] Timer tick, asking Buildbucket for the build status
[16:15:21.249] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:21.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:69:0) after 1m0s
[16:16:21.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:69:0)
[16:16:21.252] Timer tick, asking Buildbucket for the build status
[16:16:21.333] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:21.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:70:0) after 1m0s
[16:17:21.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:70:0)
[16:17:21.381] Timer tick, asking Buildbucket for the build status
[16:17:21.523] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:21.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:71:0) after 1m0s
[16:18:21.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:71:0)
[16:18:21.579] Timer tick, asking Buildbucket for the build status
[16:18:21.938] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:21.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:72:0) after 1m0s
[16:19:21.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:72:0)
[16:19:21.971] Timer tick, asking Buildbucket for the build status
[16:19:22.092] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:22.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:73:0) after 1m0s
[16:20:22.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:73:0)
[16:20:22.128] Timer tick, asking Buildbucket for the build status
[16:20:22.661] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:22.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:74:0) after 1m0s
[16:21:22.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:74:0)
[16:21:22.690] Timer tick, asking Buildbucket for the build status
[16:21:22.809] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:22.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:75:0) after 1m0s
[16:22:22.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:75:0)
[16:22:22.938] Timer tick, asking Buildbucket for the build status
[16:22:23.200] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:23.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:76:0) after 1m0s
[16:23:23.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:76:0)
[16:23:23.233] Timer tick, asking Buildbucket for the build status
[16:23:23.430] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:23.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:77:0) after 1m0s
[16:24:23.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:77:0)
[16:24:23.464] Timer tick, asking Buildbucket for the build status
[16:24:23.587] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:23.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:78:0) after 1m0s
[16:25:23.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:78:0)
[16:25:23.613] Timer tick, asking Buildbucket for the build status
[16:25:23.684] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:23.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:79:0) after 1m0s
[16:26:23.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:79:0)
[16:26:23.719] Timer tick, asking Buildbucket for the build status
[16:26:23.941] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:80:0) after 1m0s
[16:27:23.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:80:0)
[16:27:23.973] Timer tick, asking Buildbucket for the build status
[16:27:24.103] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:24.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:81:0) after 1m0s
[16:28:24.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:81:0)
[16:28:24.151] Timer tick, asking Buildbucket for the build status
[16:28:24.243] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:24.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:82:0) after 1m0s
[16:29:24.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:82:0)
[16:29:24.270] Timer tick, asking Buildbucket for the build status
[16:29:24.387] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:24.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:83:0) after 1m0s
[16:30:24.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:83:0)
[16:30:24.425] Timer tick, asking Buildbucket for the build status
[16:30:24.504] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:24.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:84:0) after 1m0s
[16:31:24.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:84:0)
[16:31:24.704] Timer tick, asking Buildbucket for the build status
[16:31:24.928] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:24.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:85:0) after 1m0s
[16:32:24.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:85:0)
[16:32:24.983] Timer tick, asking Buildbucket for the build status
[16:32:25.181] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:25.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:86:0) after 1m0s
[16:33:25.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:86:0)
[16:33:25.225] Timer tick, asking Buildbucket for the build status
[16:33:25.295] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:25.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:87:0) after 1m0s
[16:34:25.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:87:0)
[16:34:25.383] Timer tick, asking Buildbucket for the build status
[16:34:25.505] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:25.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:88:0) after 1m0s
[16:35:25.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:88:0)
[16:35:25.640] Timer tick, asking Buildbucket for the build status
[16:35:25.807] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:25.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:89:0) after 1m0s
[16:36:25.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:89:0)
[16:36:25.946] Timer tick, asking Buildbucket for the build status
[16:36:26.062] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:26.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:90:0) after 1m0s
[16:37:26.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:90:0)
[16:37:26.161] Timer tick, asking Buildbucket for the build status
[16:37:26.241] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:26.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:91:0) after 1m0s
[16:38:26.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:91:0)
[16:38:26.391] Timer tick, asking Buildbucket for the build status
[16:38:26.571] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:26.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:92:0) after 1m0s
[16:39:26.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:92:0)
[16:39:26.687] Timer tick, asking Buildbucket for the build status
[16:39:26.799] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:26.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:93:0) after 1m0s
[16:40:26.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:93:0)
[16:40:26.908] Timer tick, asking Buildbucket for the build status
[16:40:27.226] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:27.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:94:0) after 1m0s
[16:41:27.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:94:0)
[16:41:27.335] Timer tick, asking Buildbucket for the build status
[16:41:27.663] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:27.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:95:0) after 1m0s
[16:42:27.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:95:0)
[16:42:27.714] Timer tick, asking Buildbucket for the build status
[16:42:28.738] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:28.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:96:0) after 1m0s
[16:43:28.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:96:0)
[16:43:28.773] Timer tick, asking Buildbucket for the build status
[16:43:28.838] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:28.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:97:0) after 1m0s
[16:44:28.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:97:0)
[16:44:28.879] Timer tick, asking Buildbucket for the build status
[16:44:29.064] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:29.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:98:0) after 1m0s
[16:45:29.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:98:0)
[16:45:29.072] Timer tick, asking Buildbucket for the build status
[16:45:29.159] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:29.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:99:0) after 1m0s
[16:46:29.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:99:0)
[16:46:29.204] Timer tick, asking Buildbucket for the build status
[16:46:29.292] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:29.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:100:0) after 1m0s
[16:47:29.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:100:0)
[16:47:29.323] Timer tick, asking Buildbucket for the build status
[16:47:29.468] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:29.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:101:0) after 1m0s
[16:48:29.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:101:0)
[16:48:29.497] Timer tick, asking Buildbucket for the build status
[16:48:29.610] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:29.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:102:0) after 1m0s
[16:49:29.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:102:0)
[16:49:29.671] Timer tick, asking Buildbucket for the build status
[16:49:29.791] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:29.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:103:0) after 1m0s
[16:50:29.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:103:0)
[16:50:29.917] Timer tick, asking Buildbucket for the build status
[16:50:30.005] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:30.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:104:0) after 1m0s
[16:51:30.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:104:0)
[16:51:30.119] Timer tick, asking Buildbucket for the build status
[16:51:30.250] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:30.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:105:0) after 1m0s
[16:52:30.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:105:0)
[16:52:30.461] Timer tick, asking Buildbucket for the build status
[16:52:32.612] Build 8864188478655813296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029618540755678944:106:0) after 1m0s
[16:52:48.519] Received PubSub notification, asking Buildbucket for the build status
[16:52:48.851] Build 8864188478655813296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:52:48.851] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604854367361460",
"created_by": "project:chromium",
"created_ts": "1604848134329667",
"id": "8864188478655813296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dbd091f2f20ac98be38683aa1292b39593a687e7\"}}",
"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\": \"dbd091f2f20ac98be38683aa1292b39593a687e7\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-55-3ihg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21208, \"got_angle_revision\": \"aca3d408105d03683edd20b98b333c5064ac5254\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"dbd091f2f20ac98be38683aa1292b39593a687e7\", \"got_revision_cp\": \"refs/heads/master@{#825216}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"dbd091f2f20ac98be38683aa1292b39593a687e7\", \"swarm_hashes_refs/heads/master(at){#825216}_without_patch\": {\"absl_hardening_tests\": \"ce40a5b49dd9fe19f9d727e8339dbe513de9c73f\", \"accessibility_unittests\": \"0ad71572dae2c3be24eb566e89cc2a81d0ee385a\", \"angle_unittests\": \"4df724f51d2478d48bcf0782efc6ee3069a699d4\", \"app_list_unittests\": \"133969c99e5f3b59e92e9343542623e58cd850ec\", \"app_shell_unittests\": \"28f04234b3302a209b7a7200888fea5383c68931\", \"ash_unittests\": \"fb0d18a7e2c5a360e33b3bf0d62c2c3952768f54\", \"aura_unittests\": \"34a2746b3a5b8bcde45ee6c6ad857e7e56602964\", \"base_unittests\": \"0a293248e9fa011062f8600875279b4c4c49437d\", \"base_util_unittests\": \"412f89a1cb9e14ef21c5f072799b6641d673c666\", \"blink_common_unittests\": \"dbf8a4e80dc456213a09fbf8a3ee154ee43e15f0\", \"blink_fuzzer_unittests\": \"809541368b4eef0d1ce78ff4c62fa2c229ce9d9d\", \"blink_heap_unittests\": \"020b4d3c5397e13a4d0d0ebcc1876b66d5656baf\", \"blink_platform_unittests\": \"31b7ba21e1835e07122ec41dd1242b23eb85f561\", \"blink_unittests\": \"414682dad3b359fe7b566834cd5dd4302be449af\", \"boringssl_crypto_tests\": \"0d74ade5d9775f9f2db17416ead0dce0f0853b22\", \"boringssl_ssl_tests\": \"98100aea4fbe893dad96d7003919051805b5805e\", \"browser_tests\": \"9fc5adc978c7102dcb59dd65c3293152c7120e95\", \"capture_unittests\": \"84e6e34790170548760289b3a1c3d93071377c31\", \"cast_unittests\": \"4fd81138cd0f0adac435c2afb68f49522609a8a2\", \"cc_unittests\": \"e3da363381f856b9419b8fbdb92e56f6b6d119b1\", \"chrome_app_unittests\": \"f5469ff804e4758da16ac52e020113092eecc205\", \"chromedriver_unittests\": \"6ae4b6d2ca5ebd671bb207067e7de559f960821e\", \"chromeos_components_unittests\": \"4684c45dfd075d7953528ab64dfa0f288879886c\", \"chromeos_unittests\": \"1bbe072ae1968b70fc12757815494b7f1b1efbdf\", \"components_browsertests\": \"33c15c52ab784bb9bd4c02501bdd5f2198da667f\", \"components_unittests\": \"be364cd6b7b592b0b01da4d19eb9f5639bdad686\", \"compositor_unittests\": \"2c3c20fa35839dfe8ee2a6b5d050ef06ce9348c4\", \"content_browsertests\": \"f552be7c923d002c96da4869727b3f6bdd02062a\", \"content_unittests\": \"90f02638a6487bee6495bb444830d82dcc8202f1\", \"crypto_unittests\": \"b1daf4d38082e8ec161bf86c9ac6d2648c9f6561\", \"dbus_unittests\": \"e1ef42bc21676aef6bcfeb71441b32ca8aaa29a4\", \"device_unittests\": \"a474b1566b8063b0bb7c2f928882c814c81cdb5e\", \"display_unittests\": \"3bc587bd690eaaa26a4b75b2cbca45026ab72721\", \"events_unittests\": \"dbde5d4897762938c1ba26dde59c6032dce8dda1\", \"exo_unittests\": \"52565ff87768871f10126503396e33e0da2bd788\", \"extensions_browsertests\": \"d764fb6984e21bd2b29e8a797c30b867deb1c129\", \"extensions_unittests\": \"b669b34b91152d541ddb1c085611d80ca652a5c8\", \"filesystem_service_unittests\": \"4d1177302bf68a56e34eb2afc8bc6c80f434a551\", \"gcm_unit_tests\": \"ba93fd4a4d22e8716651d21adeebccee4b7b4333\", \"gfx_unittests\": \"5747a7b1454baf7292a43b413fdd8d042a813dc1\", \"gin_unittests\": \"f19fef069b22b305f10c65313caf65b9ae4a7d2e\", \"gl_unittests_ozone\": \"7afdd6ec19c2795497df66043ecdf9ecff1f2f7f\", \"google_apis_unittests\": \"e593fdc035571ac7b96bd6aeafd6f21628501ae3\", \"gpu_unittests\": \"034e06604a6f993cd920691e9673ebb926811eb1\", \"gwp_asan_unittests\": \"5eeb6b252db7d9d4ed48fcd706adea990c8ad654\", \"interactive_ui_tests\": \"c6119a67328878f62533c0f40f6525e6f1158d80\", \"ipc_tests\": \"ed0d04271097f48f893439570132fe3d1afb317f\", \"jingle_unittests\": \"c5613d2f1a374897ca4a5847383a49ff71fa7bbd\", \"keyboard_unittests\": \"d5102438c8d6f6f50805b40d4cc0b7eb231eadde\", \"latency_unittests\": \"e06dcf0e80a20887f9d99912d54783bc6278dac4\", \"libjingle_xmpp_unittests\": \"fa3ca1e69ca7bb4e564dbe07fc894127f04f15b3\", \"liburlpattern_unittests\": \"b034f965536a41ab08c3be89487c8c1fca953e50\", \"media_blink_unittests\": \"404fbe0c1397a72c26509e7e0c35b4f62de66542\", \"media_unittests\": \"3f573caf454bce3a4e6c3c293bd12867c6465261\", \"message_center_unittests\": \"29af5f84076068fa8caa177b5ba6b0671a939c24\", \"midi_unittests\": \"dcf31990f1282358a0c9a97a45085cbb49ac0bdd\", \"mojo_core_unittests\": \"fc4aaba6783e8ae105d2e3ad0bf678892c8300a7\", \"mojo_unittests\": \"116d3d43349b741cd3432c4137eee8513d0772e0\", \"nacl_helper_nonsfi_unittests\": \"5939f0cb91765df47a95cd32781d5c67088a6b69\", \"nacl_loader_unittests\": \"2abf540a64d4e310dd51c506c16ae9359ebf8a26\", \"native_theme_unittests\": \"fdcb02976f445aebabe2150b079919fbce416fbd\", \"net_unittests\": \"6345bb1dfccbd407bac97360154d1532fc7a2a90\", \"ozone_gl_unittests\": \"a7175debe87a5fc5b6637a4ac37f7252f6fd3a00\", \"ozone_unittests\": \"0d1547a8780e8444eacc8d97863029980c388389\", \"ozone_x11_unittests\": \"abb6ef822643b3b454a0eedc0fb1ffb9f78fa790\", \"pdf_unittests\": \"63d22eabbac94df8dd4b1e9f1df5645ace23be8f\", \"perfetto_unittests\": \"bcbd152622c4562ed0e4be9f3ec9d390cb2f7f10\", \"ppapi_unittests\": \"4e50251bc0705755f702bfa812ee45cf6121dcdc\", \"printing_unittests\": \"11422cabd0ad376e2225c4629b22bd80cf022938\", \"remoting_unittests\": \"6c3ef7f50493efc0196e6263f39b06c82786182e\", \"sandbox_linux_unittests\": \"1063e21590d7b529b86eb2f91112b4122372ab09\", \"service_manager_unittests\": \"66a372275a027a6a6a03066a48f4e96f9827af04\", \"services_unittests\": \"eea6cebfb8261e76e4a1afe74cd23fbc1f1a55ac\", \"shell_dialogs_unittests\": \"e184913fd652e0460981be78716732f2b21993ac\", \"skia_unittests\": \"7d777fe48f0149e8c8a31d44b443ca748012f90e\", \"snapshot_unittests\": \"3d6cd9c77ea227f5c67a51dcf41db75570c662c5\", \"sql_unittests\": \"ba2a7dbc3f3fb4c02f70e3a8823a2c65a4468964\", \"storage_unittests\": \"1a20ed17859bc5fcc9b0c30c9a22bbc9fdf4d360\", \"sync_integration_tests\": \"b776ec13316160626edcdb997e5c3203596a77ac\", \"traffic_annotation_auditor_unittests\": \"ac027e7a91cb4613baab50e158156168a21df03b\", \"ui_base_unittests\": \"dda045cc7d29f7627f194375727c1b990c62dcc8\", \"ui_chromeos_unittests\": \"5d7efd3e4f03b36783a238dd6bcc8b92ce7d11dd\", \"ui_touch_selection_unittests\": \"91fc94f74993448cc76a9c7328a1281bc7a44c5f\", \"unit_tests\": \"6d8d27411360335395d75c78623493cbb3eab3eb\", \"url_unittests\": \"bef73fc227049a52e0e822a8ee3c6ef45cce4b1d\", \"usage_time_limit_unittests\": \"02e4837e6a62cc7993ef0d93558fe834edcbee4c\", \"views_unittests\": \"324db2b78cccf2189b4c7cecd59eec34c49f2fe6\", \"viz_unittests\": \"5b6908ba0cf4e6fe39f81d17357ff0362233fdd6\", \"wm_unittests\": \"01f3ded72ac0829ad720caab833066372d6bdf98\", \"wtf_unittests\": \"19e8a5a77da4929b49ff4a54b983717e7a2804a6\", \"zlib_unittests\": \"04529bbf9e74eec28c657dd513a1d57c59acc842\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_4f2591ede8786d6a64772378dd14b2c2025b224161485e8988b4d5f036ceec5d_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_65593a18063fd659fc9e395a6af5ebbc0164c16c5230228d6fc0d5070f7b5b50_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_a3b3a06131dfa9924971b27d0acd4e18e80a2242b6d6ae41f94b770d7c996d6f_v2\", \"builder_e178daccd68499cbb9a2f37c9af80f551f8c5ddb8a7bbdd3e316e81b331c8168_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-55-3ihg\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604848383597270",
"status": "COMPLETED",
"status_changed_ts": "1604854367839846",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21208",
"builder:linux-chromeos-dbg",
"buildset:commit/git/dbd091f2f20ac98be38683aa1292b39593a687e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dbd091f2f20ac98be38683aa1292b39593a687e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029618540755678944",
"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/8864188478655813296/+/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:4fc138b4569d9d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604854367849147",
"url": "https://ci.chromium.org/b/8864188478655813296",
"utcnow_ts": "1604854368841893"
}
}
[16:52:48.851] Invocation finished in 1h43m55.908025861s with status SUCCEEDED