[07:58:44.826] New invocation is queued and will start shortly
[07:58:45.979] Starting the invocation (attempt 1)
[07:58:46.020] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:58:46.021] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:58:46.021] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024119187595799072",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9024119187595799072",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"gitiles_ref:refs/heads/master"
]
}
[07:58:46.599] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610092726107835",
"id": "8858689125587747632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610092726482309",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22112",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024119187595799072",
"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/8858689125587747632/+/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": "1610092726482428",
"url": "https://ci.chromium.org/b/8858689125587747632",
"utcnow_ts": "1610092726591738"
}
}
[07:58:46.599] Task URL: https://ci.chromium.org/b/8858689125587747632
[07:58:46.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:2:0) after 1m0s
[07:59:00.321] Received PubSub notification, asking Buildbucket for the build status
[07:59:00.396] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:46.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:2:0)
[07:59:46.733] Timer tick, asking Buildbucket for the build status
[07:59:46.835] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:4:0) after 1m0s
[08:00:46.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:4:0)
[08:00:46.925] Timer tick, asking Buildbucket for the build status
[08:00:47.119] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:47.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:5:0) after 1m0s
[08:01:47.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:5:0)
[08:01:47.178] Timer tick, asking Buildbucket for the build status
[08:01:47.461] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:47.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:6:0) after 1m0s
[08:02:47.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:6:0)
[08:02:47.507] Timer tick, asking Buildbucket for the build status
[08:02:47.658] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:47.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:7:0) after 1m0s
[08:03:47.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:7:0)
[08:03:47.760] Timer tick, asking Buildbucket for the build status
[08:03:47.892] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:47.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:8:0) after 1m0s
[08:04:47.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:8:0)
[08:04:47.864] Timer tick, asking Buildbucket for the build status
[08:04:47.953] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:47.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:9:0) after 1m0s
[08:05:48.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:9:0)
[08:05:48.035] Timer tick, asking Buildbucket for the build status
[08:05:48.141] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:48.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:10:0) after 1m0s
[08:06:48.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:10:0)
[08:06:48.167] Timer tick, asking Buildbucket for the build status
[08:06:48.237] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:11:0) after 1m0s
[08:07:48.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:11:0)
[08:07:48.247] Timer tick, asking Buildbucket for the build status
[08:07:48.373] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:48.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:12:0) after 1m0s
[08:08:48.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:12:0)
[08:08:48.398] Timer tick, asking Buildbucket for the build status
[08:08:49.202] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:49.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:13:0) after 1m0s
[08:09:49.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:13:0)
[08:09:49.286] Timer tick, asking Buildbucket for the build status
[08:09:49.385] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:49.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:14:0) after 1m0s
[08:10:49.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:14:0)
[08:10:49.410] Timer tick, asking Buildbucket for the build status
[08:10:49.481] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:49.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:15:0) after 1m0s
[08:11:49.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:15:0)
[08:11:49.508] Timer tick, asking Buildbucket for the build status
[08:11:49.620] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:49.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:16:0) after 1m0s
[08:12:49.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:16:0)
[08:12:49.640] Timer tick, asking Buildbucket for the build status
[08:12:49.727] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:49.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:17:0) after 1m0s
[08:13:49.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:17:0)
[08:13:49.746] Timer tick, asking Buildbucket for the build status
[08:13:49.868] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:49.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:18:0) after 1m0s
[08:14:49.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:18:0)
[08:14:49.888] Timer tick, asking Buildbucket for the build status
[08:14:50.082] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:50.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:19:0) after 1m0s
[08:15:50.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:19:0)
[08:15:50.108] Timer tick, asking Buildbucket for the build status
[08:15:50.350] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:50.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:20:0) after 1m0s
[08:16:50.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:20:0)
[08:16:50.379] Timer tick, asking Buildbucket for the build status
[08:16:50.457] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:50.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:21:0) after 1m0s
[08:17:50.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:21:0)
[08:17:50.499] Timer tick, asking Buildbucket for the build status
[08:17:50.787] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:50.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:22:0) after 1m0s
[08:18:50.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:22:0)
[08:18:50.809] Timer tick, asking Buildbucket for the build status
[08:18:51.326] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:51.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:23:0) after 1m0s
[08:19:51.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:23:0)
[08:19:51.380] Timer tick, asking Buildbucket for the build status
[08:19:51.450] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:51.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:24:0) after 1m0s
[08:20:51.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:24:0)
[08:20:51.461] Timer tick, asking Buildbucket for the build status
[08:20:51.616] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:51.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:25:0) after 1m0s
[08:21:51.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:25:0)
[08:21:51.680] Timer tick, asking Buildbucket for the build status
[08:21:51.747] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:51.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:26:0) after 1m0s
[08:22:51.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:26:0)
[08:22:51.767] Timer tick, asking Buildbucket for the build status
[08:22:51.856] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:51.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:27:0) after 1m0s
[08:23:51.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:27:0)
[08:23:51.888] Timer tick, asking Buildbucket for the build status
[08:23:52.002] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:52.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:28:0) after 1m0s
[08:24:52.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:28:0)
[08:24:52.043] Timer tick, asking Buildbucket for the build status
[08:24:52.121] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:52.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:29:0) after 1m0s
[08:25:52.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:29:0)
[08:25:52.185] Timer tick, asking Buildbucket for the build status
[08:25:52.302] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:52.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:30:0) after 1m0s
[08:26:52.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:30:0)
[08:26:52.352] Timer tick, asking Buildbucket for the build status
[08:26:52.405] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:52.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:31:0) after 1m0s
[08:27:52.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:31:0)
[08:27:52.436] Timer tick, asking Buildbucket for the build status
[08:27:52.492] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:52.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:32:0) after 1m0s
[08:28:52.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:32:0)
[08:28:52.546] Timer tick, asking Buildbucket for the build status
[08:28:52.648] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:52.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:33:0) after 1m0s
[08:29:52.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:33:0)
[08:29:52.714] Timer tick, asking Buildbucket for the build status
[08:29:52.797] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:52.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:34:0) after 1m0s
[08:30:52.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:34:0)
[08:30:52.795] Timer tick, asking Buildbucket for the build status
[08:30:52.871] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:52.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:35:0) after 1m0s
[08:31:52.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:35:0)
[08:31:52.868] Timer tick, asking Buildbucket for the build status
[08:31:53.063] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:53.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:36:0) after 1m0s
[08:32:53.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:36:0)
[08:32:53.132] Timer tick, asking Buildbucket for the build status
[08:32:53.325] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:53.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:37:0) after 1m0s
[08:33:53.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:37:0)
[08:33:53.442] Timer tick, asking Buildbucket for the build status
[08:33:53.511] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:53.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:38:0) after 1m0s
[08:34:53.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:38:0)
[08:34:53.542] Timer tick, asking Buildbucket for the build status
[08:34:53.738] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:53.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:39:0) after 1m0s
[08:35:53.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:39:0)
[08:35:53.786] Timer tick, asking Buildbucket for the build status
[08:35:53.859] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:53.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:40:0) after 1m0s
[08:36:53.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:40:0)
[08:36:53.889] Timer tick, asking Buildbucket for the build status
[08:36:54.313] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:54.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:41:0) after 1m0s
[08:37:54.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:41:0)
[08:37:54.399] Timer tick, asking Buildbucket for the build status
[08:37:54.471] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:54.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:42:0) after 1m0s
[08:38:54.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:42:0)
[08:38:54.490] Timer tick, asking Buildbucket for the build status
[08:38:54.781] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:54.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:43:0) after 1m0s
[08:39:54.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:43:0)
[08:39:54.805] Timer tick, asking Buildbucket for the build status
[08:39:54.940] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:54.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:44:0) after 1m0s
[08:40:54.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:44:0)
[08:40:54.963] Timer tick, asking Buildbucket for the build status
[08:40:55.112] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:55.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:45:0) after 1m0s
[08:41:55.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:45:0)
[08:41:55.133] Timer tick, asking Buildbucket for the build status
[08:41:55.262] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:55.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:46:0) after 1m0s
[08:42:55.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:46:0)
[08:42:55.359] Timer tick, asking Buildbucket for the build status
[08:42:55.480] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:55.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:47:0) after 1m0s
[08:43:55.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:47:0)
[08:43:55.519] Timer tick, asking Buildbucket for the build status
[08:43:55.646] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:55.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:48:0) after 1m0s
[08:44:55.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:48:0)
[08:44:55.659] Timer tick, asking Buildbucket for the build status
[08:44:55.784] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:55.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:49:0) after 1m0s
[08:45:55.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:49:0)
[08:45:55.814] Timer tick, asking Buildbucket for the build status
[08:45:55.926] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:55.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:50:0) after 1m0s
[08:46:55.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:50:0)
[08:46:55.940] Timer tick, asking Buildbucket for the build status
[08:46:56.817] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:56.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:51:0) after 1m0s
[08:47:56.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:51:0)
[08:47:56.796] Timer tick, asking Buildbucket for the build status
[08:47:56.855] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:56.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:52:0) after 1m0s
[08:48:56.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:52:0)
[08:48:56.913] Timer tick, asking Buildbucket for the build status
[08:48:57.016] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:57.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:53:0) after 1m0s
[08:49:57.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:53:0)
[08:49:57.039] Timer tick, asking Buildbucket for the build status
[08:49:57.110] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:57.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:54:0) after 1m0s
[08:50:57.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:54:0)
[08:50:57.234] Timer tick, asking Buildbucket for the build status
[08:50:57.312] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:57.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:55:0) after 1m0s
[08:51:57.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:55:0)
[08:51:57.345] Timer tick, asking Buildbucket for the build status
[08:51:57.475] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:57.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:56:0) after 1m0s
[08:52:57.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:56:0)
[08:52:57.541] Timer tick, asking Buildbucket for the build status
[08:52:57.862] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:57.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:57:0) after 1m0s
[08:53:57.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:57:0)
[08:53:57.887] Timer tick, asking Buildbucket for the build status
[08:53:57.998] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:58:0) after 1m0s
[08:54:57.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:58:0)
[08:54:57.995] Timer tick, asking Buildbucket for the build status
[08:54:58.064] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:58.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:59:0) after 1m0s
[08:55:58.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:59:0)
[08:55:58.114] Timer tick, asking Buildbucket for the build status
[08:55:58.268] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:58.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:60:0) after 1m0s
[08:56:58.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:60:0)
[08:56:58.398] Timer tick, asking Buildbucket for the build status
[08:56:58.501] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:58.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:61:0) after 1m0s
[08:57:58.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:61:0)
[08:57:58.594] Timer tick, asking Buildbucket for the build status
[08:57:58.983] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:58.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:62:0) after 1m0s
[08:58:59.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:62:0)
[08:58:59.009] Timer tick, asking Buildbucket for the build status
[08:58:59.137] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:63:0) after 1m0s
[08:59:59.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:63:0)
[08:59:59.158] Timer tick, asking Buildbucket for the build status
[08:59:59.279] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:59.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:64:0) after 1m0s
[09:00:59.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:64:0)
[09:00:59.303] Timer tick, asking Buildbucket for the build status
[09:00:59.411] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:59.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:65:0) after 1m0s
[09:01:59.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:65:0)
[09:01:59.493] Timer tick, asking Buildbucket for the build status
[09:01:59.801] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:59.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:66:0) after 1m0s
[09:02:59.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:66:0)
[09:02:59.832] Timer tick, asking Buildbucket for the build status
[09:02:59.900] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:59.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:67:0) after 1m0s
[09:03:59.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:67:0)
[09:03:59.926] Timer tick, asking Buildbucket for the build status
[09:04:00.169] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:68:0) after 1m0s
[09:05:00.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:68:0)
[09:05:00.232] Timer tick, asking Buildbucket for the build status
[09:05:00.294] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:00.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:69:0) after 1m0s
[09:06:00.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:69:0)
[09:06:00.394] Timer tick, asking Buildbucket for the build status
[09:06:00.488] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:00.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:70:0) after 1m0s
[09:07:00.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:70:0)
[09:07:00.748] Timer tick, asking Buildbucket for the build status
[09:07:00.827] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:00.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:71:0) after 1m0s
[09:08:01.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:71:0)
[09:08:01.226] Timer tick, asking Buildbucket for the build status
[09:08:01.306] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:01.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:72:0) after 1m0s
[09:09:01.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:72:0)
[09:09:01.396] Timer tick, asking Buildbucket for the build status
[09:09:01.552] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:01.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:73:0) after 1m0s
[09:10:01.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:73:0)
[09:10:01.957] Timer tick, asking Buildbucket for the build status
[09:10:02.064] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:02.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:74:0) after 1m0s
[09:11:02.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:74:0)
[09:11:02.095] Timer tick, asking Buildbucket for the build status
[09:11:02.399] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:02.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:75:0) after 1m0s
[09:12:02.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:75:0)
[09:12:02.466] Timer tick, asking Buildbucket for the build status
[09:12:02.567] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:76:0) after 1m0s
[09:13:02.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:76:0)
[09:13:02.566] Timer tick, asking Buildbucket for the build status
[09:13:02.632] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:77:0) after 1m0s
[09:14:02.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:77:0)
[09:14:02.658] Timer tick, asking Buildbucket for the build status
[09:14:03.036] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:03.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:78:0) after 1m0s
[09:15:03.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:78:0)
[09:15:03.150] Timer tick, asking Buildbucket for the build status
[09:15:03.254] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:03.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:79:0) after 1m0s
[09:16:03.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:79:0)
[09:16:03.298] Timer tick, asking Buildbucket for the build status
[09:16:03.622] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:03.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:80:0) after 1m0s
[09:17:03.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:80:0)
[09:17:03.713] Timer tick, asking Buildbucket for the build status
[09:17:03.796] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:03.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:81:0) after 1m0s
[09:18:03.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:81:0)
[09:18:03.809] Timer tick, asking Buildbucket for the build status
[09:18:04.044] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:82:0) after 1m0s
[09:19:04.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:82:0)
[09:19:04.108] Timer tick, asking Buildbucket for the build status
[09:19:04.402] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:04.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:83:0) after 1m0s
[09:20:04.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:83:0)
[09:20:04.542] Timer tick, asking Buildbucket for the build status
[09:20:04.892] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:04.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:84:0) after 1m0s
[09:21:05.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:84:0)
[09:21:05.015] Timer tick, asking Buildbucket for the build status
[09:21:05.090] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:05.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:85:0) after 1m0s
[09:22:05.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:85:0)
[09:22:05.210] Timer tick, asking Buildbucket for the build status
[09:22:05.290] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:05.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:86:0) after 1m0s
[09:23:05.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:86:0)
[09:23:05.332] Timer tick, asking Buildbucket for the build status
[09:23:05.394] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:05.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:87:0) after 1m0s
[09:24:05.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:87:0)
[09:24:05.463] Timer tick, asking Buildbucket for the build status
[09:24:06.189] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:06.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:88:0) after 1m0s
[09:25:06.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:88:0)
[09:25:06.266] Timer tick, asking Buildbucket for the build status
[09:25:06.384] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:06.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:89:0) after 1m0s
[09:26:06.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:89:0)
[09:26:06.500] Timer tick, asking Buildbucket for the build status
[09:26:06.593] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:06.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:90:0) after 1m0s
[09:27:06.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:90:0)
[09:27:06.768] Timer tick, asking Buildbucket for the build status
[09:27:06.837] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:06.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:91:0) after 1m0s
[09:28:06.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:91:0)
[09:28:06.911] Timer tick, asking Buildbucket for the build status
[09:28:07.000] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:07.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:92:0) after 1m0s
[09:29:07.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:92:0)
[09:29:07.093] Timer tick, asking Buildbucket for the build status
[09:29:07.262] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:07.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:93:0) after 1m0s
[09:30:07.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:93:0)
[09:30:07.438] Timer tick, asking Buildbucket for the build status
[09:30:07.531] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:07.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:94:0) after 1m0s
[09:31:07.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:94:0)
[09:31:07.572] Timer tick, asking Buildbucket for the build status
[09:31:07.797] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:07.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:95:0) after 1m0s
[09:32:07.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:95:0)
[09:32:07.823] Timer tick, asking Buildbucket for the build status
[09:32:07.897] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:96:0) after 1m0s
[09:33:07.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:96:0)
[09:33:07.989] Timer tick, asking Buildbucket for the build status
[09:33:08.283] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:97:0) after 1m0s
[09:34:08.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:97:0)
[09:34:08.431] Timer tick, asking Buildbucket for the build status
[09:34:08.558] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:08.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:98:0) after 1m0s
[09:35:08.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:98:0)
[09:35:08.606] Timer tick, asking Buildbucket for the build status
[09:35:08.699] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:08.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:99:0) after 1m0s
[09:36:08.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:99:0)
[09:36:08.810] Timer tick, asking Buildbucket for the build status
[09:36:08.901] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:100:0) after 1m0s
[09:37:09.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:100:0)
[09:37:09.011] Timer tick, asking Buildbucket for the build status
[09:37:09.083] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:09.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:101:0) after 1m0s
[09:38:09.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:101:0)
[09:38:09.251] Timer tick, asking Buildbucket for the build status
[09:38:09.617] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:09.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:102:0) after 1m0s
[09:39:09.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:102:0)
[09:39:09.661] Timer tick, asking Buildbucket for the build status
[09:39:09.916] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:09.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:103:0) after 1m0s
[09:40:10.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:103:0)
[09:40:10.085] Timer tick, asking Buildbucket for the build status
[09:40:10.166] Build 8858689125587747632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:10.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024119187595799072:104:0) after 1m0s
[09:40:30.496] Received PubSub notification, asking Buildbucket for the build status
[09:40:30.676] Build 8858689125587747632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:40:30.676] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610098828593982",
"created_by": "project:chromium",
"created_ts": "1610092726107835",
"id": "8858689125587747632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\"}}",
"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\": \"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\", \"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-65-a7fn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22112, \"got_angle_revision\": \"f99ccb082ba59aab0fba2b8d04625bc2364fc01f\", \"got_dawn_revision\": \"00fcab636a055c78036ee20bb1a89339b0a28bad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\", \"got_revision_cp\": \"refs/heads/master@{#841404}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"937395c1ed5d20af5a5fd999d7e2deddf1b78fe3\", \"got_v8_revision\": \"ff24c7121a8adc0450e1368daf5e060b7b4f64ca\", \"got_v8_revision_cp\": \"refs/heads/8.9.219@{#1}\", \"got_webrtc_revision\": \"4681cecb415194e5e0852a12f083f2fcef0b6497\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32923}\", \"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\": \"7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7\", \"swarm_hashes_refs/heads/master(at){#841404}_without_patch\": {\"absl_hardening_tests\": \"08171867cdd6ad41b16f3c9f3ea9fecb5d8d0013\", \"accessibility_unittests\": \"ed7f2a1267d586289d6abde8c47f7f7c1617b264\", \"angle_unittests\": \"ce8c92c8535e5374f1c730bf3169982ceb0c129f\", \"app_list_unittests\": \"5e6ee4aa3a1f7f4cf5bc8dbcb4183ad7bf9f7d2a\", \"app_shell_unittests\": \"837f553a1d7c68f864d298c7dfbae54a863fb6e4\", \"ash_unittests\": \"615e3c0a893e5557d3391cee1d4cbbcbb874def7\", \"aura_unittests\": \"e328d54402d5952edd63bd2602e04bc3e38408b2\", \"base_unittests\": \"637c467826a516cd0b2aba193d042d823f307864\", \"base_util_unittests\": \"08dff01a8b7a3b328bd5b9b57615a3b4073b5a4e\", \"blink_common_unittests\": \"1d45e8f8178fb5ff1189fd886f38b8ea7e5a3f2b\", \"blink_fuzzer_unittests\": \"6d05a77148276c5af3bb5557f636a534a0d6eabf\", \"blink_heap_unittests\": \"f5678e8e3eb49c26f62be3c9fd83b680fafb6550\", \"blink_platform_unittests\": \"d85bec7627e97113c1758f90e5b6a50f9468b2c1\", \"blink_unittests\": \"6a722e102cbc0ee7902e40ce5414dfc79ac8f6f9\", \"boringssl_crypto_tests\": \"ad072040ea7dc6ea7753c2d9552c03d9a0236601\", \"boringssl_ssl_tests\": \"0d8f63613ae4088f54c4d0756fb8bd73593dad63\", \"browser_tests\": \"f7739204a8314101f7ca2a1257d70c63a7f9fc34\", \"capture_unittests\": \"f997ef84c32a78e4f7868cde37fa12777bc3f660\", \"cast_unittests\": \"f10dd99b4ba4944b42778656a550cc8eac3a728f\", \"cc_unittests\": \"e24fbc22ff01009f579bfef157ece1be0589214e\", \"chrome_app_unittests\": \"71e7f4a79a01a236d752dbbb2c11007d7272fbc2\", \"chromedriver_unittests\": \"56e1d8459f5684102426c9fa0b22311273c3ea07\", \"chromeos_components_unittests\": \"2ea593ce0bdfa6a6d08a2ff91ce50fb54c83ecc1\", \"chromeos_unittests\": \"d1647fcaecc9354bb9681c5dd059cfad7d1601f2\", \"components_browsertests\": \"e80aa713c5723f885c94b49e5b613347b73e30ce\", \"components_unittests\": \"a5c46b1b5fff7e3cbba0bf0814f3aa19098ce9bc\", \"compositor_unittests\": \"9de2d282ca3dc9066087290dcd90f0cb68b15e16\", \"content_browsertests\": \"58fdfe1caa83a655c69b5beaa3923b575c2874b1\", \"content_unittests\": \"3b20cc2af2cc47d7789009debd9499c30c4f8340\", \"crashpad_tests\": \"3671f0e5208e30e37d5da811c013dbacd1ec04fd\", \"crypto_unittests\": \"6c569b15e80278f15d5c6839ce5ae36bf23adc16\", \"dbus_unittests\": \"9cc2519be6ce48abde67eb92bd294b28bb2c3808\", \"device_unittests\": \"92954cef1ac34693f7da135352e6209e308c06cb\", \"display_unittests\": \"2354b65ba1ee60ed7ca62a8c3cdd6bcced54d4a5\", \"events_unittests\": \"d2f01a14d7123f8ebc09730111e38f10446c24f0\", \"exo_unittests\": \"c8570fa8648e6f5496020fc24135cc63b63d8504\", \"extensions_browsertests\": \"93621ecd3bcedbceecd15aa77d5552ede4cf2c05\", \"extensions_unittests\": \"ed48e7a74ea243e5f883cf44c53f93e21352c382\", \"filesystem_service_unittests\": \"31572801a55f1e81037eabbdc0ce71a7d5caf8aa\", \"gcm_unit_tests\": \"198282b1ac92fbb5105810965cd24d1c61904a0b\", \"gfx_unittests\": \"67b11ca84f4e086905d42bafd5f9519bc51f34b6\", \"gin_unittests\": \"1e9352a6d5bc022198285346f3fd157360b97786\", \"gl_unittests_ozone\": \"a56fb95bdd3ffbcedca7417c296d28696c6c52e7\", \"google_apis_unittests\": \"65f02662b5740dce0b9611cf6f17da705b834d0f\", \"gpu_unittests\": \"8d7d80c7bd5961bd1bb11529fd33777f27bca027\", \"gwp_asan_unittests\": \"b7546d151be740e40fa0062a59de163124546565\", \"interactive_ui_tests\": \"a7b30063f062b5b2a7aaa3a1c7abb7c3b9e9ced6\", \"ipc_tests\": \"70cf8fa32ff7850a63226006ab568cb2de47a133\", \"jingle_unittests\": \"f1cc1f39294f41ef93bbb4e9173e74f96881999a\", \"keyboard_unittests\": \"6e366eac3ab65a16f3b1dddbd1102a19360ca636\", \"latency_unittests\": \"c12537eb3793603b356fe85a8bbb95659af0f06b\", \"libjingle_xmpp_unittests\": \"7989e0e7df20be87c9e62c75d6a14a58fe26c394\", \"liburlpattern_unittests\": \"93b0ffef4d2e5118f8ee222a27eb25d3ea61e10c\", \"media_blink_unittests\": \"103dfcfd7919485252435e04939072634cb72bbe\", \"media_unittests\": \"1f53762b9b021ea5338e25cf246b9e93d60fed15\", \"message_center_unittests\": \"30211536beb1f4da4f1551ccabdf882b73288c6b\", \"midi_unittests\": \"8c6f9bc6769957a789543de4d283c090953700d9\", \"mojo_core_unittests\": \"4029ca599c3e1d81b99bfe86090920759c3b34d1\", \"mojo_unittests\": \"1593720fce31276a44fa36458769bfb5c2c8e142\", \"nacl_helper_nonsfi_unittests\": \"aa54c78a3feb17ec5720837257bd314b6dbbad00\", \"nacl_loader_unittests\": \"4c54c7fc8d0065a487871fe46dbfef4f35986525\", \"native_theme_unittests\": \"3c824b6f1ce7a94f13d0b5c57617ce7709b18bbc\", \"net_unittests\": \"40b5f0acd5f844c1a9812a9581ba3257db9d4eab\", \"ozone_gl_unittests\": \"d004ac71335ada8606234d83d1b87768ef6e7675\", \"ozone_unittests\": \"b5a1c6683a23a00c6cb0862fb9add6aa74ba2af1\", \"ozone_x11_unittests\": \"f8e7926f4ed276f5f1a55a8fcb7df77dba011ab6\", \"pdf_unittests\": \"9ff25756aa10c31be14aab3e8e1fbd7713bd3519\", \"perfetto_unittests\": \"dc9d8b4de6701cce998d5840afb43f94e4ef2a9f\", \"ppapi_unittests\": \"6ddfd2deefc2341d52e2b0e7f74612642eb61c9a\", \"printing_unittests\": \"c03bf49819933fb2b0813339b158235f85c630aa\", \"remoting_unittests\": \"ee651bbb09177fa3c825508b0abafb89ea53ef8b\", \"sandbox_linux_unittests\": \"be3529153962bd1b904f450dae1ca25ee651b4e7\", \"service_manager_unittests\": \"2a4d8d1eba462ec3e40376b004c612de8294328c\", \"services_unittests\": \"d20c9cf48980da0c7086348f4f32276ea7030b55\", \"shell_dialogs_unittests\": \"1e67c8ab7060467b1d1814692acb1f470571a6ef\", \"shell_encryption_unittests\": \"b0857b40615e9be1da73c327530a41c5ec9726cf\", \"skia_unittests\": \"435d1daf3144c8f35adbabbe14760fbfd0a7b82a\", \"snapshot_unittests\": \"d94acbdb07db294a4450fb470202b82862a4b3fe\", \"sql_unittests\": \"7305a60e4f4851a1006cac5def81901b46edfb89\", \"storage_unittests\": \"d7d2f32e914dfe29e6cc2d61e13eb0081a82f147\", \"sync_integration_tests\": \"1d3ee43e737c96df96af2d3f54692686fbca77a2\", \"traffic_annotation_auditor_unittests\": \"9c9e7f0ac10646bfe499efa40fabce4d8fbb102c\", \"ui_base_unittests\": \"2805679ba43ab40a2843a755f6301e46967b078a\", \"ui_chromeos_unittests\": \"b8e26fcaf0a537744434bd0040c9f76063c4fe3d\", \"ui_touch_selection_unittests\": \"2e260a44835ebedd24b977acc903c55767bc7b31\", \"unit_tests\": \"a3f4ca6f8dc7544581d430b500cf29c876929a03\", \"url_unittests\": \"18a361cbf31cadda251b0b4624892bcb2a728c9c\", \"usage_time_limit_unittests\": \"dec241f49fdffda68930b9a369f40d132d07cb09\", \"views_unittests\": \"952b95f5011dac9bbc2f535e6f0a9b6c45c1c692\", \"viz_unittests\": \"378d1c606798cfb33f7d5ed895b8d9cd6e76e541\", \"wm_unittests\": \"d4124bd2f47107218c153d2896767a75b0eb4931\", \"wtf_unittests\": \"ed0fa2ad86df1ff00fd02999beee97ae1c5cc51f\", \"zlib_unittests\": \"6c0751a88ab0e590e55e8a2c9ee8eff64a2a60fb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-65-a7fn\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610092739615968",
"status": "COMPLETED",
"status_changed_ts": "1610098829463406",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22112",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ef7c9c5bfcc91518f168c3ae1c993977b9dc0e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024119187595799072",
"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/8858689125587747632/+/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:50f9d2d23fc63710",
"user_agent:luci-scheduler"
],
"updated_ts": "1610098829490966",
"url": "https://ci.chromium.org/b/8858689125587747632",
"utcnow_ts": "1610098830659940"
}
}
[09:40:30.676] Invocation finished in 1h41m45.867025011s with status SUCCEEDED