[21:48:39.028] New invocation is queued and will start shortly
[21:48:40.341] Starting the invocation (attempt 1)
[21:48:40.387] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:48:40.389] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:48:40.389] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031042941007214672",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"97155b18de89cf4de40f3682c45f672d3647c319\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031042941007214672",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/97155b18de89cf4de40f3682c45f672d3647c319",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97155b18de89cf4de40f3682c45f672d3647c319",
"gitiles_ref:refs/heads/master"
]
}
[21:48:41.302] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603489720502847",
"id": "8865612878793532032",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97155b18de89cf4de40f3682c45f672d3647c319\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603489721027950",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20983",
"builder:linux-chromeos-dbg",
"buildset:commit/git/97155b18de89cf4de40f3682c45f672d3647c319",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97155b18de89cf4de40f3682c45f672d3647c319",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031042941007214672",
"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/8865612878793532032/+/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": "1603489721028137",
"url": "https://ci.chromium.org/b/8865612878793532032",
"utcnow_ts": "1603489721292564"
}
}
[21:48:41.302] Task URL: https://ci.chromium.org/b/8865612878793532032
[21:48:41.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:2:0) after 1m0s
[21:49:41.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:2:0)
[21:49:41.328] Timer tick, asking Buildbucket for the build status
[21:49:41.436] Build 8865612878793532032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:41.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:3:0) after 1m0s
[21:50:41.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:3:0)
[21:50:41.459] Timer tick, asking Buildbucket for the build status
[21:50:41.640] Build 8865612878793532032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:41.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:4:0) after 1m0s
[21:51:41.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:4:0)
[21:51:41.675] Timer tick, asking Buildbucket for the build status
[21:51:41.751] Build 8865612878793532032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:41.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:5:0) after 1m0s
[21:52:41.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:5:0)
[21:52:41.779] Timer tick, asking Buildbucket for the build status
[21:52:42.011] Build 8865612878793532032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:42.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:6:0) after 1m0s
[21:53:14.469] Received PubSub notification, asking Buildbucket for the build status
[21:53:14.562] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:42.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:6:0)
[21:53:42.058] Timer tick, asking Buildbucket for the build status
[21:53:42.168] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:42.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:8:0) after 1m0s
[21:54:42.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:8:0)
[21:54:42.193] Timer tick, asking Buildbucket for the build status
[21:54:42.448] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:42.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:9:0) after 1m0s
[21:55:42.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:9:0)
[21:55:42.495] Timer tick, asking Buildbucket for the build status
[21:55:42.573] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:42.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:10:0) after 1m0s
[21:56:42.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:10:0)
[21:56:42.595] Timer tick, asking Buildbucket for the build status
[21:56:42.692] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:42.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:11:0) after 1m0s
[21:57:42.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:11:0)
[21:57:42.746] Timer tick, asking Buildbucket for the build status
[21:57:42.811] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:12:0) after 1m0s
[21:58:42.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:12:0)
[21:58:42.887] Timer tick, asking Buildbucket for the build status
[21:58:43.180] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:43.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:13:0) after 1m0s
[21:59:43.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:13:0)
[21:59:43.194] Timer tick, asking Buildbucket for the build status
[21:59:43.308] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:43.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:14:0) after 1m0s
[22:00:43.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:14:0)
[22:00:43.388] Timer tick, asking Buildbucket for the build status
[22:00:43.487] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:15:0) after 1m0s
[22:01:43.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:15:0)
[22:01:43.544] Timer tick, asking Buildbucket for the build status
[22:01:43.628] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:43.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:16:0) after 1m0s
[22:02:43.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:16:0)
[22:02:43.683] Timer tick, asking Buildbucket for the build status
[22:02:43.755] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:43.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:17:0) after 1m0s
[22:03:43.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:17:0)
[22:03:43.780] Timer tick, asking Buildbucket for the build status
[22:03:44.022] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:44.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:18:0) after 1m0s
[22:04:44.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:18:0)
[22:04:44.052] Timer tick, asking Buildbucket for the build status
[22:04:44.118] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:44.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:19:0) after 1m0s
[22:05:44.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:19:0)
[22:05:44.189] Timer tick, asking Buildbucket for the build status
[22:05:44.378] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:44.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:20:0) after 1m0s
[22:06:44.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:20:0)
[22:06:44.434] Timer tick, asking Buildbucket for the build status
[22:06:46.634] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:46.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:21:0) after 1m0s
[22:07:46.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:21:0)
[22:07:46.712] Timer tick, asking Buildbucket for the build status
[22:07:46.836] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:46.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:22:0) after 1m0s
[22:08:46.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:22:0)
[22:08:46.857] Timer tick, asking Buildbucket for the build status
[22:08:47.304] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:47.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:23:0) after 1m0s
[22:09:47.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:23:0)
[22:09:47.337] Timer tick, asking Buildbucket for the build status
[22:09:47.646] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:47.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:24:0) after 1m0s
[22:10:47.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:24:0)
[22:10:47.947] Timer tick, asking Buildbucket for the build status
[22:10:48.014] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:48.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:25:0) after 1m0s
[22:11:48.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:25:0)
[22:11:48.065] Timer tick, asking Buildbucket for the build status
[22:11:48.137] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:48.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:26:0) after 1m0s
[22:12:48.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:26:0)
[22:12:48.269] Timer tick, asking Buildbucket for the build status
[22:12:48.497] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:48.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:27:0) after 1m0s
[22:13:48.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:27:0)
[22:13:48.682] Timer tick, asking Buildbucket for the build status
[22:13:48.825] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:48.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:28:0) after 1m0s
[22:14:48.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:28:0)
[22:14:48.849] Timer tick, asking Buildbucket for the build status
[22:14:48.935] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:48.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:29:0) after 1m0s
[22:15:48.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:29:0)
[22:15:48.975] Timer tick, asking Buildbucket for the build status
[22:15:49.236] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:49.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:30:0) after 1m0s
[22:16:49.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:30:0)
[22:16:49.260] Timer tick, asking Buildbucket for the build status
[22:16:49.326] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:49.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:31:0) after 1m0s
[22:17:49.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:31:0)
[22:17:49.369] Timer tick, asking Buildbucket for the build status
[22:17:49.433] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:49.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:32:0) after 1m0s
[22:18:49.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:32:0)
[22:18:49.441] Timer tick, asking Buildbucket for the build status
[22:18:49.564] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:49.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:33:0) after 1m0s
[22:19:49.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:33:0)
[22:19:49.611] Timer tick, asking Buildbucket for the build status
[22:19:49.672] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:49.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:34:0) after 1m0s
[22:20:49.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:34:0)
[22:20:49.713] Timer tick, asking Buildbucket for the build status
[22:20:49.802] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:49.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:35:0) after 1m0s
[22:21:49.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:35:0)
[22:21:49.876] Timer tick, asking Buildbucket for the build status
[22:21:50.179] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:50.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:36:0) after 1m0s
[22:22:50.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:36:0)
[22:22:50.292] Timer tick, asking Buildbucket for the build status
[22:22:50.375] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:50.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:37:0) after 1m0s
[22:23:50.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:37:0)
[22:23:50.405] Timer tick, asking Buildbucket for the build status
[22:23:50.551] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:50.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:38:0) after 1m0s
[22:24:50.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:38:0)
[22:24:50.613] Timer tick, asking Buildbucket for the build status
[22:24:50.689] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:50.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:39:0) after 1m0s
[22:25:50.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:39:0)
[22:25:50.793] Timer tick, asking Buildbucket for the build status
[22:25:51.970] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:51.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:40:0) after 1m0s
[22:26:52.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:40:0)
[22:26:52.002] Timer tick, asking Buildbucket for the build status
[22:26:52.135] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:52.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:41:0) after 1m0s
[22:27:52.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:41:0)
[22:27:52.299] Timer tick, asking Buildbucket for the build status
[22:27:52.378] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:52.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:42:0) after 1m0s
[22:28:52.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:42:0)
[22:28:52.415] Timer tick, asking Buildbucket for the build status
[22:28:52.537] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:43:0) after 1m0s
[22:29:52.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:43:0)
[22:29:52.630] Timer tick, asking Buildbucket for the build status
[22:29:52.699] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:52.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:44:0) after 1m0s
[22:30:52.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:44:0)
[22:30:52.760] Timer tick, asking Buildbucket for the build status
[22:30:52.885] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:52.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:45:0) after 1m0s
[22:31:53.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:45:0)
[22:31:53.048] Timer tick, asking Buildbucket for the build status
[22:31:53.151] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:53.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:46:0) after 1m0s
[22:32:53.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:46:0)
[22:32:53.205] Timer tick, asking Buildbucket for the build status
[22:32:53.524] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:53.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:47:0) after 1m0s
[22:33:53.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:47:0)
[22:33:53.708] Timer tick, asking Buildbucket for the build status
[22:33:53.846] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:53.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:48:0) after 1m0s
[22:34:53.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:48:0)
[22:34:53.889] Timer tick, asking Buildbucket for the build status
[22:34:54.111] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:54.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:49:0) after 1m0s
[22:35:54.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:49:0)
[22:35:54.124] Timer tick, asking Buildbucket for the build status
[22:35:54.389] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:54.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:50:0) after 1m0s
[22:36:54.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:50:0)
[22:36:54.435] Timer tick, asking Buildbucket for the build status
[22:36:54.490] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:54.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:51:0) after 1m0s
[22:37:54.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:51:0)
[22:37:54.526] Timer tick, asking Buildbucket for the build status
[22:37:54.592] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:54.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:52:0) after 1m0s
[22:38:54.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:52:0)
[22:38:54.663] Timer tick, asking Buildbucket for the build status
[22:38:54.856] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:54.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:53:0) after 1m0s
[22:39:54.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:53:0)
[22:39:54.912] Timer tick, asking Buildbucket for the build status
[22:39:54.977] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:54.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:54:0) after 1m0s
[22:40:55.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:54:0)
[22:40:55.110] Timer tick, asking Buildbucket for the build status
[22:40:55.521] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:55:0) after 1m0s
[22:41:55.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:55:0)
[22:41:55.667] Timer tick, asking Buildbucket for the build status
[22:41:56.156] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:56.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:56:0) after 1m0s
[22:42:56.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:56:0)
[22:42:56.265] Timer tick, asking Buildbucket for the build status
[22:42:56.401] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:56.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:57:0) after 1m0s
[22:43:56.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:57:0)
[22:43:56.488] Timer tick, asking Buildbucket for the build status
[22:43:56.616] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:58:0) after 1m0s
[22:44:56.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:58:0)
[22:44:56.660] Timer tick, asking Buildbucket for the build status
[22:44:56.774] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:56.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:59:0) after 1m0s
[22:45:56.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:59:0)
[22:45:56.936] Timer tick, asking Buildbucket for the build status
[22:45:57.153] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:57.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:60:0) after 1m0s
[22:46:57.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:60:0)
[22:46:57.373] Timer tick, asking Buildbucket for the build status
[22:46:57.444] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:57.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:61:0) after 1m0s
[22:47:57.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:61:0)
[22:47:57.509] Timer tick, asking Buildbucket for the build status
[22:47:57.630] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:57.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:62:0) after 1m0s
[22:48:57.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:62:0)
[22:48:57.723] Timer tick, asking Buildbucket for the build status
[22:48:58.535] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:58.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:63:0) after 1m0s
[22:49:58.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:63:0)
[22:49:58.737] Timer tick, asking Buildbucket for the build status
[22:49:58.867] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:58.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:64:0) after 1m0s
[22:50:58.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:64:0)
[22:50:58.976] Timer tick, asking Buildbucket for the build status
[22:50:59.085] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:59.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:65:0) after 1m0s
[22:51:59.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:65:0)
[22:51:59.150] Timer tick, asking Buildbucket for the build status
[22:51:59.253] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:59.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:66:0) after 1m0s
[22:52:59.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:66:0)
[22:52:59.513] Timer tick, asking Buildbucket for the build status
[22:52:59.662] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:59.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:67:0) after 1m0s
[22:53:59.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:67:0)
[22:53:59.672] Timer tick, asking Buildbucket for the build status
[22:54:00.189] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:00.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:68:0) after 1m0s
[22:55:00.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:68:0)
[22:55:00.296] Timer tick, asking Buildbucket for the build status
[22:55:00.405] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:00.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:69:0) after 1m0s
[22:56:01.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:69:0)
[22:56:01.233] Timer tick, asking Buildbucket for the build status
[22:56:01.380] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:01.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:70:0) after 1m0s
[22:57:01.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:70:0)
[22:57:01.757] Timer tick, asking Buildbucket for the build status
[22:57:01.989] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:01.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:71:0) after 1m0s
[22:58:02.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:71:0)
[22:58:02.022] Timer tick, asking Buildbucket for the build status
[22:58:02.149] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:02.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:72:0) after 1m0s
[22:59:02.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:72:0)
[22:59:02.230] Timer tick, asking Buildbucket for the build status
[22:59:02.388] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:02.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:73:0) after 1m0s
[23:00:02.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:73:0)
[23:00:02.481] Timer tick, asking Buildbucket for the build status
[23:00:02.568] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:02.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:74:0) after 1m0s
[23:01:02.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:74:0)
[23:01:02.609] Timer tick, asking Buildbucket for the build status
[23:01:02.682] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:02.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:75:0) after 1m0s
[23:02:02.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:75:0)
[23:02:02.734] Timer tick, asking Buildbucket for the build status
[23:02:02.801] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:02.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:76:0) after 1m0s
[23:03:02.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:76:0)
[23:03:02.872] Timer tick, asking Buildbucket for the build status
[23:03:02.946] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:02.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:77:0) after 1m0s
[23:04:02.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:77:0)
[23:04:02.969] Timer tick, asking Buildbucket for the build status
[23:04:03.131] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:03.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:78:0) after 1m0s
[23:05:03.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:78:0)
[23:05:03.166] Timer tick, asking Buildbucket for the build status
[23:05:03.252] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:03.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:79:0) after 1m0s
[23:06:03.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:79:0)
[23:06:03.297] Timer tick, asking Buildbucket for the build status
[23:06:04.486] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:04.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:80:0) after 1m0s
[23:07:04.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:80:0)
[23:07:04.541] Timer tick, asking Buildbucket for the build status
[23:07:04.675] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:04.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:81:0) after 1m0s
[23:08:04.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:81:0)
[23:08:04.714] Timer tick, asking Buildbucket for the build status
[23:08:04.831] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:04.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:82:0) after 1m0s
[23:09:04.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:82:0)
[23:09:04.879] Timer tick, asking Buildbucket for the build status
[23:09:05.528] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:05.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:83:0) after 1m0s
[23:10:05.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:83:0)
[23:10:05.560] Timer tick, asking Buildbucket for the build status
[23:10:05.690] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:05.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:84:0) after 1m0s
[23:11:05.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:84:0)
[23:11:05.694] Timer tick, asking Buildbucket for the build status
[23:11:06.632] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:06.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:85:0) after 1m0s
[23:12:06.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:85:0)
[23:12:06.649] Timer tick, asking Buildbucket for the build status
[23:12:07.119] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:07.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:86:0) after 1m0s
[23:13:07.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:86:0)
[23:13:07.158] Timer tick, asking Buildbucket for the build status
[23:13:07.320] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:07.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:87:0) after 1m0s
[23:14:07.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:87:0)
[23:14:07.366] Timer tick, asking Buildbucket for the build status
[23:14:07.496] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:07.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:88:0) after 1m0s
[23:15:07.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:88:0)
[23:15:07.528] Timer tick, asking Buildbucket for the build status
[23:15:07.598] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:07.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:89:0) after 1m0s
[23:16:07.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:89:0)
[23:16:07.648] Timer tick, asking Buildbucket for the build status
[23:16:07.742] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:90:0) after 1m0s
[23:17:07.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:90:0)
[23:17:07.770] Timer tick, asking Buildbucket for the build status
[23:17:08.148] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:08.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:91:0) after 1m0s
[23:18:08.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:91:0)
[23:18:08.173] Timer tick, asking Buildbucket for the build status
[23:18:08.613] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:08.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:92:0) after 1m0s
[23:19:08.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:92:0)
[23:19:08.659] Timer tick, asking Buildbucket for the build status
[23:19:08.834] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:08.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:93:0) after 1m0s
[23:20:08.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:93:0)
[23:20:08.866] Timer tick, asking Buildbucket for the build status
[23:20:08.945] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:08.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:94:0) after 1m0s
[23:21:08.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:94:0)
[23:21:08.999] Timer tick, asking Buildbucket for the build status
[23:21:09.072] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:09.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:95:0) after 1m0s
[23:22:09.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:95:0)
[23:22:09.119] Timer tick, asking Buildbucket for the build status
[23:22:09.250] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:09.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:96:0) after 1m0s
[23:23:09.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:96:0)
[23:23:09.283] Timer tick, asking Buildbucket for the build status
[23:23:09.433] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:09.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:97:0) after 1m0s
[23:24:09.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:97:0)
[23:24:09.513] Timer tick, asking Buildbucket for the build status
[23:24:09.851] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:98:0) after 1m0s
[23:25:10.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:98:0)
[23:25:10.043] Timer tick, asking Buildbucket for the build status
[23:25:10.175] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:10.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:99:0) after 1m0s
[23:26:10.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:99:0)
[23:26:10.250] Timer tick, asking Buildbucket for the build status
[23:26:10.322] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:10.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:100:0) after 1m0s
[23:27:10.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:100:0)
[23:27:10.396] Timer tick, asking Buildbucket for the build status
[23:27:10.467] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:10.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:101:0) after 1m0s
[23:28:10.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:101:0)
[23:28:10.591] Timer tick, asking Buildbucket for the build status
[23:28:10.685] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:10.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:102:0) after 1m0s
[23:29:10.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:102:0)
[23:29:10.806] Timer tick, asking Buildbucket for the build status
[23:29:10.932] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:10.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:103:0) after 1m0s
[23:30:10.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:103:0)
[23:30:10.988] Timer tick, asking Buildbucket for the build status
[23:30:11.060] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:11.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:104:0) after 1m0s
[23:31:11.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:104:0)
[23:31:11.305] Timer tick, asking Buildbucket for the build status
[23:31:11.397] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:11.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:105:0) after 1m0s
[23:32:11.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:105:0)
[23:32:11.491] Timer tick, asking Buildbucket for the build status
[23:32:11.586] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:11.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:106:0) after 1m0s
[23:33:11.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:106:0)
[23:33:11.667] Timer tick, asking Buildbucket for the build status
[23:33:11.990] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:11.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:107:0) after 1m0s
[23:34:11.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:107:0)
[23:34:11.996] Timer tick, asking Buildbucket for the build status
[23:34:12.112] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:12.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:108:0) after 1m0s
[23:35:12.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:108:0)
[23:35:12.187] Timer tick, asking Buildbucket for the build status
[23:35:12.255] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:12.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:109:0) after 1m0s
[23:36:12.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:109:0)
[23:36:12.263] Timer tick, asking Buildbucket for the build status
[23:36:13.003] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:13.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:110:0) after 1m0s
[23:37:13.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:110:0)
[23:37:13.105] Timer tick, asking Buildbucket for the build status
[23:37:13.170] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:13.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:111:0) after 1m0s
[23:38:13.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:111:0)
[23:38:13.303] Timer tick, asking Buildbucket for the build status
[23:38:13.383] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:13.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:112:0) after 1m0s
[23:39:13.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:112:0)
[23:39:13.562] Timer tick, asking Buildbucket for the build status
[23:39:13.719] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:13.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:113:0) after 1m0s
[23:40:13.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:113:0)
[23:40:13.811] Timer tick, asking Buildbucket for the build status
[23:40:13.929] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:13.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:114:0) after 1m0s
[23:41:13.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:114:0)
[23:41:13.944] Timer tick, asking Buildbucket for the build status
[23:41:16.172] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:16.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:115:0) after 1m0s
[23:42:16.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:115:0)
[23:42:16.373] Timer tick, asking Buildbucket for the build status
[23:42:16.619] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:16.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:116:0) after 1m0s
[23:43:16.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:116:0)
[23:43:16.706] Timer tick, asking Buildbucket for the build status
[23:43:16.830] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:16.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:117:0) after 1m0s
[23:44:16.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:117:0)
[23:44:16.892] Timer tick, asking Buildbucket for the build status
[23:44:17.000] Build 8865612878793532032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:17.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031042941007214672:118:0) after 1m0s
[23:44:42.255] Received PubSub notification, asking Buildbucket for the build status
[23:44:42.825] Build 8865612878793532032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:44:42.825] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603496680165638",
"created_by": "project:chromium",
"created_ts": "1603489720502847",
"id": "8865612878793532032",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97155b18de89cf4de40f3682c45f672d3647c319\"}}",
"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\": \"97155b18de89cf4de40f3682c45f672d3647c319\", \"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-72-ppff\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20983, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"8901df8ffe29b3bf2ef3269edfd3a0e25fdf4b82\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"97155b18de89cf4de40f3682c45f672d3647c319\", \"got_revision_cp\": \"refs/heads/master@{#820436}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"42c17639e4e245ae9de211d0f5e24296c7ffe6bb\", \"got_v8_revision_cp\": \"refs/heads/8.8.169@{#1}\", \"got_webrtc_revision\": \"3d25935127400418ef6b5970f0edec5db01d2ba6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32478}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97155b18de89cf4de40f3682c45f672d3647c319\", \"swarm_hashes_refs/heads/master(at){#820436}_without_patch\": {\"absl_hardening_tests\": \"aadbccae09c097ebcbfbc95d266e3b2b7b4e118c\", \"accessibility_unittests\": \"beb923aeeaac640a06cad5c52b5bea0f308de120\", \"angle_unittests\": \"242e6f9b8e04440265030d9ef2582f9c6b781c3e\", \"app_list_unittests\": \"c916a875d9dc8194b27646be007c24e6b62497b1\", \"app_shell_unittests\": \"f946eaeae2ff9ffd1cad5ae007852a2dab4f874d\", \"ash_unittests\": \"9f2dd41ffceb8a81944595b12a0e1bff844b348d\", \"aura_unittests\": \"5a56b7aa368610d9abc2a66f124ab01272c6f3c7\", \"base_unittests\": \"8579a3d491eac67cf122fec24d91e09fd3e07dee\", \"base_util_unittests\": \"3a494b8c2437e7ef50ae7f54260cb29145969a93\", \"blink_common_unittests\": \"5446bc79b9bc48f55ed847170f60c490534db68e\", \"blink_fuzzer_unittests\": \"c02061a9d6e6b041dbdaa5e01414d41120ae010d\", \"blink_heap_unittests\": \"a407ccc8c55bed68240901df7bc8b59a937dac68\", \"blink_platform_unittests\": \"2088b29b56e96f5087ad306f5a0bc05c554abd03\", \"blink_unittests\": \"a68775733caa5475cb223b979b867c3762314acb\", \"boringssl_crypto_tests\": \"9c7379a069c1c76bfbc9659065ac226b9736b890\", \"boringssl_ssl_tests\": \"7b2ca6b19cfc072c91e51486fc757bab4eb0651a\", \"browser_tests\": \"779e53ac6aa4ef4c4c5ebf14c2dd4e98cf6c97c3\", \"capture_unittests\": \"a02464b2f2f7578a838e6f6db9c938a3afb70286\", \"cast_unittests\": \"119961e8cd9a69596bdc17b48f63d417e565212e\", \"cc_unittests\": \"22985958f3b970b9b42f8d7df024cf673248904d\", \"chrome_app_unittests\": \"7f38c3a511bc7331ec0c2c85e72e9b431e54ca18\", \"chromedriver_unittests\": \"ba109caf4593e884b738b5cd9a815a94a8dc1658\", \"chromeos_components_unittests\": \"770ccbc83eb88da66a349790b8fc4d87a66a42d7\", \"chromeos_unittests\": \"0d0e6367d9db7b5d35f92b4621662032e5648b1d\", \"components_browsertests\": \"559775cb533237f183a2ff3392dd6925f6eb74ba\", \"components_unittests\": \"a76e726a1d7322b52c29a334a02f42b205589108\", \"compositor_unittests\": \"0bf8a8faa4a0be1d69d35d7b8b18865d31556458\", \"content_browsertests\": \"71d19f2880a58ae2e045d529faee1f8bbef66cb1\", \"content_unittests\": \"9ec454c2175b19469c7f6f25c8b43f0bfb47f04a\", \"crypto_unittests\": \"0f174baff2f667d0f05da716dab85ab2ec98cd11\", \"dbus_unittests\": \"6f03ffd75a9202dccdfb9c88c9356c10a9ead6bd\", \"device_unittests\": \"663c32a825263d37695402e12540488b120e4446\", \"display_unittests\": \"177310a21c32b4941432d59881e42af403df5267\", \"events_unittests\": \"3e0b783318a4a16d57dcff68c4bdaa7bd618af39\", \"exo_unittests\": \"995b38b7c44640e4b17fe0bc0c969831e470943a\", \"extensions_browsertests\": \"bcac32c17ec01a2948f6fc611144e3d142fa314b\", \"extensions_unittests\": \"ba2ec6be46ac522f6286f44adda3fcfe7881cd53\", \"filesystem_service_unittests\": \"2db6950bf00d950974489b648f957a6790aa72d1\", \"gcm_unit_tests\": \"5969d9d3854089c3e95841296c22451cd051f6b2\", \"gfx_unittests\": \"04cd81be3e3c91c9b20da5eb0122d93f337eaf84\", \"gin_unittests\": \"c5218f980043c6c05e60275d40e3efa34c181d97\", \"gl_unittests_ozone\": \"55a1b9ec9fc5f7c8bf748f790d3df94a1b2ebe64\", \"google_apis_unittests\": \"cd7a095687bac0c0a1c10d4a7d7df8682d326bc4\", \"gpu_unittests\": \"fc8e8f3a102814201a028107840fad2686ec3061\", \"gwp_asan_unittests\": \"12a84b39c13b0e100086e650e82cc806e04aaea0\", \"interactive_ui_tests\": \"db5b7daa643cead753090373b4acdc047e2aa808\", \"ipc_tests\": \"77e69522c20c56bd623549052230775056f788d9\", \"jingle_unittests\": \"d0883fa7ae250fdfbdc17f2ce7ec70c375bd831e\", \"keyboard_unittests\": \"d043334f131af4b487d0c05d1d28cb444900fab1\", \"latency_unittests\": \"0a5e29b3e427f0e5d3ba6788d6ed52555c7072aa\", \"libjingle_xmpp_unittests\": \"7da73b859763ef976be42a8b9893c4d3f3119f3d\", \"media_blink_unittests\": \"a1f2673554876f89f6e9228e09cbc25c873bbf6b\", \"media_unittests\": \"e35db5c803f5fb5c5eeaf033c53e3a52d4a3c4f4\", \"message_center_unittests\": \"4b814512ac7f4abb348d17c53a957d95c4ed9e25\", \"midi_unittests\": \"25c2479d77607c16921aaf3566d0cef52cf03833\", \"mojo_core_unittests\": \"160505cfc5314e7b91b41eeb3d31635bfd2e346a\", \"mojo_unittests\": \"122ab7b7eee2acfa48fa7544b8a2ee168ec111f9\", \"nacl_helper_nonsfi_unittests\": \"a04e109e3e81ddff3f0e160d27533e1d1b090daa\", \"nacl_loader_unittests\": \"338942fe58fbcac10b44f5864f8f9fcf31b7539e\", \"native_theme_unittests\": \"a13081cb0eef2a3e92b73332bbe99a5e1c4e22ee\", \"net_unittests\": \"2b24a48c87a3ef6346d3b9147467c0a29e20a2c3\", \"ozone_gl_unittests\": \"e4f72018bc02334b14ed0308f380e06574592391\", \"ozone_unittests\": \"ca7c25dd32d5243db0e7d9895c2bd63e9c6e9715\", \"ozone_x11_unittests\": \"fddf6427b3e179199092902d62c1989de33c47a7\", \"pdf_unittests\": \"6ee5fb144cf36258b82944f742efc71bdbf70965\", \"perfetto_unittests\": \"9eb45bccf8b564082c9be5b2559d9fff63ef5ed7\", \"ppapi_unittests\": \"391da6ab6550bd64af41425a5519d7e3323e4c86\", \"printing_unittests\": \"943801f149d3c45873cd40865b230d1ea7dcf721\", \"remoting_unittests\": \"54716d7f5fd5b67d3edafdb0979d80b108204063\", \"sandbox_linux_unittests\": \"299e577abdaaa00791f993be73b3f36562bc5f8f\", \"service_manager_unittests\": \"b21a83143c1ef1dfac3fb98185a0b36569c7f06c\", \"services_unittests\": \"deac86e0a62a903512826c7004ba3bf6edf16f96\", \"shell_dialogs_unittests\": \"462f612aebac901c3a0ba0b860884393a310ad9f\", \"skia_unittests\": \"2126562f9bfa852734939a661cfb5ee307e2f6d9\", \"snapshot_unittests\": \"fea0c6104e7b8ff58f140310c37922fed142c1fb\", \"sql_unittests\": \"21453adfe6565b155be36cc36b71803ff7f1e825\", \"storage_unittests\": \"edd9e41c8c10338b83f46458255aa062714df95f\", \"sync_integration_tests\": \"f66f3068a8af5187a66029057315830f64e49a40\", \"traffic_annotation_auditor_unittests\": \"fe9585adb854ff58dab7203fa8e215513f53228a\", \"ui_base_unittests\": \"4864e873a005c93a5451c1fa088de04f1a5f056a\", \"ui_chromeos_unittests\": \"f2f90e812e31e5aaf15f53aa7250b5962e71b633\", \"ui_touch_selection_unittests\": \"1a0155795eb0190a6f1ff822ba538e64bc6c2a83\", \"unit_tests\": \"fead230c76903c015470283d69c8c35ac265b007\", \"url_unittests\": \"22d343a271be8d9388ba8600fe7330e4ed24ded6\", \"usage_time_limit_unittests\": \"82b9745548a598c68c5ac6289a4d1b761b5245a2\", \"views_unittests\": \"581a471aab188a5457024032ed247a1fb997060a\", \"viz_unittests\": \"433ec6e989d33c0ce9d19d497efee4428f55eb66\", \"wm_unittests\": \"e81749e153109d797de9a9215f703f1c7d8f0961\", \"wtf_unittests\": \"87d5d14f516194e347545a419ed9949d7c32b196\", \"zlib_unittests\": \"ad52168bb8163aab3fb9601b35d157a9d5be902a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_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-72-ppff\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603489992753420",
"status": "COMPLETED",
"status_changed_ts": "1603496680477938",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20983",
"builder:linux-chromeos-dbg",
"buildset:commit/git/97155b18de89cf4de40f3682c45f672d3647c319",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97155b18de89cf4de40f3682c45f672d3647c319",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031042941007214672",
"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/8865612878793532032/+/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:4f7040f3e1354610",
"user_agent:luci-scheduler"
],
"updated_ts": "1603496680493295",
"url": "https://ci.chromium.org/b/8865612878793532032",
"utcnow_ts": "1603496682808193"
}
}
[23:44:42.825] Invocation finished in 1h56m3.818136559s with status SUCCEEDED