[19:51:15.167] New invocation is queued and will start shortly
[19:51:16.454] Starting the invocation (attempt 1)
[19:51:16.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:51:16.556] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:51:16.556] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023893166679819696",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"46c21b6465c5941d6feaf9d7e335ea62610e5d25\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9023893166679819696",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"gitiles_ref:refs/heads/master"
]
}
[19:51:17.558] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610308276677945",
"id": "8858463104433547232",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46c21b6465c5941d6feaf9d7e335ea62610e5d25\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610308277344434",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/25810",
"builder:Linux Viz",
"buildset:commit/git/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023893166679819696",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858463104433547232/+/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": "1610308277344540",
"url": "https://ci.chromium.org/b/8858463104433547232",
"utcnow_ts": "1610308277551227"
}
}
[19:51:17.558] Task URL: https://ci.chromium.org/b/8858463104433547232
[19:51:17.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:2:0) after 1m0s
[19:52:17.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:2:0)
[19:52:17.653] Timer tick, asking Buildbucket for the build status
[19:52:17.795] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:17.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:3:0) after 1m0s
[19:53:17.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:3:0)
[19:53:17.917] Timer tick, asking Buildbucket for the build status
[19:53:18.177] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:18.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:4:0) after 1m0s
[19:54:18.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:4:0)
[19:54:18.244] Timer tick, asking Buildbucket for the build status
[19:54:18.503] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:18.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:5:0) after 1m0s
[19:55:18.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:5:0)
[19:55:18.624] Timer tick, asking Buildbucket for the build status
[19:55:18.733] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:18.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:6:0) after 1m0s
[19:56:18.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:6:0)
[19:56:18.850] Timer tick, asking Buildbucket for the build status
[19:56:19.000] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:19.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:7:0) after 1m0s
[19:57:18.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:7:0)
[19:57:18.988] Timer tick, asking Buildbucket for the build status
[19:57:19.128] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:19.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:8:0) after 1m0s
[19:58:19.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:8:0)
[19:58:19.117] Timer tick, asking Buildbucket for the build status
[19:58:19.202] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:19.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:9:0) after 1m0s
[19:59:19.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:9:0)
[19:59:19.286] Timer tick, asking Buildbucket for the build status
[19:59:19.584] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:19.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:10:0) after 1m0s
[20:00:19.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:10:0)
[20:00:19.624] Timer tick, asking Buildbucket for the build status
[20:00:19.809] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:19.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:11:0) after 1m0s
[20:01:19.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:11:0)
[20:01:19.879] Timer tick, asking Buildbucket for the build status
[20:01:19.979] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:19.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:12:0) after 1m0s
[20:02:20.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:12:0)
[20:02:20.046] Timer tick, asking Buildbucket for the build status
[20:02:20.289] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:20.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:13:0) after 1m0s
[20:03:20.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:13:0)
[20:03:20.368] Timer tick, asking Buildbucket for the build status
[20:03:20.624] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:20.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:14:0) after 1m0s
[20:04:20.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:14:0)
[20:04:20.664] Timer tick, asking Buildbucket for the build status
[20:04:20.747] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:20.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:15:0) after 1m0s
[20:05:20.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:15:0)
[20:05:20.824] Timer tick, asking Buildbucket for the build status
[20:05:20.906] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:20.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:16:0) after 1m0s
[20:06:20.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:16:0)
[20:06:20.912] Timer tick, asking Buildbucket for the build status
[20:06:21.049] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:21.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:17:0) after 1m0s
[20:07:21.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:17:0)
[20:07:21.194] Timer tick, asking Buildbucket for the build status
[20:07:21.288] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:21.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:18:0) after 1m0s
[20:08:21.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:18:0)
[20:08:21.310] Timer tick, asking Buildbucket for the build status
[20:08:21.408] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:21.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:19:0) after 1m0s
[20:09:21.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:19:0)
[20:09:21.414] Timer tick, asking Buildbucket for the build status
[20:09:21.507] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:21.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:20:0) after 1m0s
[20:10:21.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:20:0)
[20:10:21.587] Timer tick, asking Buildbucket for the build status
[20:10:21.663] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:21.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:21:0) after 1m0s
[20:11:21.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:21:0)
[20:11:21.759] Timer tick, asking Buildbucket for the build status
[20:11:21.848] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:21.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:22:0) after 1m0s
[20:12:21.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:22:0)
[20:12:21.876] Timer tick, asking Buildbucket for the build status
[20:12:21.947] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:21.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:23:0) after 1m0s
[20:13:21.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:23:0)
[20:13:21.999] Timer tick, asking Buildbucket for the build status
[20:13:22.117] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:22.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:24:0) after 1m0s
[20:14:22.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:24:0)
[20:14:22.400] Timer tick, asking Buildbucket for the build status
[20:14:22.536] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:22.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:25:0) after 1m0s
[20:15:27.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:25:0)
[20:15:27.407] Timer tick, asking Buildbucket for the build status
[20:15:27.491] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:27.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:26:0) after 1m0s
[20:16:27.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:26:0)
[20:16:27.531] Timer tick, asking Buildbucket for the build status
[20:16:27.661] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:27.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:27:0) after 1m0s
[20:17:27.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:27:0)
[20:17:27.807] Timer tick, asking Buildbucket for the build status
[20:17:27.892] Build 8858463104433547232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:27.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:28:0) after 1m0s
[20:17:57.456] Received PubSub notification, asking Buildbucket for the build status
[20:17:57.518] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:27.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:28:0)
[20:18:27.958] Timer tick, asking Buildbucket for the build status
[20:18:28.039] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:28.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:30:0) after 1m0s
[20:19:28.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:30:0)
[20:19:28.130] Timer tick, asking Buildbucket for the build status
[20:19:28.213] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:28.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:31:0) after 1m0s
[20:20:28.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:31:0)
[20:20:28.243] Timer tick, asking Buildbucket for the build status
[20:20:28.333] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:28.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:32:0) after 1m0s
[20:21:28.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:32:0)
[20:21:28.366] Timer tick, asking Buildbucket for the build status
[20:21:28.747] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:28.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:33:0) after 1m0s
[20:22:28.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:33:0)
[20:22:28.775] Timer tick, asking Buildbucket for the build status
[20:22:28.851] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:34:0) after 1m0s
[20:23:28.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:34:0)
[20:23:28.877] Timer tick, asking Buildbucket for the build status
[20:23:29.034] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:29.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:35:0) after 1m0s
[20:24:29.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:35:0)
[20:24:29.019] Timer tick, asking Buildbucket for the build status
[20:24:29.267] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:29.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:36:0) after 1m0s
[20:25:29.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:36:0)
[20:25:29.393] Timer tick, asking Buildbucket for the build status
[20:25:29.573] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:29.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:37:0) after 1m0s
[20:26:29.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:37:0)
[20:26:29.598] Timer tick, asking Buildbucket for the build status
[20:26:29.699] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:29.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:38:0) after 1m0s
[20:27:29.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:38:0)
[20:27:29.814] Timer tick, asking Buildbucket for the build status
[20:27:29.975] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:29.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:39:0) after 1m0s
[20:28:30.063] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:39:0)
[20:28:30.063] Timer tick, asking Buildbucket for the build status
[20:28:30.137] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:30.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:40:0) after 1m0s
[20:29:30.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:40:0)
[20:29:30.135] Timer tick, asking Buildbucket for the build status
[20:29:30.191] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:30.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:41:0) after 1m0s
[20:30:30.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:41:0)
[20:30:30.247] Timer tick, asking Buildbucket for the build status
[20:30:30.342] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:30.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:42:0) after 1m0s
[20:31:30.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:42:0)
[20:31:30.324] Timer tick, asking Buildbucket for the build status
[20:31:30.495] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:30.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:43:0) after 1m0s
[20:32:30.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:43:0)
[20:32:30.546] Timer tick, asking Buildbucket for the build status
[20:32:30.602] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:30.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:44:0) after 1m0s
[20:33:30.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:44:0)
[20:33:30.622] Timer tick, asking Buildbucket for the build status
[20:33:30.681] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:30.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:45:0) after 1m0s
[20:34:30.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:45:0)
[20:34:30.698] Timer tick, asking Buildbucket for the build status
[20:34:30.757] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:30.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:46:0) after 1m0s
[20:35:30.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:46:0)
[20:35:30.779] Timer tick, asking Buildbucket for the build status
[20:35:30.927] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:47:0) after 1m0s
[20:36:30.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:47:0)
[20:36:30.980] Timer tick, asking Buildbucket for the build status
[20:36:31.091] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:31.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:48:0) after 1m0s
[20:37:31.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:48:0)
[20:37:31.128] Timer tick, asking Buildbucket for the build status
[20:37:31.306] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:31.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:49:0) after 1m0s
[20:38:31.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:49:0)
[20:38:31.327] Timer tick, asking Buildbucket for the build status
[20:38:31.429] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:31.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:50:0) after 1m0s
[20:39:31.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:50:0)
[20:39:31.460] Timer tick, asking Buildbucket for the build status
[20:39:32.081] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:32.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:51:0) after 1m0s
[20:40:32.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:51:0)
[20:40:32.213] Timer tick, asking Buildbucket for the build status
[20:40:32.333] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:32.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:52:0) after 1m0s
[20:41:32.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:52:0)
[20:41:32.408] Timer tick, asking Buildbucket for the build status
[20:41:32.522] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:32.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:53:0) after 1m0s
[20:42:32.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:53:0)
[20:42:32.545] Timer tick, asking Buildbucket for the build status
[20:42:32.717] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:32.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:54:0) after 1m0s
[20:43:32.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:54:0)
[20:43:32.775] Timer tick, asking Buildbucket for the build status
[20:43:33.109] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:33.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:55:0) after 1m0s
[20:44:33.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:55:0)
[20:44:33.295] Timer tick, asking Buildbucket for the build status
[20:44:33.352] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:33.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:56:0) after 1m0s
[20:45:33.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:56:0)
[20:45:33.374] Timer tick, asking Buildbucket for the build status
[20:45:33.644] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:33.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:57:0) after 1m0s
[20:46:33.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:57:0)
[20:46:33.729] Timer tick, asking Buildbucket for the build status
[20:46:34.184] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:34.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:58:0) after 1m0s
[20:47:34.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:58:0)
[20:47:34.286] Timer tick, asking Buildbucket for the build status
[20:47:34.373] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:34.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:59:0) after 1m0s
[20:48:34.413] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:59:0)
[20:48:34.413] Timer tick, asking Buildbucket for the build status
[20:48:34.477] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:34.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:60:0) after 1m0s
[20:49:34.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:60:0)
[20:49:34.576] Timer tick, asking Buildbucket for the build status
[20:49:34.640] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:61:0) after 1m0s
[20:50:34.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:61:0)
[20:50:34.821] Timer tick, asking Buildbucket for the build status
[20:50:34.885] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:34.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:62:0) after 1m0s
[20:51:35.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:62:0)
[20:51:35.265] Timer tick, asking Buildbucket for the build status
[20:51:35.380] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:35.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:63:0) after 1m0s
[20:52:35.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:63:0)
[20:52:35.601] Timer tick, asking Buildbucket for the build status
[20:52:35.652] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:35.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:64:0) after 1m0s
[20:53:35.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:64:0)
[20:53:35.775] Timer tick, asking Buildbucket for the build status
[20:53:35.850] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:35.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:65:0) after 1m0s
[20:54:36.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:65:0)
[20:54:36.076] Timer tick, asking Buildbucket for the build status
[20:54:36.165] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:36.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:66:0) after 1m0s
[20:55:36.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:66:0)
[20:55:36.369] Timer tick, asking Buildbucket for the build status
[20:55:36.444] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:36.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:67:0) after 1m0s
[20:56:36.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:67:0)
[20:56:36.714] Timer tick, asking Buildbucket for the build status
[20:56:37.128] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:68:0) after 1m0s
[20:57:37.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:68:0)
[20:57:37.209] Timer tick, asking Buildbucket for the build status
[20:57:37.492] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:37.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:69:0) after 1m0s
[20:58:37.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:69:0)
[20:58:37.534] Timer tick, asking Buildbucket for the build status
[20:58:37.599] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:37.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:70:0) after 1m0s
[20:59:37.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:70:0)
[20:59:37.750] Timer tick, asking Buildbucket for the build status
[20:59:37.882] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:37.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:71:0) after 1m0s
[21:00:37.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:71:0)
[21:00:37.906] Timer tick, asking Buildbucket for the build status
[21:00:37.966] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:37.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:72:0) after 1m0s
[21:01:38.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:72:0)
[21:01:38.047] Timer tick, asking Buildbucket for the build status
[21:01:38.169] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:38.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:73:0) after 1m0s
[21:02:38.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:73:0)
[21:02:38.218] Timer tick, asking Buildbucket for the build status
[21:02:38.291] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:38.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:74:0) after 1m0s
[21:03:38.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:74:0)
[21:03:38.313] Timer tick, asking Buildbucket for the build status
[21:03:38.431] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:38.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:75:0) after 1m0s
[21:04:38.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:75:0)
[21:04:38.447] Timer tick, asking Buildbucket for the build status
[21:04:38.517] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:38.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:76:0) after 1m0s
[21:05:38.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:76:0)
[21:05:38.636] Timer tick, asking Buildbucket for the build status
[21:05:38.692] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:38.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:77:0) after 1m0s
[21:06:38.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:77:0)
[21:06:38.792] Timer tick, asking Buildbucket for the build status
[21:06:38.895] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:38.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:78:0) after 1m0s
[21:07:38.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:78:0)
[21:07:38.920] Timer tick, asking Buildbucket for the build status
[21:07:39.614] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:39.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:79:0) after 1m0s
[21:08:39.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:79:0)
[21:08:39.686] Timer tick, asking Buildbucket for the build status
[21:08:39.822] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:39.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:80:0) after 1m0s
[21:09:39.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:80:0)
[21:09:39.844] Timer tick, asking Buildbucket for the build status
[21:09:39.938] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:39.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:81:0) after 1m0s
[21:10:39.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:81:0)
[21:10:39.969] Timer tick, asking Buildbucket for the build status
[21:10:40.096] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:40.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:82:0) after 1m0s
[21:11:40.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:82:0)
[21:11:40.120] Timer tick, asking Buildbucket for the build status
[21:11:40.433] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:40.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:83:0) after 1m0s
[21:12:40.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:83:0)
[21:12:40.464] Timer tick, asking Buildbucket for the build status
[21:12:40.536] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:40.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:84:0) after 1m0s
[21:13:40.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:84:0)
[21:13:40.563] Timer tick, asking Buildbucket for the build status
[21:13:40.799] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:40.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:85:0) after 1m0s
[21:14:40.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:85:0)
[21:14:40.788] Timer tick, asking Buildbucket for the build status
[21:14:40.859] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:40.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:86:0) after 1m0s
[21:15:40.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:86:0)
[21:15:40.909] Timer tick, asking Buildbucket for the build status
[21:15:41.122] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:41.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:87:0) after 1m0s
[21:16:41.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:87:0)
[21:16:41.258] Timer tick, asking Buildbucket for the build status
[21:16:41.350] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:41.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:88:0) after 1m0s
[21:17:41.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:88:0)
[21:17:41.508] Timer tick, asking Buildbucket for the build status
[21:17:41.574] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:41.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:89:0) after 1m0s
[21:18:41.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:89:0)
[21:18:41.661] Timer tick, asking Buildbucket for the build status
[21:18:41.721] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:41.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:90:0) after 1m0s
[21:19:41.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:90:0)
[21:19:41.819] Timer tick, asking Buildbucket for the build status
[21:19:41.876] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:41.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:91:0) after 1m0s
[21:20:41.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:91:0)
[21:20:41.909] Timer tick, asking Buildbucket for the build status
[21:20:41.967] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:41.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:92:0) after 1m0s
[21:21:42.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:92:0)
[21:21:42.072] Timer tick, asking Buildbucket for the build status
[21:21:42.197] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:42.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:93:0) after 1m0s
[21:22:42.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:93:0)
[21:22:42.374] Timer tick, asking Buildbucket for the build status
[21:22:42.453] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:42.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:94:0) after 1m0s
[21:23:42.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:94:0)
[21:23:42.599] Timer tick, asking Buildbucket for the build status
[21:23:42.654] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:42.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:95:0) after 1m0s
[21:24:42.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:95:0)
[21:24:42.790] Timer tick, asking Buildbucket for the build status
[21:24:42.862] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:42.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:96:0) after 1m0s
[21:25:42.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:96:0)
[21:25:42.944] Timer tick, asking Buildbucket for the build status
[21:25:43.003] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:43.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:97:0) after 1m0s
[21:26:43.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:97:0)
[21:26:43.154] Timer tick, asking Buildbucket for the build status
[21:26:43.248] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:43.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:98:0) after 1m0s
[21:27:43.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:98:0)
[21:27:43.504] Timer tick, asking Buildbucket for the build status
[21:27:43.572] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:43.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:99:0) after 1m0s
[21:28:43.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:99:0)
[21:28:43.778] Timer tick, asking Buildbucket for the build status
[21:28:43.844] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:43.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:100:0) after 1m0s
[21:29:44.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:100:0)
[21:29:44.032] Timer tick, asking Buildbucket for the build status
[21:29:44.085] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:44.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:101:0) after 1m0s
[21:30:44.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:101:0)
[21:30:44.292] Timer tick, asking Buildbucket for the build status
[21:30:44.356] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:44.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:102:0) after 1m0s
[21:31:44.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:102:0)
[21:31:44.377] Timer tick, asking Buildbucket for the build status
[21:31:44.793] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:44.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:103:0) after 1m0s
[21:32:44.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:103:0)
[21:32:44.959] Timer tick, asking Buildbucket for the build status
[21:32:45.412] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:45.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:104:0) after 1m0s
[21:33:45.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:104:0)
[21:33:45.407] Timer tick, asking Buildbucket for the build status
[21:33:45.493] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:45.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:105:0) after 1m0s
[21:34:45.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:105:0)
[21:34:45.578] Timer tick, asking Buildbucket for the build status
[21:34:45.831] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:45.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:106:0) after 1m0s
[21:35:45.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:106:0)
[21:35:45.862] Timer tick, asking Buildbucket for the build status
[21:35:45.989] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:45.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:107:0) after 1m0s
[21:36:45.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:107:0)
[21:36:45.988] Timer tick, asking Buildbucket for the build status
[21:36:46.312] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:46.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:108:0) after 1m0s
[21:37:46.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:108:0)
[21:37:46.384] Timer tick, asking Buildbucket for the build status
[21:37:46.516] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:46.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:109:0) after 1m0s
[21:38:46.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:109:0)
[21:38:46.584] Timer tick, asking Buildbucket for the build status
[21:38:46.652] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:46.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:110:0) after 1m0s
[21:39:46.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:110:0)
[21:39:46.723] Timer tick, asking Buildbucket for the build status
[21:39:46.774] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:46.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:111:0) after 1m0s
[21:40:46.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:111:0)
[21:40:46.871] Timer tick, asking Buildbucket for the build status
[21:40:46.980] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:46.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:112:0) after 1m0s
[21:41:47.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:112:0)
[21:41:47.103] Timer tick, asking Buildbucket for the build status
[21:41:47.397] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:47.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:113:0) after 1m0s
[21:42:47.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:113:0)
[21:42:47.531] Timer tick, asking Buildbucket for the build status
[21:42:47.594] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:47.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:114:0) after 1m0s
[21:43:47.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:114:0)
[21:43:47.699] Timer tick, asking Buildbucket for the build status
[21:43:47.778] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:47.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:115:0) after 1m0s
[21:44:47.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:115:0)
[21:44:47.929] Timer tick, asking Buildbucket for the build status
[21:44:48.030] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:48.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:116:0) after 1m0s
[21:45:48.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:116:0)
[21:45:48.140] Timer tick, asking Buildbucket for the build status
[21:45:48.253] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:48.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:117:0) after 1m0s
[21:46:48.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:117:0)
[21:46:48.278] Timer tick, asking Buildbucket for the build status
[21:46:48.367] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:48.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:118:0) after 1m0s
[21:47:48.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:118:0)
[21:47:48.520] Timer tick, asking Buildbucket for the build status
[21:47:48.587] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:48.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:119:0) after 1m0s
[21:48:48.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:119:0)
[21:48:48.759] Timer tick, asking Buildbucket for the build status
[21:48:48.960] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:48.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:120:0) after 1m0s
[21:49:49.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:120:0)
[21:49:49.058] Timer tick, asking Buildbucket for the build status
[21:49:49.178] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:49.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:121:0) after 1m0s
[21:50:50.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:121:0)
[21:50:50.208] Timer tick, asking Buildbucket for the build status
[21:50:50.594] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:50.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:122:0) after 1m0s
[21:51:50.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:122:0)
[21:51:50.829] Timer tick, asking Buildbucket for the build status
[21:51:50.929] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:50.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:123:0) after 1m0s
[21:52:51.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:123:0)
[21:52:51.148] Timer tick, asking Buildbucket for the build status
[21:52:51.303] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:51.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:124:0) after 1m0s
[21:53:51.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:124:0)
[21:53:51.386] Timer tick, asking Buildbucket for the build status
[21:53:51.446] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:51.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:125:0) after 1m0s
[21:54:51.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:125:0)
[21:54:51.625] Timer tick, asking Buildbucket for the build status
[21:54:51.704] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:51.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:126:0) after 1m0s
[21:55:51.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:126:0)
[21:55:51.877] Timer tick, asking Buildbucket for the build status
[21:55:51.998] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:51.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:127:0) after 1m0s
[21:56:52.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:127:0)
[21:56:52.377] Timer tick, asking Buildbucket for the build status
[21:56:52.503] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:52.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:128:0) after 1m0s
[21:57:52.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:128:0)
[21:57:52.600] Timer tick, asking Buildbucket for the build status
[21:57:52.684] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:52.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:129:0) after 1m0s
[21:58:52.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:129:0)
[21:58:52.776] Timer tick, asking Buildbucket for the build status
[21:58:53.230] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:53.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:130:0) after 1m0s
[21:59:53.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:130:0)
[21:59:53.366] Timer tick, asking Buildbucket for the build status
[21:59:53.484] Build 8858463104433547232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:53.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9023893166679819696:131:0) after 1m0s
[21:59:59.175] Received PubSub notification, asking Buildbucket for the build status
[21:59:59.273] Build 8858463104433547232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:59:59.273] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610315998531845",
"created_by": "project:chromium",
"created_ts": "1610308276677945",
"id": "8858463104433547232",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46c21b6465c5941d6feaf9d7e335ea62610e5d25\"}}",
"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\": \"46c21b6465c5941d6feaf9d7e335ea62610e5d25\", \"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-96-4iyv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Linux Viz\", \"buildnumber\": 25810, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"46c21b6465c5941d6feaf9d7e335ea62610e5d25\", \"got_revision_cp\": \"refs/heads/master@{#841894}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"42082f9045e74e65b9e3a66b51093e0dc2f9375a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32929}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-viz-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46c21b6465c5941d6feaf9d7e335ea62610e5d25\", \"swarm_hashes_refs/heads/master(at){#841894}_without_patch\": {\"blink_web_tests\": \"a82624009b51f19a48b7780b7e31d0c6bab1cb4d\", \"browser_tests\": \"cf7c5076affdaa141a53725b707e4e17d852a155\", \"content_browsertests\": \"c751ba092a618e2d8aaa72d5404d35acbd6bca1f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_33498e86c0181efb6d75c3f73059d9522f6d5d2b3b1c7a2dc2a1c6b75cd205cd_v2\", \"builder_349e20fa0346c22afd9d85eafc166958d65f8d3eb174d2113a3f89c2e822dead_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_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-96-4iyv\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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": "1610309876701758",
"status": "COMPLETED",
"status_changed_ts": "1610315998918277",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/25810",
"builder:Linux Viz",
"buildset:commit/git/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46c21b6465c5941d6feaf9d7e335ea62610e5d25",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023893166679819696",
"scheduler_job_id:chromium/Linux Viz",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858463104433547232/+/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:5106abdfeed90310",
"user_agent:luci-scheduler"
],
"updated_ts": "1610315998923113",
"url": "https://ci.chromium.org/b/8858463104433547232",
"utcnow_ts": "1610315999266982"
}
}
[21:59:59.273] Invocation finished in 2h8m44.122316987s with status SUCCEEDED