[03:49:22.391] New invocation is queued and will start shortly
[03:49:23.472] Starting the invocation (attempt 1)
[03:49:23.512] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:49:23.512] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:49:23.512] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022232340550370720",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022232340550370720",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"gitiles_ref:refs/heads/master"
]
}
[03:49:24.126] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611892163622291",
"id": "8856802278596600256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611892164017494",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22392",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022232340550370720",
"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/8856802278596600256/+/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": "1611892164017616",
"url": "https://ci.chromium.org/b/8856802278596600256",
"utcnow_ts": "1611892164119023"
}
}
[03:49:24.126] Task URL: https://ci.chromium.org/b/8856802278596600256
[03:49:24.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:2:0) after 1m0s
[03:49:27.300] Received PubSub notification, asking Buildbucket for the build status
[03:49:27.379] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:24.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:2:0)
[03:50:24.133] Timer tick, asking Buildbucket for the build status
[03:50:24.245] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:24.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:4:0) after 1m0s
[03:51:24.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:4:0)
[03:51:24.292] Timer tick, asking Buildbucket for the build status
[03:51:24.615] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:24.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:5:0) after 1m0s
[03:52:24.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:5:0)
[03:52:24.634] Timer tick, asking Buildbucket for the build status
[03:52:24.754] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:24.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:6:0) after 1m0s
[03:53:24.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:6:0)
[03:53:24.823] Timer tick, asking Buildbucket for the build status
[03:53:24.927] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:24.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:7:0) after 1m0s
[03:54:24.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:7:0)
[03:54:24.988] Timer tick, asking Buildbucket for the build status
[03:54:25.174] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:25.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:8:0) after 1m0s
[03:55:25.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:8:0)
[03:55:25.319] Timer tick, asking Buildbucket for the build status
[03:55:25.908] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:25.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:9:0) after 1m0s
[03:56:25.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:9:0)
[03:56:25.976] Timer tick, asking Buildbucket for the build status
[03:56:26.074] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:26.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:10:0) after 1m0s
[03:57:26.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:10:0)
[03:57:26.125] Timer tick, asking Buildbucket for the build status
[03:57:26.201] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:26.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:11:0) after 1m0s
[03:58:26.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:11:0)
[03:58:26.278] Timer tick, asking Buildbucket for the build status
[03:58:26.434] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:26.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:12:0) after 1m0s
[03:59:26.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:12:0)
[03:59:26.537] Timer tick, asking Buildbucket for the build status
[03:59:27.018] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:27.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:13:0) after 1m0s
[04:00:27.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:13:0)
[04:00:27.120] Timer tick, asking Buildbucket for the build status
[04:00:27.414] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:27.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:14:0) after 1m0s
[04:01:27.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:14:0)
[04:01:27.423] Timer tick, asking Buildbucket for the build status
[04:01:27.716] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:27.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:15:0) after 1m0s
[04:02:27.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:15:0)
[04:02:27.739] Timer tick, asking Buildbucket for the build status
[04:02:27.814] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:27.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:16:0) after 1m0s
[04:03:27.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:16:0)
[04:03:27.842] Timer tick, asking Buildbucket for the build status
[04:03:27.941] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:27.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:17:0) after 1m0s
[04:04:27.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:17:0)
[04:04:27.985] Timer tick, asking Buildbucket for the build status
[04:04:28.127] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:28.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:18:0) after 1m0s
[04:05:28.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:18:0)
[04:05:28.120] Timer tick, asking Buildbucket for the build status
[04:05:28.184] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:19:0) after 1m0s
[04:06:28.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:19:0)
[04:06:28.237] Timer tick, asking Buildbucket for the build status
[04:06:28.325] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:28.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:20:0) after 1m0s
[04:07:28.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:20:0)
[04:07:28.398] Timer tick, asking Buildbucket for the build status
[04:07:28.844] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:28.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:21:0) after 1m0s
[04:08:28.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:21:0)
[04:08:28.866] Timer tick, asking Buildbucket for the build status
[04:08:29.185] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:29.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:22:0) after 1m0s
[04:09:29.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:22:0)
[04:09:29.215] Timer tick, asking Buildbucket for the build status
[04:09:29.301] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:29.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:23:0) after 1m0s
[04:10:29.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:23:0)
[04:10:29.327] Timer tick, asking Buildbucket for the build status
[04:10:29.397] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:29.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:24:0) after 1m0s
[04:11:29.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:24:0)
[04:11:29.421] Timer tick, asking Buildbucket for the build status
[04:11:29.480] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:29.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:25:0) after 1m0s
[04:12:29.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:25:0)
[04:12:29.504] Timer tick, asking Buildbucket for the build status
[04:12:29.571] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:29.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:26:0) after 1m0s
[04:13:29.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:26:0)
[04:13:29.616] Timer tick, asking Buildbucket for the build status
[04:13:29.670] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:29.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:27:0) after 1m0s
[04:14:29.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:27:0)
[04:14:29.675] Timer tick, asking Buildbucket for the build status
[04:14:29.774] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:29.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:28:0) after 1m0s
[04:15:29.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:28:0)
[04:15:29.808] Timer tick, asking Buildbucket for the build status
[04:15:29.860] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:29.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:29:0) after 1m0s
[04:16:29.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:29:0)
[04:16:29.908] Timer tick, asking Buildbucket for the build status
[04:16:29.966] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:29.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:30:0) after 1m0s
[04:17:29.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:30:0)
[04:17:29.975] Timer tick, asking Buildbucket for the build status
[04:17:30.045] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:30.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:31:0) after 1m0s
[04:18:30.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:31:0)
[04:18:30.095] Timer tick, asking Buildbucket for the build status
[04:18:30.247] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:30.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:32:0) after 1m0s
[04:19:30.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:32:0)
[04:19:30.259] Timer tick, asking Buildbucket for the build status
[04:19:30.391] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:30.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:33:0) after 1m0s
[04:20:30.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:33:0)
[04:20:30.453] Timer tick, asking Buildbucket for the build status
[04:20:30.513] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:30.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:34:0) after 1m0s
[04:21:30.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:34:0)
[04:21:30.559] Timer tick, asking Buildbucket for the build status
[04:21:30.628] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:30.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:35:0) after 1m0s
[04:22:30.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:35:0)
[04:22:30.712] Timer tick, asking Buildbucket for the build status
[04:22:30.775] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:30.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:36:0) after 1m0s
[04:23:30.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:36:0)
[04:23:30.848] Timer tick, asking Buildbucket for the build status
[04:23:30.983] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:30.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:37:0) after 1m0s
[04:24:31.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:37:0)
[04:24:31.025] Timer tick, asking Buildbucket for the build status
[04:24:31.163] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:31.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:38:0) after 1m0s
[04:25:31.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:38:0)
[04:25:31.204] Timer tick, asking Buildbucket for the build status
[04:25:31.304] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:31.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:39:0) after 1m0s
[04:26:31.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:39:0)
[04:26:31.358] Timer tick, asking Buildbucket for the build status
[04:26:31.757] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:31.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:40:0) after 1m0s
[04:27:31.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:40:0)
[04:27:31.840] Timer tick, asking Buildbucket for the build status
[04:27:32.105] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:32.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:41:0) after 1m0s
[04:28:32.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:41:0)
[04:28:32.236] Timer tick, asking Buildbucket for the build status
[04:28:32.300] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:32.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:42:0) after 1m0s
[04:29:32.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:42:0)
[04:29:32.315] Timer tick, asking Buildbucket for the build status
[04:29:32.630] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:32.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:43:0) after 1m0s
[04:30:32.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:43:0)
[04:30:32.716] Timer tick, asking Buildbucket for the build status
[04:30:32.776] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:32.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:44:0) after 1m0s
[04:31:32.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:44:0)
[04:31:32.824] Timer tick, asking Buildbucket for the build status
[04:31:32.888] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:45:0) after 1m0s
[04:32:32.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:45:0)
[04:32:32.895] Timer tick, asking Buildbucket for the build status
[04:32:33.076] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:33.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:46:0) after 1m0s
[04:33:33.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:46:0)
[04:33:33.174] Timer tick, asking Buildbucket for the build status
[04:33:33.304] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:33.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:47:0) after 1m0s
[04:34:33.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:47:0)
[04:34:33.322] Timer tick, asking Buildbucket for the build status
[04:34:33.519] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:48:0) after 1m0s
[04:35:33.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:48:0)
[04:35:33.571] Timer tick, asking Buildbucket for the build status
[04:35:33.690] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:33.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:49:0) after 1m0s
[04:36:33.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:49:0)
[04:36:33.740] Timer tick, asking Buildbucket for the build status
[04:36:34.293] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:34.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:50:0) after 1m0s
[04:37:34.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:50:0)
[04:37:34.374] Timer tick, asking Buildbucket for the build status
[04:37:34.492] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:34.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:51:0) after 1m0s
[04:38:34.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:51:0)
[04:38:34.644] Timer tick, asking Buildbucket for the build status
[04:38:35.004] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:35.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:52:0) after 1m0s
[04:39:35.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:52:0)
[04:39:35.105] Timer tick, asking Buildbucket for the build status
[04:39:35.412] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:35.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:53:0) after 1m0s
[04:40:35.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:53:0)
[04:40:35.488] Timer tick, asking Buildbucket for the build status
[04:40:35.760] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:35.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:54:0) after 1m0s
[04:41:35.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:54:0)
[04:41:35.906] Timer tick, asking Buildbucket for the build status
[04:41:36.000] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:55:0) after 1m0s
[04:42:36.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:55:0)
[04:42:36.122] Timer tick, asking Buildbucket for the build status
[04:42:36.219] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:56:0) after 1m0s
[04:43:36.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:56:0)
[04:43:36.385] Timer tick, asking Buildbucket for the build status
[04:43:36.629] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:36.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:57:0) after 1m0s
[04:44:36.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:57:0)
[04:44:36.790] Timer tick, asking Buildbucket for the build status
[04:44:36.919] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:36.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:58:0) after 1m0s
[04:45:36.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:58:0)
[04:45:36.953] Timer tick, asking Buildbucket for the build status
[04:45:37.220] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:37.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:59:0) after 1m0s
[04:46:37.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:59:0)
[04:46:37.370] Timer tick, asking Buildbucket for the build status
[04:46:37.549] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:60:0) after 1m0s
[04:47:37.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:60:0)
[04:47:37.540] Timer tick, asking Buildbucket for the build status
[04:47:38.042] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:38.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:61:0) after 1m0s
[04:48:38.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:61:0)
[04:48:38.206] Timer tick, asking Buildbucket for the build status
[04:48:38.294] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:38.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:62:0) after 1m0s
[04:49:38.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:62:0)
[04:49:38.412] Timer tick, asking Buildbucket for the build status
[04:49:38.803] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:38.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:63:0) after 1m0s
[04:50:38.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:63:0)
[04:50:38.945] Timer tick, asking Buildbucket for the build status
[04:50:39.439] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:39.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:64:0) after 1m0s
[04:51:39.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:64:0)
[04:51:39.488] Timer tick, asking Buildbucket for the build status
[04:51:40.147] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:40.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:65:0) after 1m0s
[04:52:40.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:65:0)
[04:52:40.151] Timer tick, asking Buildbucket for the build status
[04:52:40.234] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:40.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:66:0) after 1m0s
[04:53:40.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:66:0)
[04:53:40.425] Timer tick, asking Buildbucket for the build status
[04:53:40.559] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:40.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:67:0) after 1m0s
[04:54:40.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:67:0)
[04:54:40.625] Timer tick, asking Buildbucket for the build status
[04:54:40.744] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:40.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:68:0) after 1m0s
[04:55:40.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:68:0)
[04:55:40.911] Timer tick, asking Buildbucket for the build status
[04:55:41.036] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:41.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:69:0) after 1m0s
[04:56:41.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:69:0)
[04:56:41.139] Timer tick, asking Buildbucket for the build status
[04:56:41.333] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:41.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:70:0) after 1m0s
[04:57:41.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:70:0)
[04:57:41.364] Timer tick, asking Buildbucket for the build status
[04:57:41.557] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:41.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:71:0) after 1m0s
[04:58:41.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:71:0)
[04:58:41.571] Timer tick, asking Buildbucket for the build status
[04:58:41.643] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:41.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:72:0) after 1m0s
[04:59:41.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:72:0)
[04:59:41.704] Timer tick, asking Buildbucket for the build status
[04:59:41.983] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:41.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:73:0) after 1m0s
[05:00:42.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:73:0)
[05:00:42.036] Timer tick, asking Buildbucket for the build status
[05:00:42.256] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:42.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:74:0) after 1m0s
[05:01:42.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:74:0)
[05:01:42.345] Timer tick, asking Buildbucket for the build status
[05:01:42.433] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:42.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:75:0) after 1m0s
[05:02:42.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:75:0)
[05:02:42.570] Timer tick, asking Buildbucket for the build status
[05:02:42.675] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:42.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:76:0) after 1m0s
[05:03:42.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:76:0)
[05:03:42.743] Timer tick, asking Buildbucket for the build status
[05:03:43.093] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:43.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:77:0) after 1m0s
[05:04:43.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:77:0)
[05:04:43.122] Timer tick, asking Buildbucket for the build status
[05:04:43.285] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:43.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:78:0) after 1m0s
[05:05:43.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:78:0)
[05:05:43.304] Timer tick, asking Buildbucket for the build status
[05:05:43.664] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:43.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:79:0) after 1m0s
[05:06:43.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:79:0)
[05:06:43.761] Timer tick, asking Buildbucket for the build status
[05:06:44.057] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:44.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:80:0) after 1m0s
[05:07:44.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:80:0)
[05:07:44.129] Timer tick, asking Buildbucket for the build status
[05:07:44.344] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:44.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:81:0) after 1m0s
[05:08:44.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:81:0)
[05:08:44.408] Timer tick, asking Buildbucket for the build status
[05:08:44.619] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:44.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:82:0) after 1m0s
[05:09:44.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:82:0)
[05:09:44.643] Timer tick, asking Buildbucket for the build status
[05:09:44.863] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:44.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:83:0) after 1m0s
[05:10:44.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:83:0)
[05:10:44.920] Timer tick, asking Buildbucket for the build status
[05:10:45.765] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:45.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:84:0) after 1m0s
[05:11:45.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:84:0)
[05:11:45.929] Timer tick, asking Buildbucket for the build status
[05:11:46.218] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:46.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:85:0) after 1m0s
[05:12:46.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:85:0)
[05:12:46.315] Timer tick, asking Buildbucket for the build status
[05:12:46.408] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:46.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:86:0) after 1m0s
[05:13:46.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:86:0)
[05:13:46.433] Timer tick, asking Buildbucket for the build status
[05:13:46.494] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:46.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:87:0) after 1m0s
[05:14:46.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:87:0)
[05:14:46.529] Timer tick, asking Buildbucket for the build status
[05:14:46.652] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:46.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:88:0) after 1m0s
[05:15:46.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:88:0)
[05:15:46.720] Timer tick, asking Buildbucket for the build status
[05:15:46.794] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:46.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:89:0) after 1m0s
[05:16:46.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:89:0)
[05:16:46.844] Timer tick, asking Buildbucket for the build status
[05:16:46.979] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:46.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:90:0) after 1m0s
[05:17:47.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:90:0)
[05:17:47.011] Timer tick, asking Buildbucket for the build status
[05:17:47.086] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:47.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:91:0) after 1m0s
[05:18:47.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:91:0)
[05:18:47.081] Timer tick, asking Buildbucket for the build status
[05:18:47.179] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:47.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:92:0) after 1m0s
[05:19:47.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:92:0)
[05:19:47.312] Timer tick, asking Buildbucket for the build status
[05:19:47.432] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:47.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:93:0) after 1m0s
[05:20:47.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:93:0)
[05:20:47.477] Timer tick, asking Buildbucket for the build status
[05:20:47.559] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:47.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:94:0) after 1m0s
[05:21:47.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:94:0)
[05:21:47.628] Timer tick, asking Buildbucket for the build status
[05:21:47.916] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:47.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:95:0) after 1m0s
[05:22:47.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:95:0)
[05:22:47.921] Timer tick, asking Buildbucket for the build status
[05:22:48.044] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:48.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:96:0) after 1m0s
[05:23:48.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:96:0)
[05:23:48.133] Timer tick, asking Buildbucket for the build status
[05:23:48.506] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:48.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:97:0) after 1m0s
[05:24:48.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:97:0)
[05:24:48.569] Timer tick, asking Buildbucket for the build status
[05:24:50.322] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:50.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:98:0) after 1m0s
[05:25:50.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:98:0)
[05:25:50.528] Timer tick, asking Buildbucket for the build status
[05:25:50.640] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:50.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:99:0) after 1m0s
[05:26:50.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:99:0)
[05:26:50.771] Timer tick, asking Buildbucket for the build status
[05:26:50.837] Build 8856802278596600256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:50.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022232340550370720:100:0) after 1m0s
[05:27:31.915] Received PubSub notification, asking Buildbucket for the build status
[05:27:31.993] Build 8856802278596600256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:27:31.993] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611898049943273",
"created_by": "project:chromium",
"created_ts": "1611892163622291",
"id": "8856802278596600256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\"}}",
"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\": \"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\", \"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-55-3ju6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22392, \"got_angle_revision\": \"a685db2e9745b615987b1b514dc23cc2fafff7bd\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\", \"got_revision_cp\": \"refs/heads/master@{#848398}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d\", \"swarm_hashes_refs/heads/master(at){#848398}_without_patch\": {\"absl_hardening_tests\": \"43d9b0306d8b3deca172e8e32efca6b44984d0bf\", \"accessibility_unittests\": \"a95a6f4a7fe8a6962be98989a757b05bce725c71\", \"angle_unittests\": \"c56108b18a107e19425b47a5c18ac9797ea7a212\", \"app_list_unittests\": \"f793d47a1dac6ab3ed8287fe323aeea70d05b659\", \"app_shell_unittests\": \"b6706c0a0c2cbabe0a489c7e94fc0d47b6128751\", \"ash_unittests\": \"92c166260c263c9a758acecb5248efd43b6ef7cb\", \"aura_unittests\": \"52f6d5f19f68e5b466ec42d44221f4abf8e8105f\", \"base_unittests\": \"6288054dcb21fbc460f325035f36664d0c4fc0a8\", \"base_util_unittests\": \"23b94b053b39cdf71a7c72d37bdbd77def3893b0\", \"blink_common_unittests\": \"3fd8b6f336eba5acb6a297c8dee5aa80bde56514\", \"blink_fuzzer_unittests\": \"ff711e6e504e12b00d933fa253e7cff1ae2e542f\", \"blink_heap_unittests\": \"c518ddb636f6be9184990c61df23d5994a7735ba\", \"blink_platform_unittests\": \"f1c93a531085dc164eff59e810f51c1403205aeb\", \"blink_unittests\": \"17cc68e422c8ac7d633abb6588155dc6f8f15aa6\", \"boringssl_crypto_tests\": \"74b2ae11e00e842ada9ab15b147fd11a656cf3dc\", \"boringssl_ssl_tests\": \"6f548ef768d225a4f0009851254ec08c87c9ac1e\", \"browser_tests\": \"9285779d98c72588fe177b4c87cee13ade22c42f\", \"capture_unittests\": \"cd722ba7048fb6feef588386cf88ed3dcd0b9d8b\", \"cast_unittests\": \"32a9ff1c86f2283d936da8f916933ee530383f0f\", \"cc_unittests\": \"acc042f041007338cb7d606dc553b4ca0861201b\", \"chrome_app_unittests\": \"9e97b12da9e0aefc3b99a754e38cfae352c6997f\", \"chromedriver_unittests\": \"b09cd789966549d7f1b4ce2005f630110763d42a\", \"chromeos_components_unittests\": \"8ce84a7c41d62be851b62120af33ceb1f530a750\", \"chromeos_unittests\": \"f58ea7a3ff106d351bfba6cdfa918d837f6c49c9\", \"components_browsertests\": \"8b1565f8dc23ec3955d8c7bbb7f7879cfee50fa4\", \"components_unittests\": \"2011057c6b363a9f2026bc3b51262f4bf1bc2b41\", \"compositor_unittests\": \"e1773e685c183f29165ca7205135153b47c5fb53\", \"content_browsertests\": \"7b6b705e3e959f99cc705b013e926b1ef78c99e6\", \"content_unittests\": \"cc5f6221ba0b2ce9d1675e0a53265d28410d9969\", \"crashpad_tests\": \"fa4a51927ea735a05c8ae2bf2c0765c0fffd65e9\", \"crypto_unittests\": \"63a25943da5f5dff839a673558733e56541baea8\", \"dbus_unittests\": \"9d2a7a8255fc93a02c54d6c11921f645ebb1e0d7\", \"device_unittests\": \"fa4601be12e7c6c97db7eebc5fe05dd7cfb921ca\", \"display_unittests\": \"3e2063f60771a285a8a907dc359a9a80c4a12c1c\", \"events_unittests\": \"ac5698931cabc0291101e620a8f89ac718d55c87\", \"exo_unittests\": \"0284707c5dbf7a756f37695fe71761ad75da42f6\", \"extensions_browsertests\": \"77ebd64fe8ce8f0f3284c27b91d5dc3e173454b1\", \"extensions_unittests\": \"766a810954d2fa9388bb8f7dac6c743bfe6c7f7b\", \"filesystem_service_unittests\": \"c17708993a09d3d9d784fc4ad9f8e810d5e2dd9f\", \"gcm_unit_tests\": \"86f3e02bf7ee7faf6261014f47c1deb681f9e5e3\", \"gfx_unittests\": \"3cfccea441c2ee3e1b71ed87e19a7f8010d127c9\", \"gin_unittests\": \"23605653c77511a646c3b7226b18638c13b9dd77\", \"gl_unittests_ozone\": \"18e8be17bd4f2eb7d5ec690db591ee9542a1fe7e\", \"google_apis_unittests\": \"3eb0fd712129a69526bd455f061adad3f77912f9\", \"gpu_unittests\": \"4029cae9c6266a39fc810ef01f9b5d51c39dced2\", \"gwp_asan_unittests\": \"cfdd38f4007b0fed3962ec3af304e12597a56e8b\", \"interactive_ui_tests\": \"74e8629b2bab06a960f9a8f3a3446bbf2359ec8b\", \"ipc_tests\": \"58d70d448696f969d2cf17900c778d2c02f1d7b9\", \"jingle_unittests\": \"061665758fff432ffdbe3db52d65b3649fba2f44\", \"keyboard_unittests\": \"ea1fcba11fa323346532bb4e3414b1c685cf1ee1\", \"latency_unittests\": \"069e23b4ae486d3e03277a52f367258ad2e9ac69\", \"libjingle_xmpp_unittests\": \"df3b67c6cebf8f96a08f4650b94faaaed5a6c289\", \"liburlpattern_unittests\": \"24ac9ca048f43dbb36215bdc2cb92e4e9517aeb6\", \"media_blink_unittests\": \"6385560bb3bb88884bca6a8c7e2916426413d1b4\", \"media_unittests\": \"79342930edfc590dfa165780e37b819f38a2527c\", \"message_center_unittests\": \"953eb4320b3d533b0c2f9764dc63cb84a7a2407f\", \"midi_unittests\": \"56e5adc49dfeaefa745f366d98bd4eb1179d4ad8\", \"mojo_core_unittests\": \"4d95d02d56b8339b60b500300b37aeadbb76bfef\", \"mojo_unittests\": \"87551f0394baf57a25728968a5196ab97ddde504\", \"nacl_helper_nonsfi_unittests\": \"d48acd7c1439eaee5af79d0592e9befce3d6fe8c\", \"nacl_loader_unittests\": \"dc5b861bb7b2f29fafce063222aa61c888589fb0\", \"native_theme_unittests\": \"9a2886e650c7c1ff1a12bacd223cce0ed43bea37\", \"net_unittests\": \"23e17139a220c88d649c12d6813a16fad1ffb2f3\", \"ozone_gl_unittests\": \"2450d57210ac876a000c7e787f81f22ecd5cf0a5\", \"ozone_unittests\": \"df5a93d83e6bd241b7c9e2ee9a5ccac27aa57686\", \"ozone_x11_unittests\": \"1c7eda9a6b92052b6085d56be63c226640021fe3\", \"pdf_unittests\": \"dec87b12a97e232281cafbe2aa2f2b536f60b79a\", \"perfetto_unittests\": \"f3348af54029e7749e10454b0f1169a4463bede8\", \"ppapi_unittests\": \"f5e4ece2ad6bc7fadc44a138d28a8c40a20b38ed\", \"printing_unittests\": \"4b27523a44297365d110e6e5373fcc70222b2751\", \"remoting_unittests\": \"2c66113114de555d6ea2ee87600b94bd53dafa2e\", \"sandbox_linux_unittests\": \"10ef665b2d817e32d9f6c85446bccd4e4ec26c66\", \"service_manager_unittests\": \"fac95d61aae6173cf0fc99fdd1aaccffa86cba95\", \"services_unittests\": \"518a49f79b07c69678915153eb4d8ee81b9819b9\", \"shell_dialogs_unittests\": \"be99d766c2a4de72fda598e2f5083fc331065341\", \"shell_encryption_unittests\": \"7866574b7fa2ade074781da5936da22ffd8aba93\", \"skia_unittests\": \"81e900c28dea0e71fb298e554f486a2a17589cb6\", \"snapshot_unittests\": \"6c94b68641e501d7e5620556ac9a44179cee2b3a\", \"sql_unittests\": \"ab6418ea924abf4f4a0c24273f574e7254768d6f\", \"storage_unittests\": \"6a322e3f73cf83dcebb619dd5a29856cdf95b399\", \"sync_integration_tests\": \"ea42d368f1d50c8dd3f2bff8923698e45665e36f\", \"traffic_annotation_auditor_unittests\": \"595e2402486cb4ded58f41a569d265a27bb90b7c\", \"ui_base_unittests\": \"46f9992c1ff876b8ff17965535dab7055395ff14\", \"ui_chromeos_unittests\": \"ddb8aaca8ac313d271ef3d9e8bb109f38a80c2a9\", \"ui_touch_selection_unittests\": \"01de19da8890f0198b0af2a79955cebcbb431314\", \"unit_tests\": \"d19719ee79e1d7fb3ed9b2e1fa5e0e20bb1fb3f4\", \"url_unittests\": \"d776dc593d3e5f7953fb355fbe29ca5b28717060\", \"usage_time_limit_unittests\": \"4b6c4b3f4fce25611a97e6ddb507227a3510360f\", \"views_unittests\": \"816ce8eebe1e0b71cf219422139c8af5e7f34b80\", \"viz_unittests\": \"f831011be98d800fb3c43b0c39cdee04eaba7986\", \"wm_unittests\": \"09d4b0c5426a2ade41e415b1f72235a904ad884c\", \"wtf_unittests\": \"8a343243e448c453de8839471b2421694c5b4922\", \"zlib_unittests\": \"3cd7efe124f7d0b540fd4250d35baaec4f7e4448\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_d4fdaf58b7947408531076283e0e8baf90c29d26a4447be7804b77c871ea449a_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-55-3ju6\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611892166639546",
"status": "COMPLETED",
"status_changed_ts": "1611898050607070",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22392",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022232340550370720",
"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/8856802278596600256/+/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:5165140f33ddf010",
"user_agent:luci-scheduler"
],
"updated_ts": "1611898050706419",
"url": "https://ci.chromium.org/b/8856802278596600256",
"utcnow_ts": "1611898051984603"
}
}
[05:27:31.993] Invocation finished in 1h38m9.618289111s with status SUCCEEDED