[00:49:20.419] New invocation is queued and will start shortly
[00:49:21.556] Starting the invocation (attempt 1)
[00:49:21.592] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:49:21.592] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:49:21.592] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031303363878252816",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2f02f2623f412489909e9d9a8ad0823fac715ae3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031303363878252816",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"gitiles_ref:refs/heads/master"
]
}
[00:49:23.415] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603241361829300",
"id": "8865873301737456800",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f02f2623f412489909e9d9a8ad0823fac715ae3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603241363046135",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20941",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031303363878252816",
"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/8865873301737456800/+/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": "1603241363049090",
"url": "https://ci.chromium.org/b/8865873301737456800",
"utcnow_ts": "1603241363399687"
}
}
[00:49:23.415] Task URL: https://ci.chromium.org/b/8865873301737456800
[00:49:23.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:2:0) after 1m0s
[00:49:45.157] Received PubSub notification, asking Buildbucket for the build status
[00:49:45.398] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:23.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:2:0)
[00:50:23.582] Timer tick, asking Buildbucket for the build status
[00:50:23.815] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:23.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:4:0) after 1m0s
[00:51:24.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:4:0)
[00:51:24.101] Timer tick, asking Buildbucket for the build status
[00:51:24.484] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:24.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:5:0) after 1m0s
[00:52:24.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:5:0)
[00:52:24.538] Timer tick, asking Buildbucket for the build status
[00:52:24.632] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:6:0) after 1m0s
[00:53:24.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:6:0)
[00:53:24.765] Timer tick, asking Buildbucket for the build status
[00:53:24.825] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:24.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:7:0) after 1m0s
[00:54:25.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:7:0)
[00:54:25.034] Timer tick, asking Buildbucket for the build status
[00:54:25.153] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:25.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:8:0) after 1m0s
[00:55:25.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:8:0)
[00:55:25.202] Timer tick, asking Buildbucket for the build status
[00:55:25.609] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:9:0) after 1m0s
[00:56:25.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:9:0)
[00:56:25.801] Timer tick, asking Buildbucket for the build status
[00:56:25.920] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:25.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:10:0) after 1m0s
[00:57:25.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:10:0)
[00:57:25.949] Timer tick, asking Buildbucket for the build status
[00:57:26.077] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:26.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:11:0) after 1m0s
[00:58:26.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:11:0)
[00:58:26.204] Timer tick, asking Buildbucket for the build status
[00:58:26.406] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:26.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:12:0) after 1m0s
[00:59:26.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:12:0)
[00:59:26.537] Timer tick, asking Buildbucket for the build status
[00:59:26.925] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:26.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:13:0) after 1m0s
[01:00:27.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:13:0)
[01:00:27.093] Timer tick, asking Buildbucket for the build status
[01:00:27.173] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:27.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:14:0) after 1m0s
[01:01:27.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:14:0)
[01:01:27.231] Timer tick, asking Buildbucket for the build status
[01:01:27.326] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:27.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:15:0) after 1m0s
[01:02:27.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:15:0)
[01:02:27.426] Timer tick, asking Buildbucket for the build status
[01:02:27.490] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:27.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:16:0) after 1m0s
[01:03:27.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:16:0)
[01:03:27.566] Timer tick, asking Buildbucket for the build status
[01:03:27.716] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:27.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:17:0) after 1m0s
[01:04:27.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:17:0)
[01:04:27.763] Timer tick, asking Buildbucket for the build status
[01:04:27.931] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:27.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:18:0) after 1m0s
[01:05:28.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:18:0)
[01:05:28.132] Timer tick, asking Buildbucket for the build status
[01:05:28.325] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:28.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:19:0) after 1m0s
[01:06:28.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:19:0)
[01:06:28.497] Timer tick, asking Buildbucket for the build status
[01:06:28.555] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:28.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:20:0) after 1m0s
[01:07:28.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:20:0)
[01:07:28.708] Timer tick, asking Buildbucket for the build status
[01:07:28.802] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:28.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:21:0) after 1m0s
[01:08:28.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:21:0)
[01:08:28.865] Timer tick, asking Buildbucket for the build status
[01:08:29.370] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:29.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:22:0) after 1m0s
[01:09:29.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:22:0)
[01:09:29.396] Timer tick, asking Buildbucket for the build status
[01:09:29.556] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:29.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:23:0) after 1m0s
[01:10:29.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:23:0)
[01:10:29.657] Timer tick, asking Buildbucket for the build status
[01:10:29.760] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:29.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:24:0) after 1m0s
[01:11:29.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:24:0)
[01:11:29.827] Timer tick, asking Buildbucket for the build status
[01:11:30.118] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:30.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:25:0) after 1m0s
[01:12:30.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:25:0)
[01:12:30.410] Timer tick, asking Buildbucket for the build status
[01:12:30.493] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:30.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:26:0) after 1m0s
[01:13:30.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:26:0)
[01:13:30.555] Timer tick, asking Buildbucket for the build status
[01:13:30.844] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:30.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:27:0) after 1m0s
[01:14:30.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:27:0)
[01:14:30.969] Timer tick, asking Buildbucket for the build status
[01:14:31.115] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:31.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:28:0) after 1m0s
[01:15:31.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:28:0)
[01:15:31.112] Timer tick, asking Buildbucket for the build status
[01:15:31.210] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:31.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:29:0) after 1m0s
[01:16:31.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:29:0)
[01:16:31.221] Timer tick, asking Buildbucket for the build status
[01:16:31.278] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:30:0) after 1m0s
[01:17:31.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:30:0)
[01:17:31.466] Timer tick, asking Buildbucket for the build status
[01:17:31.527] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:31.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:31:0) after 1m0s
[01:18:31.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:31:0)
[01:18:31.882] Timer tick, asking Buildbucket for the build status
[01:18:31.948] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:31.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:32:0) after 1m0s
[01:19:32.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:32:0)
[01:19:32.334] Timer tick, asking Buildbucket for the build status
[01:19:32.452] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:32.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:33:0) after 1m0s
[01:20:32.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:33:0)
[01:20:32.569] Timer tick, asking Buildbucket for the build status
[01:20:32.638] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:32.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:34:0) after 1m0s
[01:21:32.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:34:0)
[01:21:32.880] Timer tick, asking Buildbucket for the build status
[01:21:33.089] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:33.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:35:0) after 1m0s
[01:22:33.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:35:0)
[01:22:33.099] Timer tick, asking Buildbucket for the build status
[01:22:33.166] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:33.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:36:0) after 1m0s
[01:23:33.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:36:0)
[01:23:33.214] Timer tick, asking Buildbucket for the build status
[01:23:33.276] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:33.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:37:0) after 1m0s
[01:24:33.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:37:0)
[01:24:33.304] Timer tick, asking Buildbucket for the build status
[01:24:33.517] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:33.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:38:0) after 1m0s
[01:25:33.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:38:0)
[01:25:33.583] Timer tick, asking Buildbucket for the build status
[01:25:33.802] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:33.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:39:0) after 1m0s
[01:26:33.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:39:0)
[01:26:33.864] Timer tick, asking Buildbucket for the build status
[01:26:34.009] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:34.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:40:0) after 1m0s
[01:27:34.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:40:0)
[01:27:34.106] Timer tick, asking Buildbucket for the build status
[01:27:34.166] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:34.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:41:0) after 1m0s
[01:28:34.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:41:0)
[01:28:34.241] Timer tick, asking Buildbucket for the build status
[01:28:34.498] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:34.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:42:0) after 1m0s
[01:29:34.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:42:0)
[01:29:34.557] Timer tick, asking Buildbucket for the build status
[01:29:34.719] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:34.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:43:0) after 1m0s
[01:30:34.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:43:0)
[01:30:34.740] Timer tick, asking Buildbucket for the build status
[01:30:35.028] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:35.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:44:0) after 1m0s
[01:31:35.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:44:0)
[01:31:35.083] Timer tick, asking Buildbucket for the build status
[01:31:35.506] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:35.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:45:0) after 1m0s
[01:32:35.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:45:0)
[01:32:35.569] Timer tick, asking Buildbucket for the build status
[01:32:35.899] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:35.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:46:0) after 1m0s
[01:33:36.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:46:0)
[01:33:36.038] Timer tick, asking Buildbucket for the build status
[01:33:36.193] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:36.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:47:0) after 1m0s
[01:34:36.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:47:0)
[01:34:36.205] Timer tick, asking Buildbucket for the build status
[01:34:36.302] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:36.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:48:0) after 1m0s
[01:35:36.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:48:0)
[01:35:36.292] Timer tick, asking Buildbucket for the build status
[01:35:36.613] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:36.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:49:0) after 1m0s
[01:36:36.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:49:0)
[01:36:36.638] Timer tick, asking Buildbucket for the build status
[01:36:36.791] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:50:0) after 1m0s
[01:37:36.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:50:0)
[01:37:36.846] Timer tick, asking Buildbucket for the build status
[01:37:36.987] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:51:0) after 1m0s
[01:38:37.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:51:0)
[01:38:37.109] Timer tick, asking Buildbucket for the build status
[01:38:37.473] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:52:0) after 1m0s
[01:39:37.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:52:0)
[01:39:37.571] Timer tick, asking Buildbucket for the build status
[01:39:37.672] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:37.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:53:0) after 1m0s
[01:40:37.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:53:0)
[01:40:37.761] Timer tick, asking Buildbucket for the build status
[01:40:38.113] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:38.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:54:0) after 1m0s
[01:41:38.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:54:0)
[01:41:38.248] Timer tick, asking Buildbucket for the build status
[01:41:38.371] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:38.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:55:0) after 1m0s
[01:42:38.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:55:0)
[01:42:38.348] Timer tick, asking Buildbucket for the build status
[01:42:38.889] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:38.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:56:0) after 1m0s
[01:43:39.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:56:0)
[01:43:39.041] Timer tick, asking Buildbucket for the build status
[01:43:39.205] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:57:0) after 1m0s
[01:44:39.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:57:0)
[01:44:39.244] Timer tick, asking Buildbucket for the build status
[01:44:39.729] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:39.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:58:0) after 1m0s
[01:45:39.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:58:0)
[01:45:39.730] Timer tick, asking Buildbucket for the build status
[01:45:40.106] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:40.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:59:0) after 1m0s
[01:46:40.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:59:0)
[01:46:40.118] Timer tick, asking Buildbucket for the build status
[01:46:40.232] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:40.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:60:0) after 1m0s
[01:47:40.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:60:0)
[01:47:40.312] Timer tick, asking Buildbucket for the build status
[01:47:40.455] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:40.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:61:0) after 1m0s
[01:48:40.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:61:0)
[01:48:40.523] Timer tick, asking Buildbucket for the build status
[01:48:40.780] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:40.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:62:0) after 1m0s
[01:49:40.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:62:0)
[01:49:40.840] Timer tick, asking Buildbucket for the build status
[01:49:40.965] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:40.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:63:0) after 1m0s
[01:50:41.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:63:0)
[01:50:41.026] Timer tick, asking Buildbucket for the build status
[01:50:41.099] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:41.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:64:0) after 1m0s
[01:51:41.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:64:0)
[01:51:41.183] Timer tick, asking Buildbucket for the build status
[01:51:41.271] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:41.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:65:0) after 1m0s
[01:52:41.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:65:0)
[01:52:41.297] Timer tick, asking Buildbucket for the build status
[01:52:41.435] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:41.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:66:0) after 1m0s
[01:53:41.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:66:0)
[01:53:41.545] Timer tick, asking Buildbucket for the build status
[01:53:41.654] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:41.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:67:0) after 1m0s
[01:54:41.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:67:0)
[01:54:41.649] Timer tick, asking Buildbucket for the build status
[01:54:41.761] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:41.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:68:0) after 1m0s
[01:55:41.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:68:0)
[01:55:41.789] Timer tick, asking Buildbucket for the build status
[01:55:41.927] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:41.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:69:0) after 1m0s
[01:56:41.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:69:0)
[01:56:41.962] Timer tick, asking Buildbucket for the build status
[01:56:42.068] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:42.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:70:0) after 1m0s
[01:57:42.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:70:0)
[01:57:42.123] Timer tick, asking Buildbucket for the build status
[01:57:42.290] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:42.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:71:0) after 1m0s
[01:58:42.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:71:0)
[01:58:42.421] Timer tick, asking Buildbucket for the build status
[01:58:42.513] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:42.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:72:0) after 1m0s
[01:59:42.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:72:0)
[01:59:42.542] Timer tick, asking Buildbucket for the build status
[01:59:42.696] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:42.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:73:0) after 1m0s
[02:00:42.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:73:0)
[02:00:42.748] Timer tick, asking Buildbucket for the build status
[02:00:42.900] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:42.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:74:0) after 1m0s
[02:01:43.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:74:0)
[02:01:43.068] Timer tick, asking Buildbucket for the build status
[02:01:43.599] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:43.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:75:0) after 1m0s
[02:02:43.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:75:0)
[02:02:43.687] Timer tick, asking Buildbucket for the build status
[02:02:43.805] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:43.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:76:0) after 1m0s
[02:03:43.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:76:0)
[02:03:43.934] Timer tick, asking Buildbucket for the build status
[02:03:44.008] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:44.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:77:0) after 1m0s
[02:04:44.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:77:0)
[02:04:44.128] Timer tick, asking Buildbucket for the build status
[02:04:44.465] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:44.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:78:0) after 1m0s
[02:05:44.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:78:0)
[02:05:44.506] Timer tick, asking Buildbucket for the build status
[02:05:44.579] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:44.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:79:0) after 1m0s
[02:06:44.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:79:0)
[02:06:44.812] Timer tick, asking Buildbucket for the build status
[02:06:45.084] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:45.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:80:0) after 1m0s
[02:07:45.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:80:0)
[02:07:45.288] Timer tick, asking Buildbucket for the build status
[02:07:45.378] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:45.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:81:0) after 1m0s
[02:08:45.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:81:0)
[02:08:45.537] Timer tick, asking Buildbucket for the build status
[02:08:46.238] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:46.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:82:0) after 1m0s
[02:09:46.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:82:0)
[02:09:46.268] Timer tick, asking Buildbucket for the build status
[02:09:46.788] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:46.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:83:0) after 1m0s
[02:10:46.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:83:0)
[02:10:46.853] Timer tick, asking Buildbucket for the build status
[02:10:47.270] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:47.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:84:0) after 1m0s
[02:11:47.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:84:0)
[02:11:47.324] Timer tick, asking Buildbucket for the build status
[02:11:47.841] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:47.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:85:0) after 1m0s
[02:12:47.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:85:0)
[02:12:47.847] Timer tick, asking Buildbucket for the build status
[02:12:47.922] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:47.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:86:0) after 1m0s
[02:13:47.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:86:0)
[02:13:47.994] Timer tick, asking Buildbucket for the build status
[02:13:48.059] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:48.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:87:0) after 1m0s
[02:14:48.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:87:0)
[02:14:48.089] Timer tick, asking Buildbucket for the build status
[02:14:48.248] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:48.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:88:0) after 1m0s
[02:15:48.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:88:0)
[02:15:48.376] Timer tick, asking Buildbucket for the build status
[02:15:48.512] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:48.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:89:0) after 1m0s
[02:16:48.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:89:0)
[02:16:48.565] Timer tick, asking Buildbucket for the build status
[02:16:48.641] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:48.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:90:0) after 1m0s
[02:17:48.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:90:0)
[02:17:48.685] Timer tick, asking Buildbucket for the build status
[02:17:48.787] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:91:0) after 1m0s
[02:18:48.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:91:0)
[02:18:48.831] Timer tick, asking Buildbucket for the build status
[02:18:48.901] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:92:0) after 1m0s
[02:19:49.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:92:0)
[02:19:49.023] Timer tick, asking Buildbucket for the build status
[02:19:50.284] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:50.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:93:0) after 1m0s
[02:20:50.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:93:0)
[02:20:50.298] Timer tick, asking Buildbucket for the build status
[02:20:50.367] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:50.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:94:0) after 1m0s
[02:21:50.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:94:0)
[02:21:50.434] Timer tick, asking Buildbucket for the build status
[02:21:50.509] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:50.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:95:0) after 1m0s
[02:22:50.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:95:0)
[02:22:50.633] Timer tick, asking Buildbucket for the build status
[02:22:50.702] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:50.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:96:0) after 1m0s
[02:23:50.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:96:0)
[02:23:50.721] Timer tick, asking Buildbucket for the build status
[02:23:50.788] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:50.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:97:0) after 1m0s
[02:24:50.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:97:0)
[02:24:50.891] Timer tick, asking Buildbucket for the build status
[02:24:51.123] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:51.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:98:0) after 1m0s
[02:25:51.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:98:0)
[02:25:51.164] Timer tick, asking Buildbucket for the build status
[02:25:51.277] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:99:0) after 1m0s
[02:26:51.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:99:0)
[02:26:51.343] Timer tick, asking Buildbucket for the build status
[02:26:51.779] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:51.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:100:0) after 1m0s
[02:27:51.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:100:0)
[02:27:51.822] Timer tick, asking Buildbucket for the build status
[02:27:52.113] Build 8865873301737456800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:52.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031303363878252816:101:0) after 1m0s
[02:28:28.496] Received PubSub notification, asking Buildbucket for the build status
[02:28:28.573] Build 8865873301737456800: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:28:28.573] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603247307830145",
"created_by": "project:chromium",
"created_ts": "1603241361829300",
"failure_reason": "BUILD_FAILURE",
"id": "8865873301737456800",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f02f2623f412489909e9d9a8ad0823fac715ae3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}, \"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\": \"2f02f2623f412489909e9d9a8ad0823fac715ae3\", \"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-46-1ou6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20941, \"got_angle_revision\": \"637786a9a862e617560404999b4a8800cf101f4d\", \"got_dawn_revision\": \"e9c99e93e75ec13ecf143478b9defe92230fc83e\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"2f02f2623f412489909e9d9a8ad0823fac715ae3\", \"got_revision_cp\": \"refs/heads/master@{#819178}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ee18f390eeadf44413a596881be3d45637e2243d\", \"got_v8_revision\": \"a08f3d9fa422ce47f355ec718734797090739a68\", \"got_v8_revision_cp\": \"refs/heads/8.8.146@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f02f2623f412489909e9d9a8ad0823fac715ae3\", \"swarm_hashes_refs/heads/master(at){#819178}_without_patch\": {\"absl_hardening_tests\": \"5dbf0482055baee39629382b751544372490b3cd\", \"accessibility_unittests\": \"5072851a57ff60a600653bdc5f1f2b1c57a0fa01\", \"app_list_unittests\": \"2c7312e4d5306e028d818a72fd1bd48f222ba7a8\", \"app_shell_unittests\": \"efab1ac670181d8ef1544f86fe8b58517a0b57be\", \"ash_unittests\": \"57b4430087304d79d4671587fbcb61bd61a9c1b2\", \"aura_unittests\": \"56a2e681a3a5e266e9170d78182e536e4e466779\", \"base_unittests\": \"7717f58a95e17e8859b60f43cc525bfa79235438\", \"base_util_unittests\": \"2ed04dc7813765e25483bf2fb0bf9ad18725d41a\", \"blink_common_unittests\": \"97f731b864c38ceffb05768e211cb4b1dcbdd265\", \"blink_fuzzer_unittests\": \"8bec38da9a90d876387a618e7f0181294e4a05f5\", \"blink_heap_unittests\": \"b2f555d77fe19d8ab779354b33bc69963ce328f0\", \"blink_platform_unittests\": \"b2346a530c5404457597c399682dbdab3bf11c41\", \"blink_unittests\": \"328b1d214c8c79bbf29ace503ffff85956a06229\", \"boringssl_crypto_tests\": \"b413fe362f44f950b790d779a6e581e36b75d34d\", \"boringssl_ssl_tests\": \"f94a4d9582889b76b44be2ac99e875a9e804b648\", \"browser_tests\": \"49075f6cebd065896414cf6e0c60ae2960e8ec5f\", \"capture_unittests\": \"347031ec5a742b0a1716a0c6f9596f3b411826d1\", \"cast_unittests\": \"b1f16292d628628b956d8296105fdf2bd935d7bc\", \"cc_unittests\": \"465a87d2c2394625663e98844da453f090a429a8\", \"chrome_app_unittests\": \"a01850dc1fc330d46e7dccc8fd4c19f690f5f1fa\", \"chromedriver_unittests\": \"ddcd9b9616a62b7842a3b38fb7a0d0a53a47318a\", \"chromeos_components_unittests\": \"56e0dd6d959d4661e13eea62586dda35e7aeb14c\", \"chromeos_unittests\": \"bee74ec672265a9b36ebf65d3f4df114bc085eb2\", \"components_browsertests\": \"dc39797f1e65b00cdf580eb58ed2ab320fccbaea\", \"components_unittests\": \"c72a41197a70b71ccdd6bf64dee8cddf03ce1724\", \"compositor_unittests\": \"5d3d7a45d1c676a3921533fcceeca1d7a6c777e4\", \"content_browsertests\": \"3979640810c2c1b1fc98183d6d1821b26693207a\", \"content_unittests\": \"86a38c71060d5ecbee353df1e9881c689be14f9e\", \"crypto_unittests\": \"d8dd9acc3ed5a363a4d938f1f5786ef1ece423d4\", \"dbus_unittests\": \"52c5fa45a1d519b1de28492c924a304a5c5e4c04\", \"device_unittests\": \"fb6e005d33a793b7f9fdd0a03eaae967d692de83\", \"display_unittests\": \"cd346dfb0b3daef314a4b989d53b16af4529d9b1\", \"events_unittests\": \"4263fd5b1ec088a1a77cc6fa908adc5e7c6bcab5\", \"exo_unittests\": \"70196f6204a53ae47830814dc13a3e96ad2539a7\", \"extensions_browsertests\": \"68ce0377008e78080b82624a8ab44c4399c28b56\", \"extensions_unittests\": \"746d167b1212afe07fd51d8d842172eee729ccf4\", \"filesystem_service_unittests\": \"64ac26cc5f63628881e1ffccbbbb28af6538d484\", \"gcm_unit_tests\": \"d4099dee093689c4225cb5b467a840c6ac9d3bcb\", \"gfx_unittests\": \"721aea6bfaed1c793a34f3261d21294674de6e40\", \"gin_unittests\": \"f32e6bd1b1d87dd7e15dd67b38e7c1e27cfba71f\", \"gl_unittests_ozone\": \"a946ce80eb28028a1c5dcf9a04986c8c43a96abf\", \"google_apis_unittests\": \"c6b51f7a7a64ddaa42d8363de7347c6c3d1199f5\", \"gpu_unittests\": \"06e11035cf392cc536ab86db1e3b77616424ec7b\", \"gwp_asan_unittests\": \"f2ea5e37161a1b776418e7bce928388d44a0e70e\", \"interactive_ui_tests\": \"ddeefa4acfbdb9d34af1052abd6deff890f71fbd\", \"ipc_tests\": \"7d20d2fd0e21f6af304d3cd6883ef9660d8e5f8a\", \"jingle_unittests\": \"2d0411b2c061358bb19838f9d6ccfe5132cee506\", \"keyboard_unittests\": \"c23814e59318f5baeb481969d4b693032e7981b1\", \"latency_unittests\": \"edeeba3a1679b6c1a82ed2d643885460c7380659\", \"libjingle_xmpp_unittests\": \"9577f90a5ea5670c13b383eb8cd42008ff980914\", \"media_blink_unittests\": \"6b93336f6a1f336bade02a9e6308e760434a42c6\", \"media_unittests\": \"fc0a8cabe73a1d578d98b3617c7ffa4dad9157ee\", \"message_center_unittests\": \"b9bf2b0fce82c6802223cd943d55beaf9d202f14\", \"midi_unittests\": \"2b0f8582edf6b4ece34428873dab3d39b47addf6\", \"mojo_core_unittests\": \"be22e485cb7769e40f6e03bc83e7e645b3ae9493\", \"mojo_unittests\": \"0f7eab278ebcf2c0d594cd1f0492fae0c7e765b0\", \"nacl_helper_nonsfi_unittests\": \"c1355874e5e0d4865915d612619e8a125dcb0905\", \"nacl_loader_unittests\": \"371a387cecc6c760d92903b4e4383685a602f86b\", \"native_theme_unittests\": \"ee8e6c27cf0ade1849514efa28de1069b01e8a48\", \"net_unittests\": \"15c51e987d7b0b4104809f06ba088383a94f91b7\", \"ozone_gl_unittests\": \"0487dd048d628536e22313293f1230b2803b5f9a\", \"ozone_unittests\": \"4b7a6d73270eb10421d7c2797556be7830fba998\", \"ozone_x11_unittests\": \"f35d2f93c3cf6eb7a239eefd04b1fc2f280b6eb0\", \"pdf_unittests\": \"346b2bef4e0f48e2c0f04d87d3695356d9c2febf\", \"perfetto_unittests\": \"dd9bd66a71ca00b009a142d0c6023e9ee26b1209\", \"ppapi_unittests\": \"be67f0b92cc2f0aec89b7d30ffc334615f7bfdc7\", \"printing_unittests\": \"a0a52bec336b2aaa0c3cd0c6db849284b4a6fdec\", \"remoting_unittests\": \"57d65bc53e41211a4f6c39c5d72cb1b919d3b5c2\", \"sandbox_linux_unittests\": \"c75d104319a73c239e7f5dae3fd832884fbd928d\", \"service_manager_unittests\": \"711d482613171aa4f1bfad2165808ae77834497a\", \"services_unittests\": \"d4bd8e7f19672f58b00b2fe2c0099d67e40d1bd6\", \"shell_dialogs_unittests\": \"bd3250af820b491c323ca4e87d1adfa54d780b2e\", \"skia_unittests\": \"2f403815fb93ab2a4c5e3f55d651f601c2af819b\", \"snapshot_unittests\": \"c04366b2d2400581773d46b2439a45ae60d4a5dd\", \"sql_unittests\": \"15b8cc538133f4254277e1e4ef0181d6f4ec1cb4\", \"standalone_angle_unittests\": \"0ab04115f5c19f556c5ed35ae3f5d7fc88ed4518\", \"storage_unittests\": \"b4812e3a6d1105ef066ea93e6ecd3c142ed731cc\", \"sync_integration_tests\": \"695d5a9e96ae178e0cf36458eb846a7f9b010573\", \"traffic_annotation_auditor_unittests\": \"cd1a50f4b19da4230320ebed579734b99433737c\", \"ui_base_unittests\": \"77e83fdaf34471a050dd9be47e833b8c7747b0fb\", \"ui_chromeos_unittests\": \"1ae6c06cce09686c259b6ff31a4269f52d68f97c\", \"ui_touch_selection_unittests\": \"c3f663c681637b201194b76a60eb4aa554d4ecb7\", \"unit_tests\": \"f44ca388b308afc3289e5eb4bf2d9a1887d72808\", \"url_unittests\": \"a54df9760be237844ec42f0cfb19fad6a1d2d54b\", \"usage_time_limit_unittests\": \"35bd22cb7f06e01737487cca9fb3861358e82abf\", \"views_unittests\": \"c3fadb2730cdaeb847960130a22646355622c7f6\", \"viz_unittests\": \"72f6f4eb94789a770565248c9465ddccb6f64404\", \"wm_unittests\": \"a0e1a54510e9a25d13f93fafce8bc4540accb73d\", \"wtf_unittests\": \"56d8eb8cfd1eb4bd6d56e166091c1c1fa9e50a78\", \"zlib_unittests\": \"0a8c52a05b916bf6a04b80223da5a30dc9ea1951\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_62ff673344f63b1d0862893f2031420df362e89a2b43f8f65e2ede9a934c5b6f_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_b5e41ce0b01ce81870a1097ddb1343f2a3924630f4d3bb9f1a0eaa4d6a5abbed_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-46-1ou6\"], \"image\": [\"chrome-xenial-20101400-bb93c5ec2c2\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- QuickActionsViewTest.LocatePhoneToggle\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603241384559680",
"status": "COMPLETED",
"status_changed_ts": "1603241384945306",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20941",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f02f2623f412489909e9d9a8ad0823fac715ae3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031303363878252816",
"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/8865873301737456800/+/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:4f617350b5249910",
"user_agent:luci-scheduler"
],
"updated_ts": "1603247308188714",
"url": "https://ci.chromium.org/b/8865873301737456800",
"utcnow_ts": "1603247308564182"
}
}
[02:28:28.573] Invocation finished in 1h39m8.170804796s with status FAILED