[13:51:03.714] New invocation is queued and will start shortly
[13:51:04.887] Starting the invocation (attempt 1)
[13:51:04.918] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:51:04.918] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:51:04.918] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021560306802538576",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"995b434134ca4b11719ef616e8d9f7243c01fe36\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021560306802538576",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/995b434134ca4b11719ef616e8d9f7243c01fe36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/995b434134ca4b11719ef616e8d9f7243c01fe36",
"gitiles_ref:refs/heads/master"
]
}
[13:51:06.026] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612533065026426",
"id": "8856130244765700128",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"995b434134ca4b11719ef616e8d9f7243c01fe36\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612533065698217",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22493",
"builder:linux-chromeos-dbg",
"buildset:commit/git/995b434134ca4b11719ef616e8d9f7243c01fe36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/995b434134ca4b11719ef616e8d9f7243c01fe36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021560306802538576",
"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/8856130244765700128/+/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": "1612533065698347",
"url": "https://ci.chromium.org/b/8856130244765700128",
"utcnow_ts": "1612533065996921"
}
}
[13:51:06.026] Task URL: https://ci.chromium.org/b/8856130244765700128
[13:51:06.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:2:0) after 1m0s
[13:51:12.901] Received PubSub notification, asking Buildbucket for the build status
[13:51:13.046] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:06.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:2:0)
[13:52:06.157] Timer tick, asking Buildbucket for the build status
[13:52:06.411] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:06.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:4:0) after 1m0s
[13:53:06.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:4:0)
[13:53:06.497] Timer tick, asking Buildbucket for the build status
[13:53:06.566] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:06.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:5:0) after 1m0s
[13:54:06.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:5:0)
[13:54:06.619] Timer tick, asking Buildbucket for the build status
[13:54:07.692] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:07.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:6:0) after 1m0s
[13:55:07.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:6:0)
[13:55:07.825] Timer tick, asking Buildbucket for the build status
[13:55:08.030] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:08.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:7:0) after 1m0s
[13:56:08.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:7:0)
[13:56:08.124] Timer tick, asking Buildbucket for the build status
[13:56:08.548] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:08.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:8:0) after 1m0s
[13:57:08.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:8:0)
[13:57:08.595] Timer tick, asking Buildbucket for the build status
[13:57:08.705] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:08.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:9:0) after 1m0s
[13:58:08.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:9:0)
[13:58:08.708] Timer tick, asking Buildbucket for the build status
[13:58:08.849] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:08.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:10:0) after 1m0s
[13:59:08.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:10:0)
[13:59:08.896] Timer tick, asking Buildbucket for the build status
[13:59:09.037] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:09.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:11:0) after 1m0s
[14:00:09.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:11:0)
[14:00:09.078] Timer tick, asking Buildbucket for the build status
[14:00:09.208] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:09.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:12:0) after 1m0s
[14:01:09.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:12:0)
[14:01:09.223] Timer tick, asking Buildbucket for the build status
[14:01:09.291] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:09.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:13:0) after 1m0s
[14:02:09.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:13:0)
[14:02:09.403] Timer tick, asking Buildbucket for the build status
[14:02:09.552] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:09.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:14:0) after 1m0s
[14:03:09.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:14:0)
[14:03:09.531] Timer tick, asking Buildbucket for the build status
[14:03:09.591] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:09.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:15:0) after 1m0s
[14:04:10.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:15:0)
[14:04:10.424] Timer tick, asking Buildbucket for the build status
[14:04:10.484] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:10.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:16:0) after 1m0s
[14:05:10.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:16:0)
[14:05:10.461] Timer tick, asking Buildbucket for the build status
[14:05:10.523] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:10.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:17:0) after 1m0s
[14:06:10.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:17:0)
[14:06:10.538] Timer tick, asking Buildbucket for the build status
[14:06:10.599] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:10.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:18:0) after 1m0s
[14:07:10.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:18:0)
[14:07:10.644] Timer tick, asking Buildbucket for the build status
[14:07:10.761] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:10.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:19:0) after 1m0s
[14:08:10.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:19:0)
[14:08:10.810] Timer tick, asking Buildbucket for the build status
[14:08:10.889] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:10.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:20:0) after 1m0s
[14:09:10.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:20:0)
[14:09:10.942] Timer tick, asking Buildbucket for the build status
[14:09:11.040] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:11.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:21:0) after 1m0s
[14:10:11.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:21:0)
[14:10:11.045] Timer tick, asking Buildbucket for the build status
[14:10:11.105] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:11.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:22:0) after 1m0s
[14:11:11.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:22:0)
[14:11:11.114] Timer tick, asking Buildbucket for the build status
[14:11:11.186] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:11.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:23:0) after 1m0s
[14:12:11.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:23:0)
[14:12:11.167] Timer tick, asking Buildbucket for the build status
[14:12:11.454] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:11.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:24:0) after 1m0s
[14:13:11.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:24:0)
[14:13:11.600] Timer tick, asking Buildbucket for the build status
[14:13:11.937] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:11.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:25:0) after 1m0s
[14:14:11.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:25:0)
[14:14:11.957] Timer tick, asking Buildbucket for the build status
[14:14:12.137] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:12.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:26:0) after 1m0s
[14:15:12.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:26:0)
[14:15:12.213] Timer tick, asking Buildbucket for the build status
[14:15:12.283] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:12.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:27:0) after 1m0s
[14:16:12.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:27:0)
[14:16:12.367] Timer tick, asking Buildbucket for the build status
[14:16:12.936] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:12.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:28:0) after 1m0s
[14:17:13.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:28:0)
[14:17:13.038] Timer tick, asking Buildbucket for the build status
[14:17:13.133] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:13.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:29:0) after 1m0s
[14:18:13.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:29:0)
[14:18:13.198] Timer tick, asking Buildbucket for the build status
[14:18:13.449] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:13.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:30:0) after 1m0s
[14:19:13.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:30:0)
[14:19:13.450] Timer tick, asking Buildbucket for the build status
[14:19:13.632] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:13.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:31:0) after 1m0s
[14:20:13.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:31:0)
[14:20:13.812] Timer tick, asking Buildbucket for the build status
[14:20:13.913] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:13.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:32:0) after 1m0s
[14:21:14.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:32:0)
[14:21:14.068] Timer tick, asking Buildbucket for the build status
[14:21:14.311] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:14.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:33:0) after 1m0s
[14:22:14.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:33:0)
[14:22:14.363] Timer tick, asking Buildbucket for the build status
[14:22:14.424] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:14.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:34:0) after 1m0s
[14:23:14.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:34:0)
[14:23:14.544] Timer tick, asking Buildbucket for the build status
[14:23:14.627] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:14.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:35:0) after 1m0s
[14:24:14.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:35:0)
[14:24:14.695] Timer tick, asking Buildbucket for the build status
[14:24:14.787] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:14.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:36:0) after 1m0s
[14:25:14.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:36:0)
[14:25:14.897] Timer tick, asking Buildbucket for the build status
[14:25:14.964] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:14.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:37:0) after 1m0s
[14:26:14.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:37:0)
[14:26:14.992] Timer tick, asking Buildbucket for the build status
[14:26:15.345] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:15.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:38:0) after 1m0s
[14:27:15.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:38:0)
[14:27:15.477] Timer tick, asking Buildbucket for the build status
[14:27:15.596] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:15.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:39:0) after 1m0s
[14:28:15.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:39:0)
[14:28:15.697] Timer tick, asking Buildbucket for the build status
[14:28:15.926] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:15.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:40:0) after 1m0s
[14:29:16.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:40:0)
[14:29:16.124] Timer tick, asking Buildbucket for the build status
[14:29:16.214] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:16.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:41:0) after 1m0s
[14:30:16.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:41:0)
[14:30:16.383] Timer tick, asking Buildbucket for the build status
[14:30:16.440] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:16.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:42:0) after 1m0s
[14:31:16.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:42:0)
[14:31:16.510] Timer tick, asking Buildbucket for the build status
[14:31:16.609] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:16.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:43:0) after 1m0s
[14:32:16.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:43:0)
[14:32:16.749] Timer tick, asking Buildbucket for the build status
[14:32:16.814] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:16.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:44:0) after 1m0s
[14:33:16.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:44:0)
[14:33:16.881] Timer tick, asking Buildbucket for the build status
[14:33:17.307] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:17.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:45:0) after 1m0s
[14:34:17.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:45:0)
[14:34:17.492] Timer tick, asking Buildbucket for the build status
[14:34:18.121] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:18.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:46:0) after 1m0s
[14:35:18.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:46:0)
[14:35:18.279] Timer tick, asking Buildbucket for the build status
[14:35:18.702] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:18.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:47:0) after 1m0s
[14:36:18.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:47:0)
[14:36:18.912] Timer tick, asking Buildbucket for the build status
[14:36:19.247] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:19.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:48:0) after 1m0s
[14:37:19.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:48:0)
[14:37:19.258] Timer tick, asking Buildbucket for the build status
[14:37:19.407] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:19.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:49:0) after 1m0s
[14:38:19.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:49:0)
[14:38:19.442] Timer tick, asking Buildbucket for the build status
[14:38:19.584] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:19.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:50:0) after 1m0s
[14:39:19.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:50:0)
[14:39:19.607] Timer tick, asking Buildbucket for the build status
[14:39:19.771] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:19.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:51:0) after 1m0s
[14:40:19.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:51:0)
[14:40:19.809] Timer tick, asking Buildbucket for the build status
[14:40:19.928] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:19.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:52:0) after 1m0s
[14:41:19.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:52:0)
[14:41:19.944] Timer tick, asking Buildbucket for the build status
[14:41:20.204] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:20.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:53:0) after 1m0s
[14:42:20.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:53:0)
[14:42:20.266] Timer tick, asking Buildbucket for the build status
[14:42:21.249] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:21.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:54:0) after 1m0s
[14:43:21.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:54:0)
[14:43:21.392] Timer tick, asking Buildbucket for the build status
[14:43:21.517] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:21.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:55:0) after 1m0s
[14:44:21.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:55:0)
[14:44:21.569] Timer tick, asking Buildbucket for the build status
[14:44:22.116] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:56:0) after 1m0s
[14:45:22.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:56:0)
[14:45:22.213] Timer tick, asking Buildbucket for the build status
[14:45:22.588] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:22.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:57:0) after 1m0s
[14:46:22.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:57:0)
[14:46:22.691] Timer tick, asking Buildbucket for the build status
[14:46:22.922] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:22.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:58:0) after 1m0s
[14:47:22.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:58:0)
[14:47:22.960] Timer tick, asking Buildbucket for the build status
[14:47:23.107] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:23.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:59:0) after 1m0s
[14:48:23.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:59:0)
[14:48:23.195] Timer tick, asking Buildbucket for the build status
[14:48:23.274] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:23.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:60:0) after 1m0s
[14:49:23.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:60:0)
[14:49:23.254] Timer tick, asking Buildbucket for the build status
[14:49:23.400] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:23.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:61:0) after 1m0s
[14:50:23.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:61:0)
[14:50:23.525] Timer tick, asking Buildbucket for the build status
[14:50:24.166] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:24.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:62:0) after 1m0s
[14:51:24.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:62:0)
[14:51:24.513] Timer tick, asking Buildbucket for the build status
[14:51:24.629] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:24.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:63:0) after 1m0s
[14:52:24.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:63:0)
[14:52:24.740] Timer tick, asking Buildbucket for the build status
[14:52:24.866] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:64:0) after 1m0s
[14:53:24.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:64:0)
[14:53:24.917] Timer tick, asking Buildbucket for the build status
[14:53:25.050] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:25.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:65:0) after 1m0s
[14:54:25.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:65:0)
[14:54:25.232] Timer tick, asking Buildbucket for the build status
[14:54:25.340] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:25.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:66:0) after 1m0s
[14:55:25.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:66:0)
[14:55:25.405] Timer tick, asking Buildbucket for the build status
[14:55:25.556] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:25.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:67:0) after 1m0s
[14:56:25.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:67:0)
[14:56:25.576] Timer tick, asking Buildbucket for the build status
[14:56:25.756] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:25.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:68:0) after 1m0s
[14:57:25.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:68:0)
[14:57:25.886] Timer tick, asking Buildbucket for the build status
[14:57:26.075] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:26.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:69:0) after 1m0s
[14:58:26.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:69:0)
[14:58:26.187] Timer tick, asking Buildbucket for the build status
[14:58:26.269] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:26.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:70:0) after 1m0s
[14:59:26.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:70:0)
[14:59:26.307] Timer tick, asking Buildbucket for the build status
[14:59:26.371] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:26.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:71:0) after 1m0s
[15:00:26.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:71:0)
[15:00:26.475] Timer tick, asking Buildbucket for the build status
[15:00:26.550] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:26.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:72:0) after 1m0s
[15:01:26.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:72:0)
[15:01:26.615] Timer tick, asking Buildbucket for the build status
[15:01:26.931] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:26.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:73:0) after 1m0s
[15:02:26.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:73:0)
[15:02:26.969] Timer tick, asking Buildbucket for the build status
[15:02:27.245] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:27.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:74:0) after 1m0s
[15:03:27.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:74:0)
[15:03:27.291] Timer tick, asking Buildbucket for the build status
[15:03:27.460] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:27.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:75:0) after 1m0s
[15:04:27.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:75:0)
[15:04:27.504] Timer tick, asking Buildbucket for the build status
[15:04:27.904] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:27.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:76:0) after 1m0s
[15:05:28.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:76:0)
[15:05:28.007] Timer tick, asking Buildbucket for the build status
[15:05:28.430] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:28.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:77:0) after 1m0s
[15:06:28.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:77:0)
[15:06:28.480] Timer tick, asking Buildbucket for the build status
[15:06:29.241] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:29.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:78:0) after 1m0s
[15:07:29.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:78:0)
[15:07:29.247] Timer tick, asking Buildbucket for the build status
[15:07:29.508] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:29.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:79:0) after 1m0s
[15:08:29.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:79:0)
[15:08:29.595] Timer tick, asking Buildbucket for the build status
[15:08:29.713] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:29.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:80:0) after 1m0s
[15:09:29.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:80:0)
[15:09:29.734] Timer tick, asking Buildbucket for the build status
[15:09:29.845] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:29.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:81:0) after 1m0s
[15:10:29.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:81:0)
[15:10:29.832] Timer tick, asking Buildbucket for the build status
[15:10:29.910] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:29.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:82:0) after 1m0s
[15:11:29.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:82:0)
[15:11:29.915] Timer tick, asking Buildbucket for the build status
[15:11:30.063] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:30.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:83:0) after 1m0s
[15:12:30.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:83:0)
[15:12:30.158] Timer tick, asking Buildbucket for the build status
[15:12:30.221] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:30.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:84:0) after 1m0s
[15:13:30.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:84:0)
[15:13:30.273] Timer tick, asking Buildbucket for the build status
[15:13:30.339] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:85:0) after 1m0s
[15:14:30.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:85:0)
[15:14:30.389] Timer tick, asking Buildbucket for the build status
[15:14:30.606] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:30.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:86:0) after 1m0s
[15:15:30.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:86:0)
[15:15:30.657] Timer tick, asking Buildbucket for the build status
[15:15:30.796] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:30.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:87:0) after 1m0s
[15:16:30.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:87:0)
[15:16:30.874] Timer tick, asking Buildbucket for the build status
[15:16:31.197] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:31.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:88:0) after 1m0s
[15:17:31.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:88:0)
[15:17:31.267] Timer tick, asking Buildbucket for the build status
[15:17:31.338] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:31.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:89:0) after 1m0s
[15:18:31.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:89:0)
[15:18:31.390] Timer tick, asking Buildbucket for the build status
[15:18:31.707] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:31.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:90:0) after 1m0s
[15:19:31.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:90:0)
[15:19:31.742] Timer tick, asking Buildbucket for the build status
[15:19:31.849] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:31.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:91:0) after 1m0s
[15:20:31.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:91:0)
[15:20:31.913] Timer tick, asking Buildbucket for the build status
[15:20:32.013] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:32.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:92:0) after 1m0s
[15:21:32.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:92:0)
[15:21:32.062] Timer tick, asking Buildbucket for the build status
[15:21:32.532] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:32.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:93:0) after 1m0s
[15:22:32.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:93:0)
[15:22:32.664] Timer tick, asking Buildbucket for the build status
[15:22:32.739] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:32.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:94:0) after 1m0s
[15:23:32.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:94:0)
[15:23:32.769] Timer tick, asking Buildbucket for the build status
[15:23:32.847] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:32.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:95:0) after 1m0s
[15:24:32.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:95:0)
[15:24:32.883] Timer tick, asking Buildbucket for the build status
[15:24:32.977] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:32.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:96:0) after 1m0s
[15:25:33.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:96:0)
[15:25:33.041] Timer tick, asking Buildbucket for the build status
[15:25:33.122] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:97:0) after 1m0s
[15:26:33.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:97:0)
[15:26:33.159] Timer tick, asking Buildbucket for the build status
[15:26:33.731] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:33.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:98:0) after 1m0s
[15:27:33.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:98:0)
[15:27:33.844] Timer tick, asking Buildbucket for the build status
[15:27:33.912] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:33.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:99:0) after 1m0s
[15:28:33.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:99:0)
[15:28:33.921] Timer tick, asking Buildbucket for the build status
[15:28:34.407] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:100:0) after 1m0s
[15:29:34.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:100:0)
[15:29:34.425] Timer tick, asking Buildbucket for the build status
[15:29:34.500] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:34.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:101:0) after 1m0s
[15:30:34.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:101:0)
[15:30:34.530] Timer tick, asking Buildbucket for the build status
[15:30:35.415] Build 8856130244765700128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:35.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021560306802538576:102:0) after 1m0s
[15:31:20.447] Received PubSub notification, asking Buildbucket for the build status
[15:31:20.538] Build 8856130244765700128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:31:20.538] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612539079641395",
"created_by": "project:chromium",
"created_ts": "1612533065026426",
"id": "8856130244765700128",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"995b434134ca4b11719ef616e8d9f7243c01fe36\"}}",
"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\": \"995b434134ca4b11719ef616e8d9f7243c01fe36\", \"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-93-pui4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22493, \"got_angle_revision\": \"82df803412eced8a2ec7e4ddc63570f64b7f35ac\", \"got_dawn_revision\": \"2b9707d3369addfef7f7f7aafa6416036e4aad52\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"995b434134ca4b11719ef616e8d9f7243c01fe36\", \"got_revision_cp\": \"refs/heads/master@{#851097}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"7a64550888c94b882033f89163526edc7ff4f863\", \"got_v8_revision_cp\": \"refs/heads/9.0.135@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"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\": \"995b434134ca4b11719ef616e8d9f7243c01fe36\", \"swarm_hashes_refs/heads/master(at){#851097}_without_patch\": {\"absl_hardening_tests\": \"b6459c9509011de1fc7a45a2739224bd590fca8b\", \"accessibility_unittests\": \"16abcc01f9dcf635d1a34bcf811707e7cbfd8189\", \"angle_unittests\": \"6f787f0dd036949ac9bd1d6db34b2cbec5fdefb1\", \"app_list_unittests\": \"fa131e5da5bbb3c45497458481d4225bff96ebc2\", \"app_shell_unittests\": \"5f31f8dbe2ccd5300d2065117db148c222c6aca5\", \"ash_unittests\": \"4e04abc54586ab31930fd5573b80e30b502bafaa\", \"aura_unittests\": \"1a66cb1db16492b017255b8108d22ef615d24e74\", \"base_unittests\": \"6d398d3ee4566edd9250b87a4d1ba74aa8d07953\", \"base_util_unittests\": \"7f7b3883757d08aa53cb6eb17d43b67e487a65f3\", \"blink_common_unittests\": \"b2b00f05bf2d74e44bd70456d1dbd4b8e051926a\", \"blink_fuzzer_unittests\": \"7d9948f8787081d7887c01a2289b0e0cad364f54\", \"blink_heap_unittests\": \"3dc7ebd24c61df2c9b4dfecfee57be6b7c697570\", \"blink_platform_unittests\": \"0e424b3595e545a0cd6cba7e73bc7625dc88c743\", \"blink_unittests\": \"302cabfae83ce73f608dd2fc1e6d1d42204e1d9b\", \"boringssl_crypto_tests\": \"d9949983ec785cb5b30b84ee9d9dc7b93bcd7bc2\", \"boringssl_ssl_tests\": \"44ccfa9f440d4da7df8a3f48256079c5d0b66406\", \"browser_tests\": \"bf9c83f1f5f9767d1728cefb88390caa893cf38c\", \"capture_unittests\": \"9abe5c2a295fb2e68c07f8d8e40d206ba2961364\", \"cast_unittests\": \"33f103c9b3edf7261ebe90feb5773a79846f36dd\", \"cc_unittests\": \"dd5e8197050233007c03f5e55cdfe5d1779a0104\", \"chrome_app_unittests\": \"dcf7b7f8aa64152c53a9ffd5a0ff320f6b3954a5\", \"chromedriver_unittests\": \"dba58480902670212f782a20e36f39d7c6c626fa\", \"chromeos_components_unittests\": \"69223d7600a09a006d430537513af169168ac7a8\", \"chromeos_unittests\": \"04ac8bb8cbcdc6ca70edebd655aeaf57d55c6d86\", \"components_browsertests\": \"6f3ce77b0f1c5674794cd767b58a050e9b6f9f85\", \"components_unittests\": \"63f1fd8418969d602f5fee4f1187b8a7f195b5df\", \"compositor_unittests\": \"fcf54461e43bccc5c296bcd3816e208c2bac0891\", \"content_browsertests\": \"f1c96433a13ac5d75bb2582c8b28b828b5935cce\", \"content_unittests\": \"33040778a1f3251911b966ec816b4d445574e87e\", \"crashpad_tests\": \"9cbfdeaba667f273dcd3b421de00fd743deaddff\", \"crypto_unittests\": \"4670ba57e0d7e87277ffa14e4743e108b5043188\", \"dbus_unittests\": \"bafab95e3b4b28c6cd51170d35d017bfef022767\", \"device_unittests\": \"5fed47e7826e73234c3f18d3895d1fc615f572ec\", \"display_unittests\": \"287974575057829e092481721051bad801ff251d\", \"events_unittests\": \"41c7eaea191d91e2cdebc747b9444305ef32d9a6\", \"exo_unittests\": \"6382163f2dee749a31a1c0a5d9979a27e3a28b1a\", \"extensions_browsertests\": \"e1d48d5a44a6cae19c7be227824e40676eaa049f\", \"extensions_unittests\": \"1d1443d278488418421d547e34241268d7a6eab2\", \"filesystem_service_unittests\": \"3110c968f9a4715a367315fc8dbdd056ddeb0afe\", \"gcm_unit_tests\": \"f6536f47294598e8f524dd63c6ac6954daad12d7\", \"gfx_unittests\": \"c5d2ca8c236371a8aabeb333c19fd972a932164c\", \"gin_unittests\": \"d03b018a5d4209c9dce88999e081e203a206ef02\", \"gl_unittests_ozone\": \"e70a32b849c4749150cc60618af44e5652fe6c6f\", \"google_apis_unittests\": \"d5628811ec7779dde71397415e1f897eda70aec4\", \"gpu_unittests\": \"ea7693999ea2bda5b7b4f35c902d6b0e9f247dbe\", \"gwp_asan_unittests\": \"14c1c8acba3eaa49cb8d63f8e868e1bf77a96ab4\", \"interactive_ui_tests\": \"69b135bf55935e2a71a96fcfb52747b05f63ed9a\", \"ipc_tests\": \"98c85ab7c394e73e13c14d391eb1276ca5f69900\", \"jingle_unittests\": \"31c957b9d707bb2310e9f363c4e4a26049177ec1\", \"keyboard_unittests\": \"90149d32f44c41456a45b61fc8717abe6c883286\", \"latency_unittests\": \"405762f9136bdbb6f07331357d2f3f2573646d6f\", \"libjingle_xmpp_unittests\": \"2671b40f281e9cbea993895aeecd4cf405e50a18\", \"liburlpattern_unittests\": \"e30a8551cb20def209c2747e94f4398f5827dc52\", \"media_blink_unittests\": \"2bd4a0490c93df9136f8397c7ef4738558eb8748\", \"media_unittests\": \"6600ca228b93f1faa73c68527f0c3bf1a6e380be\", \"message_center_unittests\": \"a05ca37c9134f6b4be6e1a4e22b71558abc17fde\", \"midi_unittests\": \"a529f1bf30d865c32ca38ced44a8c0403ce2f22d\", \"mojo_core_unittests\": \"b8e55ee209c39ce7c694944fd95c27cc751c9dc0\", \"mojo_unittests\": \"15576d20d9968ef2f02355396e2d0d8cd1beaa4c\", \"nacl_helper_nonsfi_unittests\": \"a313aa2c1895a21b669e164cdd92ebb77e17fbd0\", \"nacl_loader_unittests\": \"c15a87da6606b92f8f78ed00295c5f0b8beed5b2\", \"native_theme_unittests\": \"6934c1d4686c03d5bf1029c3f630e58a9b9c49bb\", \"net_unittests\": \"b218f963e034de0ae618f4bbde10e5c041c77a38\", \"ozone_gl_unittests\": \"e8f339501ddfca3b5d0b260a17afe91353702699\", \"ozone_unittests\": \"62069be38fd7ebe8ea5e7ef8d74f72bcd3a8e3a7\", \"ozone_x11_unittests\": \"90afbec61c41820bf3be5318660f36d622ece90c\", \"pdf_unittests\": \"1fe5ddb93b8d719476c8c3090701434ad2b0602f\", \"perfetto_unittests\": \"8fdff4b8de4cc570ed76ad9a9051a87bd00bc315\", \"ppapi_unittests\": \"0cf70d211189dedb9458ff2a65a68dc49349f163\", \"printing_unittests\": \"f764074fc272ede00a62f46fbfc01cdaff9e3408\", \"remoting_unittests\": \"18b3e2962a227c65f5ccdddbc15503fedd4de93a\", \"sandbox_linux_unittests\": \"da6eed438ae3d4c65630427291009e2ca0fef2de\", \"service_manager_unittests\": \"4aba34fc42cbb224e6c10b5871a849e51500fa66\", \"services_unittests\": \"f4c9ea0dd979320970c5317f27518b5057df56d0\", \"shell_dialogs_unittests\": \"b363b2fb1faf85c872595ab950aff76a0b02287f\", \"shell_encryption_unittests\": \"736179b159105508fa2c1ca347728ad32d2f46a3\", \"skia_unittests\": \"e876a0cdad86cca7ca539206afef11da090bc880\", \"snapshot_unittests\": \"8a55d99c43ab433c213edcec01ff880389708e24\", \"sql_unittests\": \"ea09d6762dd471cf7d33cf1c7a0ea9e26cd9b742\", \"storage_unittests\": \"52640c72ff30e337a716e194216478ac935dc769\", \"sync_integration_tests\": \"9721cc9da178c4909c9da9fec45e4e36ed65cb4e\", \"traffic_annotation_auditor_unittests\": \"809f4ab02f0bf03843789def6a546cc342c67b99\", \"ui_base_unittests\": \"56a660b8ce0b0003b949db8bfb3887a436ca0c30\", \"ui_chromeos_unittests\": \"2d02b2b318ac9708ba54db0975439950f75b23c5\", \"ui_touch_selection_unittests\": \"85e7530d40a0e5566eeeed7d592e5c98688b7e69\", \"unit_tests\": \"661c2c916a9320b403e72e91e046088a97a77739\", \"url_unittests\": \"9888bd1c0bab33061c92a24c923874bd5ad738d7\", \"usage_time_limit_unittests\": \"086c4009e362d88889221073e8a1c5df3571b05a\", \"views_unittests\": \"e0e79469655374aada0f87932df784e786e0aec9\", \"viz_unittests\": \"a7b74125e0b45aea9a340345c87e55b0461f4010\", \"wm_unittests\": \"193ef769934b7df6e1cdfa15f2a73d74f9b56ebc\", \"wtf_unittests\": \"85d7f45c42f9573ac6f7858f143c23c5615a55fc\", \"zlib_unittests\": \"e41103d9a91f2ded32f1d32d778867fb3cfeb6ff\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_9f02bd2de6eac19c457931accbc0b1e66d92a355209524fd30dfc8de3911a1f0_v2\", \"builder_f950d00180feebb913a151f4148df44a669def32bdb4d2b9a63ead64ebacc911_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-93-pui4\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612533071224372",
"status": "COMPLETED",
"status_changed_ts": "1612539080017190",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22493",
"builder:linux-chromeos-dbg",
"buildset:commit/git/995b434134ca4b11719ef616e8d9f7243c01fe36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/995b434134ca4b11719ef616e8d9f7243c01fe36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021560306802538576",
"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/8856130244765700128/+/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:518b478242eca110",
"user_agent:luci-scheduler"
],
"updated_ts": "1612539080022287",
"url": "https://ci.chromium.org/b/8856130244765700128",
"utcnow_ts": "1612539080528739"
}
}
[15:31:20.538] Invocation finished in 1h40m16.838936628s with status SUCCEEDED