[04:06:17.191] New invocation is queued and will start shortly
[04:06:18.427] Starting the invocation (attempt 1)
[04:06:18.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:06:18.470] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:06:18.471] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019060382633169488",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"02dd21b43ff2fff841f8d864219c0d473d24df5b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019060382633169488",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"gitiles_ref:refs/heads/master"
]
}
[04:06:19.412] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614917178646139",
"id": "8853630320441942624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"02dd21b43ff2fff841f8d864219c0d473d24df5b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614917179239341",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22870",
"builder:linux-chromeos-dbg",
"buildset:commit/git/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019060382633169488",
"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/8853630320441942624/+/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": "1614917179239445",
"url": "https://ci.chromium.org/b/8853630320441942624",
"utcnow_ts": "1614917179404739"
}
}
[04:06:19.412] Task URL: https://ci.chromium.org/b/8853630320441942624
[04:06:19.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:2:0) after 1m0s
[04:06:38.114] Received PubSub notification, asking Buildbucket for the build status
[04:06:38.218] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:19.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:2:0)
[04:07:19.525] Timer tick, asking Buildbucket for the build status
[04:07:19.614] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:19.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:4:0) after 1m0s
[04:08:20.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:4:0)
[04:08:20.045] Timer tick, asking Buildbucket for the build status
[04:08:20.197] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:20.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:5:0) after 1m0s
[04:09:20.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:5:0)
[04:09:20.576] Timer tick, asking Buildbucket for the build status
[04:09:20.688] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:20.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:6:0) after 1m0s
[04:10:20.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:6:0)
[04:10:20.947] Timer tick, asking Buildbucket for the build status
[04:10:21.215] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:7:0) after 1m0s
[04:11:21.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:7:0)
[04:11:21.294] Timer tick, asking Buildbucket for the build status
[04:11:21.376] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:21.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:8:0) after 1m0s
[04:12:21.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:8:0)
[04:12:21.419] Timer tick, asking Buildbucket for the build status
[04:12:21.521] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:21.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:9:0) after 1m0s
[04:13:21.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:9:0)
[04:13:21.912] Timer tick, asking Buildbucket for the build status
[04:13:22.002] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:22.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:10:0) after 1m0s
[04:14:22.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:10:0)
[04:14:22.084] Timer tick, asking Buildbucket for the build status
[04:14:22.168] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:22.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:11:0) after 1m0s
[04:15:22.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:11:0)
[04:15:22.229] Timer tick, asking Buildbucket for the build status
[04:15:22.413] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:22.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:12:0) after 1m0s
[04:16:22.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:12:0)
[04:16:22.636] Timer tick, asking Buildbucket for the build status
[04:16:22.724] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:22.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:13:0) after 1m0s
[04:17:22.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:13:0)
[04:17:22.790] Timer tick, asking Buildbucket for the build status
[04:17:22.945] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:22.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:14:0) after 1m0s
[04:18:22.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:14:0)
[04:18:22.984] Timer tick, asking Buildbucket for the build status
[04:18:23.055] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:23.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:15:0) after 1m0s
[04:19:23.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:15:0)
[04:19:23.127] Timer tick, asking Buildbucket for the build status
[04:19:23.242] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:23.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:16:0) after 1m0s
[04:20:23.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:16:0)
[04:20:23.866] Timer tick, asking Buildbucket for the build status
[04:20:23.951] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:23.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:17:0) after 1m0s
[04:21:24.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:17:0)
[04:21:24.013] Timer tick, asking Buildbucket for the build status
[04:21:24.111] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:18:0) after 1m0s
[04:22:24.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:18:0)
[04:22:24.155] Timer tick, asking Buildbucket for the build status
[04:22:24.262] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:24.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:19:0) after 1m0s
[04:23:24.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:19:0)
[04:23:24.295] Timer tick, asking Buildbucket for the build status
[04:23:24.462] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:24.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:20:0) after 1m0s
[04:24:24.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:20:0)
[04:24:24.501] Timer tick, asking Buildbucket for the build status
[04:24:24.722] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:24.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:21:0) after 1m0s
[04:25:24.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:21:0)
[04:25:24.770] Timer tick, asking Buildbucket for the build status
[04:25:24.856] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:24.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:22:0) after 1m0s
[04:26:24.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:22:0)
[04:26:24.872] Timer tick, asking Buildbucket for the build status
[04:26:25.089] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:25.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:23:0) after 1m0s
[04:27:25.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:23:0)
[04:27:25.157] Timer tick, asking Buildbucket for the build status
[04:27:25.307] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:25.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:24:0) after 1m0s
[04:28:25.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:24:0)
[04:28:25.320] Timer tick, asking Buildbucket for the build status
[04:28:25.431] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:25.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:25:0) after 1m0s
[04:29:25.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:25:0)
[04:29:25.447] Timer tick, asking Buildbucket for the build status
[04:29:25.547] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:25.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:26:0) after 1m0s
[04:30:25.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:26:0)
[04:30:25.563] Timer tick, asking Buildbucket for the build status
[04:30:25.807] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:25.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:27:0) after 1m0s
[04:31:25.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:27:0)
[04:31:25.872] Timer tick, asking Buildbucket for the build status
[04:31:25.973] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:28:0) after 1m0s
[04:32:25.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:28:0)
[04:32:25.993] Timer tick, asking Buildbucket for the build status
[04:32:26.080] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:26.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:29:0) after 1m0s
[04:33:26.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:29:0)
[04:33:26.122] Timer tick, asking Buildbucket for the build status
[04:33:26.219] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:26.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:30:0) after 1m0s
[04:34:26.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:30:0)
[04:34:26.294] Timer tick, asking Buildbucket for the build status
[04:34:26.367] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:26.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:31:0) after 1m0s
[04:35:26.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:31:0)
[04:35:26.394] Timer tick, asking Buildbucket for the build status
[04:35:26.465] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:26.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:32:0) after 1m0s
[04:36:26.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:32:0)
[04:36:26.464] Timer tick, asking Buildbucket for the build status
[04:36:26.565] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:26.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:33:0) after 1m0s
[04:37:26.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:33:0)
[04:37:26.617] Timer tick, asking Buildbucket for the build status
[04:37:27.292] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:27.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:34:0) after 1m0s
[04:38:27.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:34:0)
[04:38:27.403] Timer tick, asking Buildbucket for the build status
[04:38:27.554] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:27.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:35:0) after 1m0s
[04:39:27.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:35:0)
[04:39:27.638] Timer tick, asking Buildbucket for the build status
[04:39:27.754] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:27.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:36:0) after 1m0s
[04:40:27.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:36:0)
[04:40:27.874] Timer tick, asking Buildbucket for the build status
[04:40:27.943] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:27.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:37:0) after 1m0s
[04:41:28.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:37:0)
[04:41:28.041] Timer tick, asking Buildbucket for the build status
[04:41:28.883] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:28.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:38:0) after 1m0s
[04:42:28.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:38:0)
[04:42:28.947] Timer tick, asking Buildbucket for the build status
[04:42:29.092] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:29.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:39:0) after 1m0s
[04:43:29.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:39:0)
[04:43:29.256] Timer tick, asking Buildbucket for the build status
[04:43:29.382] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:29.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:40:0) after 1m0s
[04:44:29.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:40:0)
[04:44:29.401] Timer tick, asking Buildbucket for the build status
[04:44:29.473] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:29.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:41:0) after 1m0s
[04:45:29.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:41:0)
[04:45:29.502] Timer tick, asking Buildbucket for the build status
[04:45:30.139] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:30.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:42:0) after 1m0s
[04:46:30.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:42:0)
[04:46:30.272] Timer tick, asking Buildbucket for the build status
[04:46:30.381] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:30.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:43:0) after 1m0s
[04:47:30.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:43:0)
[04:47:30.545] Timer tick, asking Buildbucket for the build status
[04:47:30.625] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:30.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:44:0) after 1m0s
[04:48:30.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:44:0)
[04:48:30.750] Timer tick, asking Buildbucket for the build status
[04:48:30.850] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:30.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:45:0) after 1m0s
[04:49:31.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:45:0)
[04:49:31.076] Timer tick, asking Buildbucket for the build status
[04:49:31.550] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:31.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:46:0) after 1m0s
[04:50:31.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:46:0)
[04:50:31.673] Timer tick, asking Buildbucket for the build status
[04:50:31.855] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:31.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:47:0) after 1m0s
[04:51:31.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:47:0)
[04:51:31.863] Timer tick, asking Buildbucket for the build status
[04:51:31.957] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:31.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:48:0) after 1m0s
[04:52:32.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:48:0)
[04:52:32.004] Timer tick, asking Buildbucket for the build status
[04:52:32.103] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:32.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:49:0) after 1m0s
[04:53:32.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:49:0)
[04:53:32.168] Timer tick, asking Buildbucket for the build status
[04:53:32.280] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:32.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:50:0) after 1m0s
[04:54:32.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:50:0)
[04:54:32.441] Timer tick, asking Buildbucket for the build status
[04:54:33.232] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:33.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:51:0) after 1m0s
[04:55:33.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:51:0)
[04:55:33.359] Timer tick, asking Buildbucket for the build status
[04:55:33.457] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:33.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:52:0) after 1m0s
[04:56:33.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:52:0)
[04:56:33.443] Timer tick, asking Buildbucket for the build status
[04:56:33.881] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:33.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:53:0) after 1m0s
[04:57:33.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:53:0)
[04:57:33.891] Timer tick, asking Buildbucket for the build status
[04:57:33.977] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:33.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:54:0) after 1m0s
[04:58:34.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:54:0)
[04:58:34.007] Timer tick, asking Buildbucket for the build status
[04:58:34.334] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:34.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:55:0) after 1m0s
[04:59:34.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:55:0)
[04:59:34.305] Timer tick, asking Buildbucket for the build status
[04:59:34.400] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:34.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:56:0) after 1m0s
[05:00:34.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:56:0)
[05:00:34.459] Timer tick, asking Buildbucket for the build status
[05:00:34.579] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:34.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:57:0) after 1m0s
[05:01:34.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:57:0)
[05:01:34.601] Timer tick, asking Buildbucket for the build status
[05:01:34.859] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:58:0) after 1m0s
[05:02:34.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:58:0)
[05:02:34.878] Timer tick, asking Buildbucket for the build status
[05:02:34.962] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:34.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:59:0) after 1m0s
[05:03:35.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:59:0)
[05:03:35.000] Timer tick, asking Buildbucket for the build status
[05:03:35.110] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:35.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:60:0) after 1m0s
[05:04:35.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:60:0)
[05:04:35.153] Timer tick, asking Buildbucket for the build status
[05:04:35.461] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:35.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:61:0) after 1m0s
[05:05:35.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:61:0)
[05:05:35.522] Timer tick, asking Buildbucket for the build status
[05:05:35.658] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:35.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:62:0) after 1m0s
[05:06:35.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:62:0)
[05:06:35.716] Timer tick, asking Buildbucket for the build status
[05:06:35.829] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:35.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:63:0) after 1m0s
[05:07:35.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:63:0)
[05:07:35.885] Timer tick, asking Buildbucket for the build status
[05:07:36.334] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:36.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:64:0) after 1m0s
[05:08:36.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:64:0)
[05:08:36.377] Timer tick, asking Buildbucket for the build status
[05:08:36.646] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:36.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:65:0) after 1m0s
[05:09:36.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:65:0)
[05:09:36.661] Timer tick, asking Buildbucket for the build status
[05:09:37.106] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:37.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:66:0) after 1m0s
[05:10:37.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:66:0)
[05:10:37.149] Timer tick, asking Buildbucket for the build status
[05:10:37.231] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:37.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:67:0) after 1m0s
[05:11:37.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:67:0)
[05:11:37.271] Timer tick, asking Buildbucket for the build status
[05:11:37.485] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:37.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:68:0) after 1m0s
[05:12:37.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:68:0)
[05:12:37.529] Timer tick, asking Buildbucket for the build status
[05:12:37.606] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:37.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:69:0) after 1m0s
[05:13:37.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:69:0)
[05:13:37.615] Timer tick, asking Buildbucket for the build status
[05:13:37.760] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:37.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:70:0) after 1m0s
[05:14:37.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:70:0)
[05:14:37.814] Timer tick, asking Buildbucket for the build status
[05:14:37.894] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:37.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:71:0) after 1m0s
[05:15:38.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:71:0)
[05:15:38.023] Timer tick, asking Buildbucket for the build status
[05:15:40.921] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:40.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:72:0) after 1m0s
[05:16:40.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:72:0)
[05:16:40.973] Timer tick, asking Buildbucket for the build status
[05:16:41.087] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:41.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:73:0) after 1m0s
[05:17:41.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:73:0)
[05:17:41.200] Timer tick, asking Buildbucket for the build status
[05:17:41.280] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:41.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:74:0) after 1m0s
[05:18:41.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:74:0)
[05:18:41.355] Timer tick, asking Buildbucket for the build status
[05:18:41.480] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:41.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:75:0) after 1m0s
[05:19:41.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:75:0)
[05:19:41.503] Timer tick, asking Buildbucket for the build status
[05:19:41.792] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:76:0) after 1m0s
[05:20:41.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:76:0)
[05:20:41.836] Timer tick, asking Buildbucket for the build status
[05:20:42.107] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:42.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:77:0) after 1m0s
[05:21:42.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:77:0)
[05:21:42.133] Timer tick, asking Buildbucket for the build status
[05:21:43.005] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:43.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:78:0) after 1m0s
[05:22:43.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:78:0)
[05:22:43.054] Timer tick, asking Buildbucket for the build status
[05:22:43.151] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:43.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:79:0) after 1m0s
[05:23:43.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:79:0)
[05:23:43.175] Timer tick, asking Buildbucket for the build status
[05:23:43.268] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:43.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:80:0) after 1m0s
[05:24:43.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:80:0)
[05:24:43.286] Timer tick, asking Buildbucket for the build status
[05:24:43.371] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:43.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:81:0) after 1m0s
[05:25:43.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:81:0)
[05:25:43.670] Timer tick, asking Buildbucket for the build status
[05:25:43.766] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:82:0) after 1m0s
[05:26:44.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:82:0)
[05:26:44.283] Timer tick, asking Buildbucket for the build status
[05:26:44.830] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:44.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:83:0) after 1m0s
[05:27:45.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:83:0)
[05:27:45.259] Timer tick, asking Buildbucket for the build status
[05:27:45.353] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:45.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:84:0) after 1m0s
[05:28:45.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:84:0)
[05:28:45.459] Timer tick, asking Buildbucket for the build status
[05:28:45.536] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:45.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:85:0) after 1m0s
[05:29:45.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:85:0)
[05:29:45.571] Timer tick, asking Buildbucket for the build status
[05:29:45.649] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:45.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:86:0) after 1m0s
[05:30:45.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:86:0)
[05:30:45.700] Timer tick, asking Buildbucket for the build status
[05:30:45.868] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:45.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:87:0) after 1m0s
[05:31:45.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:87:0)
[05:31:45.975] Timer tick, asking Buildbucket for the build status
[05:31:46.263] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:46.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:88:0) after 1m0s
[05:32:46.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:88:0)
[05:32:46.683] Timer tick, asking Buildbucket for the build status
[05:32:46.914] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:46.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:89:0) after 1m0s
[05:33:47.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:89:0)
[05:33:47.069] Timer tick, asking Buildbucket for the build status
[05:33:47.191] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:90:0) after 1m0s
[05:34:47.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:90:0)
[05:34:47.469] Timer tick, asking Buildbucket for the build status
[05:34:47.901] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:47.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:91:0) after 1m0s
[05:35:47.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:91:0)
[05:35:47.932] Timer tick, asking Buildbucket for the build status
[05:35:48.076] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:48.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:92:0) after 1m0s
[05:36:48.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:92:0)
[05:36:48.142] Timer tick, asking Buildbucket for the build status
[05:36:48.459] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:48.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:93:0) after 1m0s
[05:37:48.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:93:0)
[05:37:48.509] Timer tick, asking Buildbucket for the build status
[05:37:48.942] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:48.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:94:0) after 1m0s
[05:38:49.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:94:0)
[05:38:49.216] Timer tick, asking Buildbucket for the build status
[05:38:49.411] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:49.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:95:0) after 1m0s
[05:39:49.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:95:0)
[05:39:49.551] Timer tick, asking Buildbucket for the build status
[05:39:49.626] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:49.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:96:0) after 1m0s
[05:40:49.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:96:0)
[05:40:49.720] Timer tick, asking Buildbucket for the build status
[05:40:50.058] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:50.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:97:0) after 1m0s
[05:41:50.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:97:0)
[05:41:50.085] Timer tick, asking Buildbucket for the build status
[05:41:50.172] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:50.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:98:0) after 1m0s
[05:42:50.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:98:0)
[05:42:50.269] Timer tick, asking Buildbucket for the build status
[05:42:50.387] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:50.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:99:0) after 1m0s
[05:43:50.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:99:0)
[05:43:50.467] Timer tick, asking Buildbucket for the build status
[05:43:50.580] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:50.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:100:0) after 1m0s
[05:44:50.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:100:0)
[05:44:50.716] Timer tick, asking Buildbucket for the build status
[05:44:50.808] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:50.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:101:0) after 1m0s
[05:45:50.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:101:0)
[05:45:50.854] Timer tick, asking Buildbucket for the build status
[05:45:51.011] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:51.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:102:0) after 1m0s
[05:46:51.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:102:0)
[05:46:51.090] Timer tick, asking Buildbucket for the build status
[05:46:51.433] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:51.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:103:0) after 1m0s
[05:47:51.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:103:0)
[05:47:51.538] Timer tick, asking Buildbucket for the build status
[05:47:51.653] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:51.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:104:0) after 1m0s
[05:48:51.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:104:0)
[05:48:51.694] Timer tick, asking Buildbucket for the build status
[05:48:51.792] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:51.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:105:0) after 1m0s
[05:49:52.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:105:0)
[05:49:52.042] Timer tick, asking Buildbucket for the build status
[05:49:52.178] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:52.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:106:0) after 1m0s
[05:50:52.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:106:0)
[05:50:52.279] Timer tick, asking Buildbucket for the build status
[05:50:52.598] Build 8853630320441942624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:52.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019060382633169488:107:0) after 1m0s
[05:51:10.296] Received PubSub notification, asking Buildbucket for the build status
[05:51:10.995] Build 8853630320441942624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:51:10.995] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614923468840218",
"created_by": "project:chromium",
"created_ts": "1614917178646139",
"id": "8853630320441942624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"02dd21b43ff2fff841f8d864219c0d473d24df5b\"}}",
"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\": \"02dd21b43ff2fff841f8d864219c0d473d24df5b\", \"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-128-h6p6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22870, \"got_angle_revision\": \"8092ed7271d972fe40df1900537a6711eaa595ae\", \"got_dawn_revision\": \"80915849ce7d5f4c0fe834924ed420ed0002b210\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"02dd21b43ff2fff841f8d864219c0d473d24df5b\", \"got_revision_cp\": \"refs/heads/master@{#860114}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"6846389f25cad4233a4bd04fd3fc6c60ae30ff35\", \"got_v8_revision\": \"a88754d974902819a903536937527fd8465d871d\", \"got_v8_revision_cp\": \"refs/heads/9.1.46@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"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\": \"02dd21b43ff2fff841f8d864219c0d473d24df5b\", \"swarm_hashes_refs/heads/master(at){#860114}_without_patch\": {\"absl_hardening_tests\": \"b55b91d166d92c8a790b90a3175a216cce7669f7\", \"accessibility_unittests\": \"c48b91204ee6a651308203ebfd9b4964a4e2b744\", \"angle_unittests\": \"21eadf2c54379ea97af5257f874228ec10a557d6\", \"app_list_unittests\": \"15a518ea0f27caa021a30191c55263bb2e7f37e1\", \"app_shell_unittests\": \"1ce7202d3379e121529cdc803e4881bc9ac86ab9\", \"ash_unittests\": \"da44e08584e18de218f06b45bd17f7dc03d42583\", \"aura_unittests\": \"0d5726094ea9128fb5ce4969f9c32636aa783dd6\", \"base_unittests\": \"dd37609ad7e3ad4056a678e3c83f4b0edd12772d\", \"base_util_unittests\": \"d5da6f061e7cb664fbf771e835c4e03b48b648e9\", \"blink_common_unittests\": \"851f74d143e393345e8c0a220045b681bc123500\", \"blink_fuzzer_unittests\": \"6119ff1a82309932bc15da8f7f7ff033e148081a\", \"blink_heap_unittests\": \"d5290b24f756dfa35edd43fb1ca1f331bbe0f9e2\", \"blink_platform_unittests\": \"6f7c32beb99602341936c2342f3da70468ad5152\", \"blink_unittests\": \"2cb4c4a5d2a55c37ce1164259a00fcdab99217ba\", \"boringssl_crypto_tests\": \"04d8d5fba0badab64e365e1ad987c9fdc4db622d\", \"boringssl_ssl_tests\": \"a71c510dab176960794670c6e4737aee6ef59782\", \"browser_tests\": \"79ddb79b644475f7910d2c80d32ae762c3ca79a1\", \"capture_unittests\": \"5889ffcc2a2055c4876f558eaffbc497312717c5\", \"cast_unittests\": \"d0c2397199984a779eb7f3f314f2daa02bdfa7a8\", \"cc_unittests\": \"bc5f08471b41434859489ba714bbe78aa7f5e603\", \"chrome_app_unittests\": \"952ef8f16a3d81c294728e307be7e4ad797e6926\", \"chromedriver_unittests\": \"47133ba30b9c881dcd3afe4ce6f023b756f06aba\", \"chromeos_components_unittests\": \"da6b9f1748bd8f51caa2260a474d72f94ddf2c7d\", \"chromeos_unittests\": \"1455f9527b1f110edd9be9a28884dd59e733a500\", \"color_unittests\": \"7bf30aaa44b62bde9280150729ece234c052f278\", \"components_browsertests\": \"a4e971f56748130c405b0ad4988294219e3f8eee\", \"components_unittests\": \"58546d57f3503e6005fd229ded7e69ec3583e9ee\", \"compositor_unittests\": \"d8b7824b5e2858af6cae3d23d3deb3f65e4db268\", \"content_browsertests\": \"485896f6c7c6079b283c3f382d04624853e1634a\", \"content_unittests\": \"21d6aaad79cab1148092dd69f3b5e739bc5675df\", \"crashpad_tests\": \"2961132ec60b9342a7b319eaf0a2bfa66bef4028\", \"crypto_unittests\": \"947438f44c158799b8f4831979d5db904c15c217\", \"dbus_unittests\": \"432ed555cc31c59ad4d55681e9b79fbde55f8c9f\", \"device_unittests\": \"e96f8fd01690570c9406f739c381e28b192a19ed\", \"display_unittests\": \"cc5fa139234b9a06f4c75962e20163bbd1883428\", \"events_unittests\": \"bd29132643d63331d37cb6047ff53220e5511202\", \"exo_unittests\": \"11861af57b67f5e7e9eaaefa3902291940ca31ba\", \"extensions_browsertests\": \"014276adbc9fda04b624722e2cd24d50819da500\", \"extensions_unittests\": \"232fb86f1030ee32cf9a158a37bcd7ed0e72e546\", \"filesystem_service_unittests\": \"7e74b6f4d37a397e01ca48c0de1f0f5192c14437\", \"gcm_unit_tests\": \"3fe9d6fb9aa2db05287df2d52ddedd3bb4a75145\", \"gfx_unittests\": \"2dcc8488f238a953ec7dc79e2b0e0bfce6313f8c\", \"gin_unittests\": \"df08d069fe4e88d47946c087d69cf83a9f04710e\", \"gl_unittests_ozone\": \"d9799f113c12356059e5bc22b1d1f4c26df7c4ac\", \"google_apis_unittests\": \"9de237d39f664f6219d284e9db63dd5be2637ee1\", \"gpu_unittests\": \"0c83ad45a37a462a49d111bd6b42e1f32cb9cddd\", \"gwp_asan_unittests\": \"deeff58fa5776aa7f4fe41754bfc4204e53d6c20\", \"interactive_ui_tests\": \"3797d31446a43b08b55a909d58a04f9ae99d8661\", \"ipc_tests\": \"67a869ee4e548209f56ab1d505c574c9714d12d7\", \"jingle_unittests\": \"0cc0c612f7d6af66630ea790124911e9d9bc9614\", \"keyboard_unittests\": \"9ef457ff2670b44a6784d5aafcd7fb88ddb6fdc0\", \"latency_unittests\": \"30fba9485d02b7b6d9bc9919dd6a8a810bbb9f38\", \"libjingle_xmpp_unittests\": \"75914e8d722f2b75e4145b6aef2c1ce4d75cd78f\", \"liburlpattern_unittests\": \"4aacd114893192dd8446fa78ba1e884656ce4622\", \"media_blink_unittests\": \"7d5ddd3c102c22dcd0d7de376639850cb4751a5c\", \"media_unittests\": \"0285ce17904a36c4f3558896c660e7f0f18bc564\", \"message_center_unittests\": \"036025e3b9ae54bc80cb5a59f04b1d9a296f15f3\", \"midi_unittests\": \"ef7642018a0ce24d74a242c972a3981f29566a28\", \"mojo_core_unittests\": \"ed2a95dacaeb2d2f7dccf9bc15c46aa146b7e8db\", \"mojo_unittests\": \"3881eeb4faaddd4567192b269be90dc7db07f7ed\", \"nacl_helper_nonsfi_unittests\": \"d6e0ebbaaaeeb3ad7322d44115927ea80a429e20\", \"nacl_loader_unittests\": \"caed6c5b97ef24d41cc4fd4e710e97e2d247a445\", \"native_theme_unittests\": \"66cc5444b61f123f4536c402439d6a4a74d322cf\", \"net_unittests\": \"fb0335382a428c1ebe91542730372e38581d996f\", \"ozone_gl_unittests\": \"c21a3353464db6cf3aeb694bb0a640b3e9ffe11a\", \"ozone_unittests\": \"44151088c06f0ea930f2156237fff481eb9ff8e6\", \"ozone_x11_unittests\": \"784ed19fd814ba5bce4fefaef9439bb8c4b5cbaa\", \"pdf_unittests\": \"af0d7d9efb79dade4a29f3e51f6d3f5198424c66\", \"perfetto_unittests\": \"9e1b5cc2e494f6f6f450e52d5f74fb671cfcf985\", \"ppapi_unittests\": \"450804b7936a83cc5dfeb49628791a1fa747181a\", \"printing_unittests\": \"4f684a6dff7f0dc54951338ad5a4e38a137fc9e6\", \"remoting_unittests\": \"db9c6d75b3996793af700f9429a05df8f37439f4\", \"sandbox_linux_unittests\": \"cc9cc80793f0e47c22c46877e44f34703f813e17\", \"service_manager_unittests\": \"385a7ea74bf2f5cf6a8e9ca4b663bb55a8fe7a2b\", \"services_unittests\": \"93bb8db6f8d3c60cee1e22ef8abd9276fa2f3abf\", \"shell_dialogs_unittests\": \"6acdec41683f846511c194248125074343f19578\", \"shell_encryption_unittests\": \"08ae385df953052c3c5e6e4148673d278d45e8e7\", \"skia_unittests\": \"254308a78b90c0201963b8afe905878a3da1c38f\", \"snapshot_unittests\": \"0de2f96c4f4acc880aa4bb7d027c71bf6c31ff22\", \"sql_unittests\": \"b8f855d4e791d8ded9e5874c0573bf4e4b22d556\", \"storage_unittests\": \"23888021feabf24cd6dcfd0b31dd50d5e737b641\", \"sync_integration_tests\": \"e76aa3a0528512de73ff72b9cc363e56de0f0a71\", \"traffic_annotation_auditor_unittests\": \"5fc214636a2b9dd7a84d2a133738b16d002b868d\", \"ui_base_unittests\": \"c89b73532f5578f9fc2a4bed992590c69f749cd8\", \"ui_chromeos_unittests\": \"642dc65f32ffccf2f50888de851d80f73f00e4aa\", \"ui_touch_selection_unittests\": \"b69c91b6e80bdfacdc090f72a98b9fabd0bf2a66\", \"unit_tests\": \"b855300dc19badc7fafee9791c23e0b824bacd4d\", \"url_unittests\": \"ff2fef1c6c8ab16eab4ffeb016e73c8c96421bf0\", \"usage_time_limit_unittests\": \"e043f6eaacc46c3848d1f0548dafe0c92098491a\", \"views_unittests\": \"5322a88e1baf00f6fa49c322480f49f6ecd07b6f\", \"viz_unittests\": \"0242907b5f7392bfe34ceb2d1f7df54258be79cc\", \"wayland_client_tests\": \"a2a8d4c38fcedfd6dbe91cc588dac12634dbcaba\", \"wm_unittests\": \"3cdd62e755a26a9ea029de3b1ffab92833355c0b\", \"wtf_unittests\": \"0c4651e3e1c5c0cce32781464ab49a4ded8c2606\", \"zlib_unittests\": \"6208cf1ea607617299ecb0030daea26eb98b3beb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5c747cd818883fbaf47d95a1957ca48c3a2cfea22c337e9f1af1c41b2acc0162_v2\", \"builder_7ddc1ece4c938056809d45345930c5d8ea6799936d2255389af4f16219f397ac_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_eb9380ccf2029d620c130d9d5d70d66e8dbc39579ef092b67cdf97c73c50a0cb_v2\", \"builder_f19369f36f1005e29867c6fb0f70a58122bd720e998eaad530661aca056acedd_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-128-h6p6\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614917197136920",
"status": "COMPLETED",
"status_changed_ts": "1614923469313940",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22870",
"builder:linux-chromeos-dbg",
"buildset:commit/git/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/02dd21b43ff2fff841f8d864219c0d473d24df5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019060382633169488",
"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/8853630320441942624/+/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:521962210b524210",
"user_agent:luci-scheduler"
],
"updated_ts": "1614923469318671",
"url": "https://ci.chromium.org/b/8853630320441942624",
"utcnow_ts": "1614923470986553"
}
}
[05:51:10.995] Invocation finished in 1h44m53.82210427s with status SUCCEEDED