[13:10:16.242] New invocation is queued and will start shortly
[13:10:17.359] Starting the invocation (attempt 1)
[13:10:17.407] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:10:17.407] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:10:17.407] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019841530803360976",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7ca80a5770a02ac7301bf04a863ce86cb232622e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019841530803360976",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"gitiles_ref:refs/heads/master"
]
}
[13:10:19.151] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614172217549437",
"id": "8854411468769729136",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ca80a5770a02ac7301bf04a863ce86cb232622e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614172217976870",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22761",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019841530803360976",
"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/8854411468769729136/+/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": "1614172217976985",
"url": "https://ci.chromium.org/b/8854411468769729136",
"utcnow_ts": "1614172219091562"
}
}
[13:10:19.151] Task URL: https://ci.chromium.org/b/8854411468769729136
[13:10:19.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:2:0) after 1m0s
[13:11:19.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:2:0)
[13:11:19.171] Timer tick, asking Buildbucket for the build status
[13:11:19.308] Build 8854411468769729136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:19.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:3:0) after 1m0s
[13:12:19.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:3:0)
[13:12:19.407] Timer tick, asking Buildbucket for the build status
[13:12:19.512] Build 8854411468769729136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:4:0) after 1m0s
[13:13:19.078] Received PubSub notification, asking Buildbucket for the build status
[13:13:19.394] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:19.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:4:0)
[13:13:19.580] Timer tick, asking Buildbucket for the build status
[13:13:19.680] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:19.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:6:0) after 1m0s
[13:14:19.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:6:0)
[13:14:19.711] Timer tick, asking Buildbucket for the build status
[13:14:19.832] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:19.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:7:0) after 1m0s
[13:15:19.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:7:0)
[13:15:19.899] Timer tick, asking Buildbucket for the build status
[13:15:19.990] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:19.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:8:0) after 1m0s
[13:16:20.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:8:0)
[13:16:20.014] Timer tick, asking Buildbucket for the build status
[13:16:20.125] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:20.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:9:0) after 1m0s
[13:17:20.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:9:0)
[13:17:20.189] Timer tick, asking Buildbucket for the build status
[13:17:20.266] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:20.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:10:0) after 1m0s
[13:18:20.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:10:0)
[13:18:20.379] Timer tick, asking Buildbucket for the build status
[13:18:20.460] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:20.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:11:0) after 1m0s
[13:19:20.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:11:0)
[13:19:20.516] Timer tick, asking Buildbucket for the build status
[13:19:20.607] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:20.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:12:0) after 1m0s
[13:20:20.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:12:0)
[13:20:20.650] Timer tick, asking Buildbucket for the build status
[13:20:21.134] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:21.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:13:0) after 1m0s
[13:21:21.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:13:0)
[13:21:21.159] Timer tick, asking Buildbucket for the build status
[13:21:21.349] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:21.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:14:0) after 1m0s
[13:22:21.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:14:0)
[13:22:21.411] Timer tick, asking Buildbucket for the build status
[13:22:21.572] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:21.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:15:0) after 1m0s
[13:23:21.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:15:0)
[13:23:21.562] Timer tick, asking Buildbucket for the build status
[13:23:21.643] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:21.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:16:0) after 1m0s
[13:24:21.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:16:0)
[13:24:21.723] Timer tick, asking Buildbucket for the build status
[13:24:21.822] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:21.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:17:0) after 1m0s
[13:25:21.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:17:0)
[13:25:21.910] Timer tick, asking Buildbucket for the build status
[13:25:22.009] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:22.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:18:0) after 1m0s
[13:26:22.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:18:0)
[13:26:22.048] Timer tick, asking Buildbucket for the build status
[13:26:22.138] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:22.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:19:0) after 1m0s
[13:27:22.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:19:0)
[13:27:22.188] Timer tick, asking Buildbucket for the build status
[13:27:22.459] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:22.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:20:0) after 1m0s
[13:28:22.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:20:0)
[13:28:22.519] Timer tick, asking Buildbucket for the build status
[13:28:22.807] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:22.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:21:0) after 1m0s
[13:29:22.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:21:0)
[13:29:22.850] Timer tick, asking Buildbucket for the build status
[13:29:22.944] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:22.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:22:0) after 1m0s
[13:30:22.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:22:0)
[13:30:22.952] Timer tick, asking Buildbucket for the build status
[13:30:23.145] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:23.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:23:0) after 1m0s
[13:31:23.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:23:0)
[13:31:23.164] Timer tick, asking Buildbucket for the build status
[13:31:23.264] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:23.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:24:0) after 1m0s
[13:32:23.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:24:0)
[13:32:23.294] Timer tick, asking Buildbucket for the build status
[13:32:23.439] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:23.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:25:0) after 1m0s
[13:33:23.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:25:0)
[13:33:23.483] Timer tick, asking Buildbucket for the build status
[13:33:23.620] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:23.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:26:0) after 1m0s
[13:34:23.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:26:0)
[13:34:23.663] Timer tick, asking Buildbucket for the build status
[13:34:23.727] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:23.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:27:0) after 1m0s
[13:35:23.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:27:0)
[13:35:23.772] Timer tick, asking Buildbucket for the build status
[13:35:23.867] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:23.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:28:0) after 1m0s
[13:36:23.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:28:0)
[13:36:23.908] Timer tick, asking Buildbucket for the build status
[13:36:24.760] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:24.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:29:0) after 1m0s
[13:37:24.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:29:0)
[13:37:24.768] Timer tick, asking Buildbucket for the build status
[13:37:24.940] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:30:0) after 1m0s
[13:38:25.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:30:0)
[13:38:25.222] Timer tick, asking Buildbucket for the build status
[13:38:25.320] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:31:0) after 1m0s
[13:39:25.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:31:0)
[13:39:25.784] Timer tick, asking Buildbucket for the build status
[13:39:25.859] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:25.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:32:0) after 1m0s
[13:40:26.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:32:0)
[13:40:26.016] Timer tick, asking Buildbucket for the build status
[13:40:26.136] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:26.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:33:0) after 1m0s
[13:41:26.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:33:0)
[13:41:26.295] Timer tick, asking Buildbucket for the build status
[13:41:26.386] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:26.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:34:0) after 1m0s
[13:42:26.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:34:0)
[13:42:26.609] Timer tick, asking Buildbucket for the build status
[13:42:26.700] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:26.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:35:0) after 1m0s
[13:43:26.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:35:0)
[13:43:26.800] Timer tick, asking Buildbucket for the build status
[13:43:26.901] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:26.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:36:0) after 1m0s
[13:44:27.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:36:0)
[13:44:27.002] Timer tick, asking Buildbucket for the build status
[13:44:27.090] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:27.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:37:0) after 1m0s
[13:45:27.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:37:0)
[13:45:27.125] Timer tick, asking Buildbucket for the build status
[13:45:27.498] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:38:0) after 1m0s
[13:46:27.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:38:0)
[13:46:27.594] Timer tick, asking Buildbucket for the build status
[13:46:27.719] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:39:0) after 1m0s
[13:47:27.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:39:0)
[13:47:27.864] Timer tick, asking Buildbucket for the build status
[13:47:27.942] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:27.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:40:0) after 1m0s
[13:48:27.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:40:0)
[13:48:27.956] Timer tick, asking Buildbucket for the build status
[13:48:28.207] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:28.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:41:0) after 1m0s
[13:49:28.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:41:0)
[13:49:28.241] Timer tick, asking Buildbucket for the build status
[13:49:28.324] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:28.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:42:0) after 1m0s
[13:50:28.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:42:0)
[13:50:28.410] Timer tick, asking Buildbucket for the build status
[13:50:28.584] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:28.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:43:0) after 1m0s
[13:51:28.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:43:0)
[13:51:28.668] Timer tick, asking Buildbucket for the build status
[13:51:28.732] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:28.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:44:0) after 1m0s
[13:52:28.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:44:0)
[13:52:28.770] Timer tick, asking Buildbucket for the build status
[13:52:28.847] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:28.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:45:0) after 1m0s
[13:53:28.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:45:0)
[13:53:28.971] Timer tick, asking Buildbucket for the build status
[13:53:29.272] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:29.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:46:0) after 1m0s
[13:54:29.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:46:0)
[13:54:29.321] Timer tick, asking Buildbucket for the build status
[13:54:29.434] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:29.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:47:0) after 1m0s
[13:55:29.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:47:0)
[13:55:29.532] Timer tick, asking Buildbucket for the build status
[13:55:29.648] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:29.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:48:0) after 1m0s
[13:56:29.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:48:0)
[13:56:29.740] Timer tick, asking Buildbucket for the build status
[13:56:29.827] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:29.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:49:0) after 1m0s
[13:57:29.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:49:0)
[13:57:29.867] Timer tick, asking Buildbucket for the build status
[13:57:30.106] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:30.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:50:0) after 1m0s
[13:58:30.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:50:0)
[13:58:30.220] Timer tick, asking Buildbucket for the build status
[13:58:30.320] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:30.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:51:0) after 1m0s
[13:59:30.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:51:0)
[13:59:30.366] Timer tick, asking Buildbucket for the build status
[13:59:30.499] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:30.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:52:0) after 1m0s
[14:00:30.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:52:0)
[14:00:30.559] Timer tick, asking Buildbucket for the build status
[14:00:30.670] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:30.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:53:0) after 1m0s
[14:01:30.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:53:0)
[14:01:30.824] Timer tick, asking Buildbucket for the build status
[14:01:30.928] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:30.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:54:0) after 1m0s
[14:02:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:54:0)
[14:02:30.968] Timer tick, asking Buildbucket for the build status
[14:02:31.057] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:31.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:55:0) after 1m0s
[14:03:31.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:55:0)
[14:03:31.068] Timer tick, asking Buildbucket for the build status
[14:03:31.278] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:56:0) after 1m0s
[14:04:31.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:56:0)
[14:04:31.316] Timer tick, asking Buildbucket for the build status
[14:04:31.457] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:31.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:57:0) after 1m0s
[14:05:31.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:57:0)
[14:05:31.514] Timer tick, asking Buildbucket for the build status
[14:05:32.207] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:32.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:58:0) after 1m0s
[14:06:32.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:58:0)
[14:06:32.311] Timer tick, asking Buildbucket for the build status
[14:06:32.778] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:59:0) after 1m0s
[14:07:32.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:59:0)
[14:07:32.917] Timer tick, asking Buildbucket for the build status
[14:07:32.996] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:32.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:60:0) after 1m0s
[14:08:33.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:60:0)
[14:08:33.074] Timer tick, asking Buildbucket for the build status
[14:08:33.156] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:33.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:61:0) after 1m0s
[14:09:33.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:61:0)
[14:09:33.267] Timer tick, asking Buildbucket for the build status
[14:09:33.401] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:33.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:62:0) after 1m0s
[14:10:33.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:62:0)
[14:10:33.604] Timer tick, asking Buildbucket for the build status
[14:10:33.744] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:33.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:63:0) after 1m0s
[14:11:33.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:63:0)
[14:11:33.899] Timer tick, asking Buildbucket for the build status
[14:11:33.996] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:33.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:64:0) after 1m0s
[14:12:34.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:64:0)
[14:12:34.103] Timer tick, asking Buildbucket for the build status
[14:12:34.258] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:34.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:65:0) after 1m0s
[14:13:35.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:65:0)
[14:13:35.087] Timer tick, asking Buildbucket for the build status
[14:13:35.361] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:35.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:66:0) after 1m0s
[14:14:35.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:66:0)
[14:14:35.627] Timer tick, asking Buildbucket for the build status
[14:14:35.765] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:35.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:67:0) after 1m0s
[14:15:35.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:67:0)
[14:15:35.831] Timer tick, asking Buildbucket for the build status
[14:15:35.940] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:68:0) after 1m0s
[14:16:36.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:68:0)
[14:16:36.152] Timer tick, asking Buildbucket for the build status
[14:16:36.294] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:36.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:69:0) after 1m0s
[14:17:37.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:69:0)
[14:17:37.122] Timer tick, asking Buildbucket for the build status
[14:17:37.212] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:37.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:70:0) after 1m0s
[14:18:37.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:70:0)
[14:18:37.218] Timer tick, asking Buildbucket for the build status
[14:18:37.490] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:37.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:71:0) after 1m0s
[14:19:37.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:71:0)
[14:19:37.476] Timer tick, asking Buildbucket for the build status
[14:19:37.769] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:37.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:72:0) after 1m0s
[14:20:37.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:72:0)
[14:20:37.804] Timer tick, asking Buildbucket for the build status
[14:20:37.938] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:73:0) after 1m0s
[14:21:37.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:73:0)
[14:21:37.970] Timer tick, asking Buildbucket for the build status
[14:21:38.208] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:38.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:74:0) after 1m0s
[14:22:38.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:74:0)
[14:22:38.368] Timer tick, asking Buildbucket for the build status
[14:22:38.494] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:38.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:75:0) after 1m0s
[14:23:38.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:75:0)
[14:23:38.615] Timer tick, asking Buildbucket for the build status
[14:23:38.749] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:38.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:76:0) after 1m0s
[14:24:38.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:76:0)
[14:24:38.796] Timer tick, asking Buildbucket for the build status
[14:24:39.028] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:39.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:77:0) after 1m0s
[14:25:39.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:77:0)
[14:25:39.168] Timer tick, asking Buildbucket for the build status
[14:25:39.263] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:39.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:78:0) after 1m0s
[14:26:39.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:78:0)
[14:26:39.306] Timer tick, asking Buildbucket for the build status
[14:26:39.386] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:79:0) after 1m0s
[14:27:39.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:79:0)
[14:27:39.413] Timer tick, asking Buildbucket for the build status
[14:27:39.523] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:39.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:80:0) after 1m0s
[14:28:39.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:80:0)
[14:28:39.562] Timer tick, asking Buildbucket for the build status
[14:28:39.946] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:39.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:81:0) after 1m0s
[14:29:39.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:81:0)
[14:29:39.982] Timer tick, asking Buildbucket for the build status
[14:29:40.067] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:40.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:82:0) after 1m0s
[14:30:40.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:82:0)
[14:30:40.047] Timer tick, asking Buildbucket for the build status
[14:30:40.161] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:40.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:83:0) after 1m0s
[14:31:40.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:83:0)
[14:31:40.240] Timer tick, asking Buildbucket for the build status
[14:31:40.328] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:40.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:84:0) after 1m0s
[14:32:40.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:84:0)
[14:32:40.383] Timer tick, asking Buildbucket for the build status
[14:32:40.472] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:40.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:85:0) after 1m0s
[14:33:40.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:85:0)
[14:33:40.611] Timer tick, asking Buildbucket for the build status
[14:33:40.701] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:40.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:86:0) after 1m0s
[14:34:40.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:86:0)
[14:34:40.860] Timer tick, asking Buildbucket for the build status
[14:34:40.937] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:40.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:87:0) after 1m0s
[14:35:40.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:87:0)
[14:35:40.975] Timer tick, asking Buildbucket for the build status
[14:35:41.115] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:41.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:88:0) after 1m0s
[14:36:41.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:88:0)
[14:36:41.138] Timer tick, asking Buildbucket for the build status
[14:36:41.680] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:41.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:89:0) after 1m0s
[14:37:41.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:89:0)
[14:37:41.701] Timer tick, asking Buildbucket for the build status
[14:37:41.969] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:41.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:90:0) after 1m0s
[14:38:42.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:90:0)
[14:38:42.021] Timer tick, asking Buildbucket for the build status
[14:38:42.348] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:42.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:91:0) after 1m0s
[14:39:42.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:91:0)
[14:39:42.387] Timer tick, asking Buildbucket for the build status
[14:39:42.492] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:92:0) after 1m0s
[14:40:42.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:92:0)
[14:40:42.562] Timer tick, asking Buildbucket for the build status
[14:40:42.944] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:42.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:93:0) after 1m0s
[14:41:42.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:93:0)
[14:41:42.948] Timer tick, asking Buildbucket for the build status
[14:41:43.105] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:43.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:94:0) after 1m0s
[14:42:43.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:94:0)
[14:42:43.177] Timer tick, asking Buildbucket for the build status
[14:42:43.267] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:43.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:95:0) after 1m0s
[14:43:43.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:95:0)
[14:43:43.274] Timer tick, asking Buildbucket for the build status
[14:43:43.827] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:43.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:96:0) after 1m0s
[14:44:43.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:96:0)
[14:44:43.850] Timer tick, asking Buildbucket for the build status
[14:44:44.045] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:44.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:97:0) after 1m0s
[14:45:44.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:97:0)
[14:45:44.126] Timer tick, asking Buildbucket for the build status
[14:45:44.245] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:44.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:98:0) after 1m0s
[14:46:44.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:98:0)
[14:46:44.283] Timer tick, asking Buildbucket for the build status
[14:46:44.361] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:44.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:99:0) after 1m0s
[14:47:44.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:99:0)
[14:47:44.420] Timer tick, asking Buildbucket for the build status
[14:47:44.505] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:44.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:100:0) after 1m0s
[14:48:44.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:100:0)
[14:48:44.527] Timer tick, asking Buildbucket for the build status
[14:48:44.934] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:44.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:101:0) after 1m0s
[14:49:44.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:101:0)
[14:49:44.929] Timer tick, asking Buildbucket for the build status
[14:49:45.171] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:45.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:102:0) after 1m0s
[14:50:45.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:102:0)
[14:50:45.196] Timer tick, asking Buildbucket for the build status
[14:50:45.376] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:45.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:103:0) after 1m0s
[14:51:45.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:103:0)
[14:51:45.373] Timer tick, asking Buildbucket for the build status
[14:51:45.468] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:104:0) after 1m0s
[14:52:45.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:104:0)
[14:52:45.500] Timer tick, asking Buildbucket for the build status
[14:52:45.595] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:105:0) after 1m0s
[14:53:45.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:105:0)
[14:53:45.646] Timer tick, asking Buildbucket for the build status
[14:53:45.774] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:45.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:106:0) after 1m0s
[14:54:45.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:106:0)
[14:54:45.786] Timer tick, asking Buildbucket for the build status
[14:54:46.046] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:46.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:107:0) after 1m0s
[14:55:46.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:107:0)
[14:55:46.096] Timer tick, asking Buildbucket for the build status
[14:55:46.194] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:46.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:108:0) after 1m0s
[14:56:46.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:108:0)
[14:56:46.216] Timer tick, asking Buildbucket for the build status
[14:56:46.308] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:46.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:109:0) after 1m0s
[14:57:46.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:109:0)
[14:57:46.390] Timer tick, asking Buildbucket for the build status
[14:57:46.479] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:46.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:110:0) after 1m0s
[14:58:46.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:110:0)
[14:58:46.504] Timer tick, asking Buildbucket for the build status
[14:58:46.845] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:46.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:111:0) after 1m0s
[14:59:46.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:111:0)
[14:59:46.875] Timer tick, asking Buildbucket for the build status
[14:59:46.970] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:46.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:112:0) after 1m0s
[15:00:47.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:112:0)
[15:00:47.014] Timer tick, asking Buildbucket for the build status
[15:00:47.203] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:47.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:113:0) after 1m0s
[15:01:47.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:113:0)
[15:01:47.267] Timer tick, asking Buildbucket for the build status
[15:01:47.349] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:47.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:114:0) after 1m0s
[15:02:47.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:114:0)
[15:02:47.362] Timer tick, asking Buildbucket for the build status
[15:02:47.488] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:47.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:115:0) after 1m0s
[15:03:47.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:115:0)
[15:03:47.543] Timer tick, asking Buildbucket for the build status
[15:03:47.757] Build 8854411468769729136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:47.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019841530803360976:116:0) after 1m0s
[15:04:12.023] Received PubSub notification, asking Buildbucket for the build status
[15:04:12.121] Build 8854411468769729136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:04:12.121] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614179050436360",
"created_by": "project:chromium",
"created_ts": "1614172217549437",
"id": "8854411468769729136",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ca80a5770a02ac7301bf04a863ce86cb232622e\"}}",
"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\": \"7ca80a5770a02ac7301bf04a863ce86cb232622e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-76-83di\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22761, \"got_angle_revision\": \"d81e5d17b26ad7a401c764bacdfd96604eac8802\", \"got_dawn_revision\": \"d67544797e54d3866f378c2a7c05181db552f125\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7ca80a5770a02ac7301bf04a863ce86cb232622e\", \"got_revision_cp\": \"refs/heads/master@{#857133}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"27931735fc4450a71eacf39ce96e46f47e1c0acf\", \"got_v8_revision_cp\": \"refs/heads/9.0.252@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"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\": \"7ca80a5770a02ac7301bf04a863ce86cb232622e\", \"swarm_hashes_refs/heads/master(at){#857133}_without_patch\": {\"absl_hardening_tests\": \"2210c477b59111627740bdd94322dbc06a9dba18\", \"accessibility_unittests\": \"99a275956d3f02e97d5b1ba2989b7a2cfceef4dd\", \"angle_unittests\": \"2ca710c021a5bc19079eb48c9d3a6842d8b8f419\", \"app_list_unittests\": \"521b9448c1c9dc9fff361f335072b1577ec344f4\", \"app_shell_unittests\": \"e2b86e139e778e57fd516eec8b3b79a603faa7ac\", \"ash_unittests\": \"cea1ec28e2e2409f937e59b0d8dcbdbb3b68e8e5\", \"aura_unittests\": \"e1b4500301d4f799de7d99184fa7bf74ae8e23f4\", \"base_unittests\": \"f8242eb918467a8cdc436753c1b9b57d75d92b3b\", \"base_util_unittests\": \"4422b7297a1ad3eb00d575c5326be128d057167b\", \"blink_common_unittests\": \"2e06121fd5536a972baa12105938cd30cbab9fca\", \"blink_fuzzer_unittests\": \"6015c124acece55dd53b17dfaa845eed0f7d85e3\", \"blink_heap_unittests\": \"dddfcff1e23c298cb35014083ac6dc6334d82de4\", \"blink_platform_unittests\": \"d36fecc03b3d2afa302d250d4b28302e43b08f0f\", \"blink_unittests\": \"a7083d20afc350fff31285b4c414ddca25142704\", \"boringssl_crypto_tests\": \"e1517c0cbfda36aff6c0bf5b7ffb5bf6c364ca4e\", \"boringssl_ssl_tests\": \"2eec07889bfbec47d1ee4d8b01f6c9d03de5bb33\", \"browser_tests\": \"07042734f362757d5afd8bb87033a17d185ac71d\", \"capture_unittests\": \"91b9f8b28d43d21511eb369fc8071de2a7ca255f\", \"cast_unittests\": \"8cf96c5a942a6c4a4f5ed428cb0f614800d270e0\", \"cc_unittests\": \"9c7176a49ba3e525de5e7fe6148e6650d6bba576\", \"chrome_app_unittests\": \"2f2cc61e452c8b3b584c7f4b0d7ae4b5d0ddf3c9\", \"chromedriver_unittests\": \"eb6dfa65d233c34fd65f043703fc05224f45efc2\", \"chromeos_components_unittests\": \"157175eea7f13374cfcf834e74f249ede6d6eff9\", \"chromeos_unittests\": \"57c981c989cd6a1c2c7dd31adb6e6e39c9b7b8ee\", \"color_unittests\": \"84d08742bb35adf6ef0e406b3a8809648777ad62\", \"components_browsertests\": \"e5d46e58b6f7e27a943b1e2d7c71ae4b823a79b3\", \"components_unittests\": \"2e85b80cb2b717fc9204abff4386116145f1747e\", \"compositor_unittests\": \"f606e7e7cec5a602d8517bacf66ec1f9179c4914\", \"content_browsertests\": \"ef58b83de57b22b8b9369778a6793472cb9085b0\", \"content_unittests\": \"12e450f721223e6304d96e09bca70178a07f210c\", \"crashpad_tests\": \"d4f62d815b5bea358bc9ca1b7dd204dbfd9fd739\", \"crypto_unittests\": \"9b772977fa6139591c7036ae52a11b2072877c69\", \"dbus_unittests\": \"3f6908acb08528d1f5d60eee4c779b67a9b92169\", \"device_unittests\": \"1b9a2872a2e7e893c51e9459f4ceb6cb3a95e173\", \"display_unittests\": \"ddd2767e2a2f68812f791772d74c424dc011e3d3\", \"events_unittests\": \"98e6cef8d971f7214672e0e5213703bbd2a06ef2\", \"exo_unittests\": \"22a07310fdeff99ac98c5327d55989ec3700a297\", \"extensions_browsertests\": \"aa1a3c69dad68eeb02e6dd7689dbe351ed36f893\", \"extensions_unittests\": \"c72cb917aa6d67448b23794a894cdcd2eb86b666\", \"filesystem_service_unittests\": \"9afd307d86fffb97aa71336e1952e1cc318eea12\", \"gcm_unit_tests\": \"b7f3aff67cab2376afe75b402ca74cf518d43934\", \"gfx_unittests\": \"e7c9faf00973d7e40fcda60eb1afd06eaa7863ff\", \"gin_unittests\": \"874542eeb210cb8b3029727fb1b1279c2cd43ca3\", \"gl_unittests_ozone\": \"884a20ab430c35cb9031da09417a498d45912e46\", \"google_apis_unittests\": \"d96571de2419033050c4141d5b4b1792f0675559\", \"gpu_unittests\": \"ade7b1c5d5e78aebd34c54f9a0a73c256494d3cc\", \"gwp_asan_unittests\": \"1fd7ea5efcc68133ba51fb879bcf7e0191cb4363\", \"interactive_ui_tests\": \"7a18ea577bc7fc1719d7668210fab613710d118e\", \"ipc_tests\": \"f8d3cdbbc879d141e2d3c7697aeccf47e620411b\", \"jingle_unittests\": \"7b8fa2700de4369bb49a2e8895779bdf6ff7d467\", \"keyboard_unittests\": \"1c2a926f681b44087162d9eeadc44168770b8abc\", \"latency_unittests\": \"874fcfe6f082f19b74301868ec8d32c3074efc8c\", \"libjingle_xmpp_unittests\": \"270fe7e141cf23d6dbc563289c919af8b8e64064\", \"liburlpattern_unittests\": \"a556f158ae1c03d65da88c2fa23d3ece1eafd273\", \"media_blink_unittests\": \"2f33a62ad9fa7ce88f2443f9da1377f3b863d752\", \"media_unittests\": \"cc8146f28cc773d421f611a841a9dd8902c5b588\", \"message_center_unittests\": \"6e8169a0b3e61aaa062a4b2679302cb7fb1b6f75\", \"midi_unittests\": \"24c3c9746a1e8693126ec53f0b3be2b612e2d274\", \"mojo_core_unittests\": \"d4c46cff3bfb82cb08423a321de2f1e111b70c8f\", \"mojo_unittests\": \"182b25aa4c6a8a5765562668beac72dbbce6c8ba\", \"nacl_helper_nonsfi_unittests\": \"c4f511f516e6ecff219d5b237784a9b33db73d39\", \"nacl_loader_unittests\": \"8b6c5089259a568b24141b841eab0506e7c88667\", \"native_theme_unittests\": \"396bc2dc3f9cc4505c20e92234b573eb863bdd97\", \"net_unittests\": \"c7c020f06a2e547c3e0b921d6c79083934baf5e9\", \"ozone_gl_unittests\": \"beeca9286f0a3213b117d6122452f7b58f3811fa\", \"ozone_unittests\": \"79d89d6739e7b025069a6fc5f28baf3a1d718263\", \"ozone_x11_unittests\": \"7db91460c12cda61cd283cfe3af7d453aee9d718\", \"pdf_unittests\": \"a8da315fa840324fd58d8a31f26c17de77d62888\", \"perfetto_unittests\": \"cb9521ab1fbc64d266423b8ccc076dca083cb7cc\", \"ppapi_unittests\": \"a195b2a71a13d15b311239e114a2ffba3606f490\", \"printing_unittests\": \"c4de3fdc4a122fc478bef92ae7e71a88d7b8599e\", \"remoting_unittests\": \"ea43dfd58a9d2572b88f4c71ea8ec3be76a88546\", \"sandbox_linux_unittests\": \"471d95884ec5d2a97abcd6693834f4c605fa36db\", \"service_manager_unittests\": \"3eb2fc9ef52a0276d57ee2249391a43da7bca22d\", \"services_unittests\": \"f08572b33c4c9a825ccc78f81975d8b6ba3700dd\", \"shell_dialogs_unittests\": \"290345941a9bbe8b96a13ba47f75655385516bc1\", \"shell_encryption_unittests\": \"69af8547db90789da054212cd102c799a523de55\", \"skia_unittests\": \"3d84a6801860080154d54f842fcce579a65226f0\", \"snapshot_unittests\": \"0c616bedfa444d194b1a70e834cc901e7b2fe337\", \"sql_unittests\": \"c4f2a4bce342a4ff4192630baa065e348fa759de\", \"storage_unittests\": \"bd91717777aacc8e4664ae42cd7c4c3e196321bf\", \"sync_integration_tests\": \"3fc7b631f76f957f150dee5b45159b76140c6b4c\", \"traffic_annotation_auditor_unittests\": \"297ae08b25d40fbfbacf3ac04429c504add5be02\", \"ui_base_unittests\": \"c754ac9cde2162bb8a6b4d5e0f3b62d3ea41f4c9\", \"ui_chromeos_unittests\": \"78b128c3ad22cce0710051c842c7f633216d9e9d\", \"ui_touch_selection_unittests\": \"ec490b396f00870476a7477c9fd019921db419e5\", \"unit_tests\": \"05207fa85de57a5c69af7b3eab181a137ad96dfa\", \"url_unittests\": \"50df28ff9e5950fb0e34aa1a4b4db028df2bbd62\", \"usage_time_limit_unittests\": \"fd1ae18ebfd399a13bee839934680daee20f2cd5\", \"views_unittests\": \"7dd418d0a857eb96e758ebeed05072eeb46cb9a4\", \"viz_unittests\": \"a57feefeb53d1c498db047f6211e71087666e24d\", \"wm_unittests\": \"fcad46af0e8eeaafaccda0261b06f2344d30ae6b\", \"wtf_unittests\": \"4fdda1f735143924c41bae56080da568d756ee86\", \"zlib_unittests\": \"cd3c983a508f97c3e9e11bc7463dabeb34277c6a\"}}, \"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-east1-d-8-76-83di\"], \"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\": [\"5709-d3c4474\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614172398508688",
"status": "COMPLETED",
"status_changed_ts": "1614179050981088",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22761",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ca80a5770a02ac7301bf04a863ce86cb232622e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019841530803360976",
"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/8854411468769729136/+/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:51ecfaec35f5bd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614179050993820",
"url": "https://ci.chromium.org/b/8854411468769729136",
"utcnow_ts": "1614179052109005"
}
}
[15:04:12.121] Invocation finished in 1h53m55.894680445s with status SUCCEEDED