[04:52:16.579] New invocation is queued and will start shortly
[04:52:17.629] Starting the invocation (attempt 1)
[04:52:17.684] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:52:17.684] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:52:17.684] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9041163149013733904",
"parameters_json": "{\"builder_name\":\"Linux Viz\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"44afe2f10f47bce1475042016318252bc1fc971d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Viz",
"scheduler_invocation_id:9041163149013733904",
"scheduler_job_id:chromium/Linux Viz",
"user_agent:luci-scheduler",
"buildset:commit/git/44afe2f10f47bce1475042016318252bc1fc971d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/44afe2f10f47bce1475042016318252bc1fc971d",
"gitiles_ref:refs/heads/master"
]
}
[04:52:18.887] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1593838337787482",
"id": "8875733087074799888",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"44afe2f10f47bce1475042016318252bc1fc971d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1593838338614716",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/22866",
"builder:Linux Viz",
"buildset:commit/git/44afe2f10f47bce1475042016318252bc1fc971d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/44afe2f10f47bce1475042016318252bc1fc971d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041163149013733904",
"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/8875733087074799888/+/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": "1593838338614881",
"url": "https://ci.chromium.org/b/8875733087074799888",
"utcnow_ts": "1593838338876027"
}
}
[04:52:18.887] Task URL: https://ci.chromium.org/b/8875733087074799888
[04:52:18.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:2:0) after 1m0s
[04:53:18.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:2:0)
[04:53:18.963] Timer tick, asking Buildbucket for the build status
[04:53:19.213] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:19.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:3:0) after 1m0s
[04:54:19.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:3:0)
[04:54:19.317] Timer tick, asking Buildbucket for the build status
[04:54:19.494] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:19.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:4:0) after 1m0s
[04:55:19.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:4:0)
[04:55:19.560] Timer tick, asking Buildbucket for the build status
[04:55:19.689] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:19.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:5:0) after 1m0s
[04:56:19.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:5:0)
[04:56:19.787] Timer tick, asking Buildbucket for the build status
[04:56:20.045] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:20.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:6:0) after 1m0s
[04:57:20.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:6:0)
[04:57:20.091] Timer tick, asking Buildbucket for the build status
[04:57:20.211] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:20.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:7:0) after 1m0s
[04:58:20.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:7:0)
[04:58:20.323] Timer tick, asking Buildbucket for the build status
[04:58:20.471] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:20.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:8:0) after 1m0s
[04:59:20.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:8:0)
[04:59:20.501] Timer tick, asking Buildbucket for the build status
[04:59:20.847] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:20.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:9:0) after 1m0s
[05:00:20.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:9:0)
[05:00:20.915] Timer tick, asking Buildbucket for the build status
[05:00:22.282] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:22.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:10:0) after 1m0s
[05:01:22.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:10:0)
[05:01:22.351] Timer tick, asking Buildbucket for the build status
[05:01:22.530] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:22.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:11:0) after 1m0s
[05:02:22.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:11:0)
[05:02:22.588] Timer tick, asking Buildbucket for the build status
[05:02:22.716] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:22.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:12:0) after 1m0s
[05:03:22.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:12:0)
[05:03:22.703] Timer tick, asking Buildbucket for the build status
[05:03:23.096] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:13:0) after 1m0s
[05:04:23.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:13:0)
[05:04:23.148] Timer tick, asking Buildbucket for the build status
[05:04:23.273] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:23.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:14:0) after 1m0s
[05:05:23.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:14:0)
[05:05:23.329] Timer tick, asking Buildbucket for the build status
[05:05:23.819] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:23.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:15:0) after 1m0s
[05:06:23.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:15:0)
[05:06:23.940] Timer tick, asking Buildbucket for the build status
[05:06:24.105] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:24.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:16:0) after 1m0s
[05:07:24.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:16:0)
[05:07:24.153] Timer tick, asking Buildbucket for the build status
[05:07:24.434] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:24.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:17:0) after 1m0s
[05:08:24.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:17:0)
[05:08:24.489] Timer tick, asking Buildbucket for the build status
[05:08:24.651] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:24.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:18:0) after 1m0s
[05:09:24.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:18:0)
[05:09:24.683] Timer tick, asking Buildbucket for the build status
[05:09:25.077] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:25.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:19:0) after 1m0s
[05:10:25.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:19:0)
[05:10:25.143] Timer tick, asking Buildbucket for the build status
[05:10:25.365] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:25.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:20:0) after 1m0s
[05:11:25.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:20:0)
[05:11:25.485] Timer tick, asking Buildbucket for the build status
[05:11:25.711] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:25.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:21:0) after 1m0s
[05:12:25.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:21:0)
[05:12:25.806] Timer tick, asking Buildbucket for the build status
[05:12:25.979] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:25.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:22:0) after 1m0s
[05:13:26.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:22:0)
[05:13:26.015] Timer tick, asking Buildbucket for the build status
[05:13:26.114] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:26.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:23:0) after 1m0s
[05:14:26.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:23:0)
[05:14:26.134] Timer tick, asking Buildbucket for the build status
[05:14:26.595] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:26.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:24:0) after 1m0s
[05:15:26.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:24:0)
[05:15:26.594] Timer tick, asking Buildbucket for the build status
[05:15:26.820] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:26.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:25:0) after 1m0s
[05:16:26.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:25:0)
[05:16:26.842] Timer tick, asking Buildbucket for the build status
[05:16:26.942] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:26.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:26:0) after 1m0s
[05:17:27.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:26:0)
[05:17:27.014] Timer tick, asking Buildbucket for the build status
[05:17:27.194] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:27.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:27:0) after 1m0s
[05:18:27.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:27:0)
[05:18:27.217] Timer tick, asking Buildbucket for the build status
[05:18:27.317] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:27.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:28:0) after 1m0s
[05:19:27.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:28:0)
[05:19:27.432] Timer tick, asking Buildbucket for the build status
[05:19:27.549] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:27.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:29:0) after 1m0s
[05:20:27.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:29:0)
[05:20:27.694] Timer tick, asking Buildbucket for the build status
[05:20:28.081] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:28.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:30:0) after 1m0s
[05:21:28.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:30:0)
[05:21:28.105] Timer tick, asking Buildbucket for the build status
[05:21:28.477] Build 8875733087074799888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:28.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:31:0) after 1m0s
[05:21:47.280] Received PubSub notification, asking Buildbucket for the build status
[05:21:47.413] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:28.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:31:0)
[05:22:28.496] Timer tick, asking Buildbucket for the build status
[05:22:28.826] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:28.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:33:0) after 1m0s
[05:23:28.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:33:0)
[05:23:28.800] Timer tick, asking Buildbucket for the build status
[05:23:29.289] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:29.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:34:0) after 1m0s
[05:24:29.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:34:0)
[05:24:29.354] Timer tick, asking Buildbucket for the build status
[05:24:30.359] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:30.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:35:0) after 1m0s
[05:25:30.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:35:0)
[05:25:30.384] Timer tick, asking Buildbucket for the build status
[05:25:30.582] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:30.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:36:0) after 1m0s
[05:26:30.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:36:0)
[05:26:30.620] Timer tick, asking Buildbucket for the build status
[05:26:30.778] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:37:0) after 1m0s
[05:27:30.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:37:0)
[05:27:30.817] Timer tick, asking Buildbucket for the build status
[05:27:30.981] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:30.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:38:0) after 1m0s
[05:28:31.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:38:0)
[05:28:31.001] Timer tick, asking Buildbucket for the build status
[05:28:31.574] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:31.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:39:0) after 1m0s
[05:29:31.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:39:0)
[05:29:31.624] Timer tick, asking Buildbucket for the build status
[05:29:31.764] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:31.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:40:0) after 1m0s
[05:30:31.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:40:0)
[05:30:31.820] Timer tick, asking Buildbucket for the build status
[05:30:31.938] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:31.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:41:0) after 1m0s
[05:31:31.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:41:0)
[05:31:31.964] Timer tick, asking Buildbucket for the build status
[05:31:32.091] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:32.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:42:0) after 1m0s
[05:32:32.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:42:0)
[05:32:32.235] Timer tick, asking Buildbucket for the build status
[05:32:32.361] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:43:0) after 1m0s
[05:33:32.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:43:0)
[05:33:32.427] Timer tick, asking Buildbucket for the build status
[05:33:32.534] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:32.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:44:0) after 1m0s
[05:34:32.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:44:0)
[05:34:32.543] Timer tick, asking Buildbucket for the build status
[05:34:32.886] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:32.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:45:0) after 1m0s
[05:35:32.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:45:0)
[05:35:32.944] Timer tick, asking Buildbucket for the build status
[05:35:33.092] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:33.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:46:0) after 1m0s
[05:36:33.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:46:0)
[05:36:33.074] Timer tick, asking Buildbucket for the build status
[05:36:33.209] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:33.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:47:0) after 1m0s
[05:37:33.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:47:0)
[05:37:33.229] Timer tick, asking Buildbucket for the build status
[05:37:34.407] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:48:0) after 1m0s
[05:38:34.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:48:0)
[05:38:34.472] Timer tick, asking Buildbucket for the build status
[05:38:34.609] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:34.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:49:0) after 1m0s
[05:39:34.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:49:0)
[05:39:34.721] Timer tick, asking Buildbucket for the build status
[05:39:34.826] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:34.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:50:0) after 1m0s
[05:40:34.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:50:0)
[05:40:34.875] Timer tick, asking Buildbucket for the build status
[05:40:35.092] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:35.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:51:0) after 1m0s
[05:41:35.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:51:0)
[05:41:35.163] Timer tick, asking Buildbucket for the build status
[05:41:35.338] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:35.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:52:0) after 1m0s
[05:42:35.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:52:0)
[05:42:35.319] Timer tick, asking Buildbucket for the build status
[05:42:37.251] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:37.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:53:0) after 1m0s
[05:43:37.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:53:0)
[05:43:37.299] Timer tick, asking Buildbucket for the build status
[05:43:37.401] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:37.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:54:0) after 1m0s
[05:44:37.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:54:0)
[05:44:37.483] Timer tick, asking Buildbucket for the build status
[05:44:37.723] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:37.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:55:0) after 1m0s
[05:45:37.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:55:0)
[05:45:37.729] Timer tick, asking Buildbucket for the build status
[05:45:38.149] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:38.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:56:0) after 1m0s
[05:46:38.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:56:0)
[05:46:38.169] Timer tick, asking Buildbucket for the build status
[05:46:38.288] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:38.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:57:0) after 1m0s
[05:47:38.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:57:0)
[05:47:38.323] Timer tick, asking Buildbucket for the build status
[05:47:38.496] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:38.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:58:0) after 1m0s
[05:48:38.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:58:0)
[05:48:38.518] Timer tick, asking Buildbucket for the build status
[05:48:38.660] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:38.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:59:0) after 1m0s
[05:49:38.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:59:0)
[05:49:38.743] Timer tick, asking Buildbucket for the build status
[05:49:38.862] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:38.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:60:0) after 1m0s
[05:50:38.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:60:0)
[05:50:38.894] Timer tick, asking Buildbucket for the build status
[05:50:39.019] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:39.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:61:0) after 1m0s
[05:51:39.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:61:0)
[05:51:39.080] Timer tick, asking Buildbucket for the build status
[05:51:39.201] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:39.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:62:0) after 1m0s
[05:52:39.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:62:0)
[05:52:39.228] Timer tick, asking Buildbucket for the build status
[05:52:40.982] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:63:0) after 1m0s
[05:53:41.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:63:0)
[05:53:41.074] Timer tick, asking Buildbucket for the build status
[05:53:41.196] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:41.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:64:0) after 1m0s
[05:54:41.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:64:0)
[05:54:41.219] Timer tick, asking Buildbucket for the build status
[05:54:41.556] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:41.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:65:0) after 1m0s
[05:55:41.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:65:0)
[05:55:41.530] Timer tick, asking Buildbucket for the build status
[05:55:41.675] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:41.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:66:0) after 1m0s
[05:56:41.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:66:0)
[05:56:41.700] Timer tick, asking Buildbucket for the build status
[05:56:41.798] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:41.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:67:0) after 1m0s
[05:57:41.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:67:0)
[05:57:41.817] Timer tick, asking Buildbucket for the build status
[05:57:47.442] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:47.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:68:0) after 1m0s
[05:58:47.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:68:0)
[05:58:47.487] Timer tick, asking Buildbucket for the build status
[05:58:47.724] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:47.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:69:0) after 1m0s
[05:59:47.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:69:0)
[05:59:47.748] Timer tick, asking Buildbucket for the build status
[05:59:48.102] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:48.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:70:0) after 1m0s
[06:00:48.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:70:0)
[06:00:48.212] Timer tick, asking Buildbucket for the build status
[06:00:48.330] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:48.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:71:0) after 1m0s
[06:01:48.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:71:0)
[06:01:48.466] Timer tick, asking Buildbucket for the build status
[06:01:48.614] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:72:0) after 1m0s
[06:02:48.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:72:0)
[06:02:48.676] Timer tick, asking Buildbucket for the build status
[06:02:48.859] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:48.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:73:0) after 1m0s
[06:03:48.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:73:0)
[06:03:48.987] Timer tick, asking Buildbucket for the build status
[06:03:49.107] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:74:0) after 1m0s
[06:04:49.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:74:0)
[06:04:49.141] Timer tick, asking Buildbucket for the build status
[06:04:49.245] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:75:0) after 1m0s
[06:05:49.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:75:0)
[06:05:49.234] Timer tick, asking Buildbucket for the build status
[06:05:49.330] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:76:0) after 1m0s
[06:06:49.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:76:0)
[06:06:49.352] Timer tick, asking Buildbucket for the build status
[06:06:49.467] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:49.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:77:0) after 1m0s
[06:07:49.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:77:0)
[06:07:49.487] Timer tick, asking Buildbucket for the build status
[06:07:49.709] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:49.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:78:0) after 1m0s
[06:08:49.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:78:0)
[06:08:49.906] Timer tick, asking Buildbucket for the build status
[06:08:50.178] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:50.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:79:0) after 1m0s
[06:09:50.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:79:0)
[06:09:50.333] Timer tick, asking Buildbucket for the build status
[06:09:50.749] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:50.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:80:0) after 1m0s
[06:10:50.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:80:0)
[06:10:50.824] Timer tick, asking Buildbucket for the build status
[06:10:51.008] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:51.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:81:0) after 1m0s
[06:11:51.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:81:0)
[06:11:51.248] Timer tick, asking Buildbucket for the build status
[06:11:51.383] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:51.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:82:0) after 1m0s
[06:12:51.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:82:0)
[06:12:51.514] Timer tick, asking Buildbucket for the build status
[06:12:51.793] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:83:0) after 1m0s
[06:13:52.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:83:0)
[06:13:52.775] Timer tick, asking Buildbucket for the build status
[06:13:52.920] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:52.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:84:0) after 1m0s
[06:14:52.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:84:0)
[06:14:52.976] Timer tick, asking Buildbucket for the build status
[06:14:53.112] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:85:0) after 1m0s
[06:15:53.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:85:0)
[06:15:53.224] Timer tick, asking Buildbucket for the build status
[06:15:53.502] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:53.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:86:0) after 1m0s
[06:16:53.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:86:0)
[06:16:53.526] Timer tick, asking Buildbucket for the build status
[06:16:53.929] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:53.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:87:0) after 1m0s
[06:17:53.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:87:0)
[06:17:53.952] Timer tick, asking Buildbucket for the build status
[06:17:54.122] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:54.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:88:0) after 1m0s
[06:18:54.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:88:0)
[06:18:54.155] Timer tick, asking Buildbucket for the build status
[06:18:54.499] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:54.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:89:0) after 1m0s
[06:19:54.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:89:0)
[06:19:54.548] Timer tick, asking Buildbucket for the build status
[06:19:54.711] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:54.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:90:0) after 1m0s
[06:20:54.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:90:0)
[06:20:54.770] Timer tick, asking Buildbucket for the build status
[06:20:55.104] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:91:0) after 1m0s
[06:21:55.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:91:0)
[06:21:55.170] Timer tick, asking Buildbucket for the build status
[06:21:55.302] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:55.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:92:0) after 1m0s
[06:22:55.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:92:0)
[06:22:55.384] Timer tick, asking Buildbucket for the build status
[06:22:56.816] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:93:0) after 1m0s
[06:23:56.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:93:0)
[06:23:56.844] Timer tick, asking Buildbucket for the build status
[06:23:56.951] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:56.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:94:0) after 1m0s
[06:24:57.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:94:0)
[06:24:57.006] Timer tick, asking Buildbucket for the build status
[06:24:57.307] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:57.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:95:0) after 1m0s
[06:25:57.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:95:0)
[06:25:57.372] Timer tick, asking Buildbucket for the build status
[06:25:57.661] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:57.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:96:0) after 1m0s
[06:26:57.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:96:0)
[06:26:57.719] Timer tick, asking Buildbucket for the build status
[06:26:58.227] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:58.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:97:0) after 1m0s
[06:27:58.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:97:0)
[06:27:58.312] Timer tick, asking Buildbucket for the build status
[06:27:58.619] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:98:0) after 1m0s
[06:28:58.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:98:0)
[06:28:58.688] Timer tick, asking Buildbucket for the build status
[06:28:58.842] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:58.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:99:0) after 1m0s
[06:29:58.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:99:0)
[06:29:58.951] Timer tick, asking Buildbucket for the build status
[06:29:59.076] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:59.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:100:0) after 1m0s
[06:30:59.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:100:0)
[06:30:59.187] Timer tick, asking Buildbucket for the build status
[06:30:59.392] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:59.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:101:0) after 1m0s
[06:31:59.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:101:0)
[06:31:59.463] Timer tick, asking Buildbucket for the build status
[06:31:59.665] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:59.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:102:0) after 1m0s
[06:32:59.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:102:0)
[06:32:59.759] Timer tick, asking Buildbucket for the build status
[06:33:01.115] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:01.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:103:0) after 1m0s
[06:34:02.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:103:0)
[06:34:02.956] Timer tick, asking Buildbucket for the build status
[06:34:03.072] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:03.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:104:0) after 1m0s
[06:35:03.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:104:0)
[06:35:03.270] Timer tick, asking Buildbucket for the build status
[06:35:03.405] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:03.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:105:0) after 1m0s
[06:36:03.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:105:0)
[06:36:03.646] Timer tick, asking Buildbucket for the build status
[06:36:03.768] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:03.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:106:0) after 1m0s
[06:37:03.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:106:0)
[06:37:03.852] Timer tick, asking Buildbucket for the build status
[06:37:03.949] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:03.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:107:0) after 1m0s
[06:38:04.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:107:0)
[06:38:04.064] Timer tick, asking Buildbucket for the build status
[06:38:05.028] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:05.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:108:0) after 1m0s
[06:39:05.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:108:0)
[06:39:05.374] Timer tick, asking Buildbucket for the build status
[06:39:05.490] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:05.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:109:0) after 1m0s
[06:40:05.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:109:0)
[06:40:05.720] Timer tick, asking Buildbucket for the build status
[06:40:05.878] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:05.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:110:0) after 1m0s
[06:41:06.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:110:0)
[06:41:06.172] Timer tick, asking Buildbucket for the build status
[06:41:06.552] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:06.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:111:0) after 1m0s
[06:42:06.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:111:0)
[06:42:06.700] Timer tick, asking Buildbucket for the build status
[06:42:06.775] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:06.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:112:0) after 1m0s
[06:43:07.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:112:0)
[06:43:07.004] Timer tick, asking Buildbucket for the build status
[06:43:07.486] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:07.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:113:0) after 1m0s
[06:44:07.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:113:0)
[06:44:07.609] Timer tick, asking Buildbucket for the build status
[06:44:07.732] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:07.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:114:0) after 1m0s
[06:45:07.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:114:0)
[06:45:07.806] Timer tick, asking Buildbucket for the build status
[06:45:07.874] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:07.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:115:0) after 1m0s
[06:46:07.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:115:0)
[06:46:07.977] Timer tick, asking Buildbucket for the build status
[06:46:08.166] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:08.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:116:0) after 1m0s
[06:47:08.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:116:0)
[06:47:08.317] Timer tick, asking Buildbucket for the build status
[06:47:08.700] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:08.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:117:0) after 1m0s
[06:48:08.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:117:0)
[06:48:08.804] Timer tick, asking Buildbucket for the build status
[06:48:09.882] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:09.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:118:0) after 1m0s
[06:49:09.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:118:0)
[06:49:09.994] Timer tick, asking Buildbucket for the build status
[06:49:10.338] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:10.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:119:0) after 1m0s
[06:50:10.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:119:0)
[06:50:10.561] Timer tick, asking Buildbucket for the build status
[06:50:10.678] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:10.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:120:0) after 1m0s
[06:51:10.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:120:0)
[06:51:10.705] Timer tick, asking Buildbucket for the build status
[06:51:10.848] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:10.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:121:0) after 1m0s
[06:52:10.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:121:0)
[06:52:10.893] Timer tick, asking Buildbucket for the build status
[06:52:11.002] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:11.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:122:0) after 1m0s
[06:53:11.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:122:0)
[06:53:11.108] Timer tick, asking Buildbucket for the build status
[06:53:11.183] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:11.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:123:0) after 1m0s
[06:54:11.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:123:0)
[06:54:11.288] Timer tick, asking Buildbucket for the build status
[06:54:11.443] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:11.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:124:0) after 1m0s
[06:55:11.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:124:0)
[06:55:11.544] Timer tick, asking Buildbucket for the build status
[06:55:11.647] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:11.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:125:0) after 1m0s
[06:56:11.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:125:0)
[06:56:11.714] Timer tick, asking Buildbucket for the build status
[06:56:12.156] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:12.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:126:0) after 1m0s
[06:57:12.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:126:0)
[06:57:12.207] Timer tick, asking Buildbucket for the build status
[06:57:12.543] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:127:0) after 1m0s
[06:58:12.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:127:0)
[06:58:12.622] Timer tick, asking Buildbucket for the build status
[06:58:12.759] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:12.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:128:0) after 1m0s
[06:59:12.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:128:0)
[06:59:12.790] Timer tick, asking Buildbucket for the build status
[06:59:12.918] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:129:0) after 1m0s
[07:00:13.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:129:0)
[07:00:13.000] Timer tick, asking Buildbucket for the build status
[07:00:13.113] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:13.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:130:0) after 1m0s
[07:01:13.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:130:0)
[07:01:13.951] Timer tick, asking Buildbucket for the build status
[07:01:14.112] Build 8875733087074799888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:14.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:9041163149013733904:131:0) after 1m0s
[07:01:47.124] Received PubSub notification, asking Buildbucket for the build status
[07:01:47.218] Build 8875733087074799888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:01:47.218] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1593846106280781",
"created_by": "project:chromium",
"created_ts": "1593838337787482",
"id": "8875733087074799888",
"parameters_json": "{\"builder_name\": \"Linux Viz\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"44afe2f10f47bce1475042016318252bc1fc971d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-34-53p0\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Viz\", \"buildnumber\": 22866, \"got_angle_revision\": \"d38c75c5ea103067d9751d085de47c3c6774dd93\", \"got_dawn_revision\": \"59ccb1f6de17ac15a45374acd4cef997e190e8f8\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"44afe2f10f47bce1475042016318252bc1fc971d\", \"got_revision_cp\": \"refs/heads/master@{#785156}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"3121585acce20f5cc2074088563e3c1a076b8e48\", \"got_v8_revision\": \"aa548839b7dc2ce9b50d13ba4cbb80f62acfa9ac\", \"got_v8_revision_cp\": \"refs/heads/8.6.55@{#1}\", \"got_webrtc_revision\": \"62032d45924e9faeb27568009c83cc49ad068bd3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31628}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"44afe2f10f47bce1475042016318252bc1fc971d\", \"swarm_hashes\": {\"blink_web_tests\": \"e7415025e761f6d79da0ec207b73014d02329cb9\", \"browser_tests\": \"d85c9e1ef4780cdf378e2624434e0494f97aa7e3\", \"content_browsertests\": \"775ff22f6acdf40d042d80cc9ce7a296166763a0\"}, \"swarm_hashes_refs/heads/master(at){#785156}_without_patch\": {\"blink_web_tests\": \"e7415025e761f6d79da0ec207b73014d02329cb9\", \"browser_tests\": \"d85c9e1ef4780cdf378e2624434e0494f97aa7e3\", \"content_browsertests\": \"775ff22f6acdf40d042d80cc9ce7a296166763a0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fad31733c4a16cff8028666b237342064fde3326baa4b7f3c573ff92335076_v2\", \"builder_497278b5819f10111ab639898a894ad19d361b24d185228ca986cf767de7a7ef_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_75bb63162a23d4b1c0ff37321417ec47e6c57c7535580350abbb418df2b18732_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_eeb4aed1f5957a78d1f0fe1c00bdb778895591d08c1bb63c47ebb234324ef661_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-34-53p0\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1593840106246665",
"status": "COMPLETED",
"status_changed_ts": "1593846106714929",
"tags": [
"build_address:luci.chromium.ci/Linux Viz/22866",
"builder:Linux Viz",
"buildset:commit/git/44afe2f10f47bce1475042016318252bc1fc971d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/44afe2f10f47bce1475042016318252bc1fc971d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041163149013733904",
"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/8875733087074799888/+/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:4d30fc8c86925210",
"user_agent:luci-scheduler"
],
"updated_ts": "1593846106724664",
"url": "https://ci.chromium.org/b/8875733087074799888",
"utcnow_ts": "1593846107208491"
}
}
[07:01:47.218] Invocation finished in 2h9m30.663511075s with status SUCCEEDED