[05:52:25.602] New invocation is queued and will start shortly
[05:52:26.725] Starting the invocation (attempt 1)
[05:52:26.758] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10a2d55093ad21f2c94206bf9e8ef3611b9cb875"
[05:52:26.758] Popped gitiles commit info from properties and tags
[05:52:26.758] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:52:26.758] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:52:26.759] Buildbucket request:
{
"requestId": "9017875944303520864",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "10a2d55093ad21f2c94206bf9e8ef3611b9cb875",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017875944303520864"
},
{
"key": "scheduler_job_id",
"value": "chromium/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:52:27.254] Scheduled build:
{
"id": "8852445882338889920",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-official"
},
"number": 1764,
"createdBy": "project:chromium",
"createTime": "2021-03-18T05:52:26.845806Z",
"updateTime": "2021-03-18T05:52:27.183564Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "10a2d55093ad21f2c94206bf9e8ef3611b9cb875",
"ref": "refs/heads/master"
}
}
}
[05:52:27.254] Task URL: https://cr-buildbucket.appspot.com/build/8852445882338889920
[05:52:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:2:0) after 9m1s
[05:52:30.529] Received PubSub notification, asking Buildbucket for the build status
[05:52:30.557] Build status: STARTED
[06:01:28.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:2:0)
[06:01:28.410] Timer tick, asking Buildbucket for the build status
[06:01:28.504] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:28.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:4:0) after 1m0s
[06:02:28.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:4:0)
[06:02:28.571] Build status: STARTED
[06:02:28.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:5:0) after 7m26s
[06:09:54.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:5:0)
[06:09:54.693] Build status: STARTED
[06:09:54.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:6:0) after 9m17s
[06:19:11.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:6:0)
[06:19:11.714] Timer tick, asking Buildbucket for the build status
[06:19:11.794] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:11.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:7:0) after 1m0s
[06:20:11.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:7:0)
[06:20:11.828] Timer tick, asking Buildbucket for the build status
[06:20:11.944] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:11.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:8:0) after 1m0s
[06:21:11.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:8:0)
[06:21:11.994] Build status: STARTED
[06:21:11.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:9:0) after 8m10s
[06:29:22.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:9:0)
[06:29:22.047] Timer tick, asking Buildbucket for the build status
[06:29:22.143] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:22.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:10:0) after 1m0s
[06:30:22.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:10:0)
[06:30:22.244] Timer tick, asking Buildbucket for the build status
[06:30:22.520] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:22.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:11:0) after 1m0s
[06:31:22.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:11:0)
[06:31:22.617] Timer tick, asking Buildbucket for the build status
[06:31:22.690] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:22.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:12:0) after 1m0s
[06:32:22.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:12:0)
[06:32:22.753] Build status: STARTED
[06:32:22.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:13:0) after 4m30s
[06:36:52.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:13:0)
[06:36:52.834] Timer tick, asking Buildbucket for the build status
[06:36:52.914] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:52.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:14:0) after 1m0s
[06:37:52.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:14:0)
[06:37:52.972] Timer tick, asking Buildbucket for the build status
[06:37:53.119] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:15:0) after 1m0s
[06:38:53.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:15:0)
[06:38:53.216] Timer tick, asking Buildbucket for the build status
[06:38:53.420] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:53.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:16:0) after 1m0s
[06:39:53.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:16:0)
[06:39:53.412] Timer tick, asking Buildbucket for the build status
[06:39:53.543] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:53.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:17:0) after 1m0s
[06:40:53.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:17:0)
[06:40:53.689] Build status: STARTED
[06:40:53.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:18:0) after 2m10s
[06:43:03.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:18:0)
[06:43:03.839] Build status: STARTED
[06:43:03.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:19:0) after 7m29s
[06:50:32.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:19:0)
[06:50:32.861] Timer tick, asking Buildbucket for the build status
[06:50:32.927] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:32.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:20:0) after 1m0s
[06:51:32.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:20:0)
[06:51:32.991] Build status: STARTED
[06:51:32.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:21:0) after 6m12s
[06:57:45.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:21:0)
[06:57:45.060] Timer tick, asking Buildbucket for the build status
[06:57:45.377] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:45.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:22:0) after 1m0s
[06:58:45.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:22:0)
[06:58:45.466] Build status: STARTED
[06:58:45.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:23:0) after 4m51s
[07:03:36.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:23:0)
[07:03:36.535] Timer tick, asking Buildbucket for the build status
[07:03:36.678] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:36.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:24:0) after 1m0s
[07:04:36.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:24:0)
[07:04:36.751] Timer tick, asking Buildbucket for the build status
[07:04:36.842] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:36.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:25:0) after 1m0s
[07:05:36.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:25:0)
[07:05:36.933] Build status: STARTED
[07:05:36.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:26:0) after 6m34s
[07:12:11.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:26:0)
[07:12:11.583] Timer tick, asking Buildbucket for the build status
[07:12:11.665] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:11.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:27:0) after 1m0s
[07:13:11.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:27:0)
[07:13:11.751] Timer tick, asking Buildbucket for the build status
[07:13:11.865] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:11.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:28:0) after 1m0s
[07:14:12.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:28:0)
[07:14:12.030] Timer tick, asking Buildbucket for the build status
[07:14:12.220] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:12.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:29:0) after 1m0s
[07:15:12.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:29:0)
[07:15:12.282] Timer tick, asking Buildbucket for the build status
[07:15:12.471] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:12.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:30:0) after 1m0s
[07:16:12.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:30:0)
[07:16:12.525] Timer tick, asking Buildbucket for the build status
[07:16:12.826] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:12.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:31:0) after 1m0s
[07:17:12.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:31:0)
[07:17:12.860] Timer tick, asking Buildbucket for the build status
[07:17:13.039] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:13.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:32:0) after 1m0s
[07:18:13.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:32:0)
[07:18:13.089] Timer tick, asking Buildbucket for the build status
[07:18:13.180] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:13.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:33:0) after 1m0s
[07:19:13.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:33:0)
[07:19:13.216] Timer tick, asking Buildbucket for the build status
[07:19:13.284] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:13.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:34:0) after 1m0s
[07:20:13.309] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:34:0)
[07:20:13.309] Timer tick, asking Buildbucket for the build status
[07:20:13.423] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:35:0) after 1m0s
[07:21:13.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:35:0)
[07:21:13.437] Timer tick, asking Buildbucket for the build status
[07:21:13.541] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:13.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:36:0) after 1m0s
[07:22:13.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:36:0)
[07:22:13.623] Timer tick, asking Buildbucket for the build status
[07:22:13.787] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:13.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:37:0) after 1m0s
[07:23:13.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:37:0)
[07:23:13.832] Timer tick, asking Buildbucket for the build status
[07:23:13.932] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:13.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:38:0) after 1m0s
[07:24:14.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:38:0)
[07:24:14.137] Timer tick, asking Buildbucket for the build status
[07:24:14.235] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:14.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:39:0) after 1m0s
[07:25:14.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:39:0)
[07:25:14.312] Timer tick, asking Buildbucket for the build status
[07:25:14.574] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:14.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:40:0) after 1m0s
[07:26:14.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:40:0)
[07:26:14.653] Timer tick, asking Buildbucket for the build status
[07:26:14.935] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:14.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:41:0) after 1m0s
[07:27:14.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:41:0)
[07:27:14.977] Timer tick, asking Buildbucket for the build status
[07:27:15.046] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:42:0) after 1m0s
[07:28:15.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:42:0)
[07:28:15.116] Timer tick, asking Buildbucket for the build status
[07:28:15.199] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:15.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:43:0) after 1m0s
[07:29:15.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:43:0)
[07:29:15.174] Timer tick, asking Buildbucket for the build status
[07:29:18.847] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:18.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:44:0) after 1m0s
[07:30:18.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:44:0)
[07:30:18.908] Timer tick, asking Buildbucket for the build status
[07:30:18.972] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:18.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:45:0) after 1m0s
[07:31:19.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:45:0)
[07:31:19.024] Timer tick, asking Buildbucket for the build status
[07:31:19.143] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:19.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:46:0) after 1m0s
[07:32:19.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:46:0)
[07:32:19.246] Timer tick, asking Buildbucket for the build status
[07:32:19.474] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:19.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:47:0) after 1m0s
[07:33:19.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:47:0)
[07:33:19.561] Timer tick, asking Buildbucket for the build status
[07:33:19.709] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:19.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:48:0) after 1m0s
[07:34:19.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:48:0)
[07:34:19.768] Timer tick, asking Buildbucket for the build status
[07:34:20.070] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:20.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:49:0) after 1m0s
[07:35:20.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:49:0)
[07:35:20.141] Timer tick, asking Buildbucket for the build status
[07:35:20.211] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:20.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:50:0) after 1m0s
[07:36:20.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:50:0)
[07:36:20.312] Timer tick, asking Buildbucket for the build status
[07:36:20.383] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:51:0) after 1m0s
[07:37:20.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:51:0)
[07:37:20.500] Timer tick, asking Buildbucket for the build status
[07:37:20.571] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:20.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:52:0) after 1m0s
[07:38:20.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:52:0)
[07:38:20.739] Timer tick, asking Buildbucket for the build status
[07:38:20.819] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:20.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:53:0) after 1m0s
[07:39:20.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:53:0)
[07:39:20.924] Timer tick, asking Buildbucket for the build status
[07:39:21.299] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:21.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:54:0) after 1m0s
[07:40:21.479] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:54:0)
[07:40:21.479] Timer tick, asking Buildbucket for the build status
[07:40:21.812] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:21.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:55:0) after 1m0s
[07:41:22.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:55:0)
[07:41:22.047] Timer tick, asking Buildbucket for the build status
[07:41:22.107] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:22.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:56:0) after 1m0s
[07:42:22.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:56:0)
[07:42:22.324] Timer tick, asking Buildbucket for the build status
[07:42:22.399] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:22.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:57:0) after 1m0s
[07:43:22.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:57:0)
[07:43:22.587] Timer tick, asking Buildbucket for the build status
[07:43:22.828] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:22.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:58:0) after 1m0s
[07:44:22.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:58:0)
[07:44:22.944] Timer tick, asking Buildbucket for the build status
[07:44:23.139] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:23.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:59:0) after 1m0s
[07:45:23.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:59:0)
[07:45:23.119] Timer tick, asking Buildbucket for the build status
[07:45:23.179] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:23.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:60:0) after 1m0s
[07:46:23.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:60:0)
[07:46:23.242] Timer tick, asking Buildbucket for the build status
[07:46:23.301] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:61:0) after 1m0s
[07:47:23.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:61:0)
[07:47:23.378] Timer tick, asking Buildbucket for the build status
[07:47:23.656] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:23.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:62:0) after 1m0s
[07:48:23.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:62:0)
[07:48:23.750] Timer tick, asking Buildbucket for the build status
[07:48:24.205] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:24.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:63:0) after 1m0s
[07:49:24.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:63:0)
[07:49:24.252] Timer tick, asking Buildbucket for the build status
[07:49:24.364] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:24.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:64:0) after 1m0s
[07:50:24.473] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:64:0)
[07:50:24.473] Timer tick, asking Buildbucket for the build status
[07:50:24.548] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:24.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:65:0) after 1m0s
[07:51:24.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:65:0)
[07:51:24.580] Timer tick, asking Buildbucket for the build status
[07:51:24.647] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:24.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:66:0) after 1m0s
[07:52:24.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:66:0)
[07:52:24.764] Timer tick, asking Buildbucket for the build status
[07:52:24.835] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:24.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:67:0) after 1m0s
[07:53:24.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:67:0)
[07:53:24.905] Timer tick, asking Buildbucket for the build status
[07:53:24.982] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:68:0) after 1m0s
[07:54:25.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:68:0)
[07:54:25.033] Timer tick, asking Buildbucket for the build status
[07:54:25.100] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:25.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:69:0) after 1m0s
[07:55:25.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:69:0)
[07:55:25.132] Timer tick, asking Buildbucket for the build status
[07:55:25.302] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:25.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:70:0) after 1m0s
[07:56:25.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:70:0)
[07:56:25.334] Timer tick, asking Buildbucket for the build status
[07:56:25.696] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:71:0) after 1m0s
[07:57:25.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:71:0)
[07:57:25.723] Timer tick, asking Buildbucket for the build status
[07:57:25.816] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:25.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:72:0) after 1m0s
[07:58:25.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:72:0)
[07:58:25.801] Timer tick, asking Buildbucket for the build status
[07:58:25.880] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:25.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:73:0) after 1m0s
[07:59:26.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:73:0)
[07:59:26.005] Timer tick, asking Buildbucket for the build status
[07:59:26.078] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:74:0) after 1m0s
[08:00:26.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:74:0)
[08:00:26.136] Timer tick, asking Buildbucket for the build status
[08:00:26.247] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:26.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:75:0) after 1m0s
[08:01:26.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:75:0)
[08:01:26.263] Timer tick, asking Buildbucket for the build status
[08:01:26.334] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:26.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:76:0) after 1m0s
[08:02:26.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:76:0)
[08:02:26.381] Timer tick, asking Buildbucket for the build status
[08:02:26.445] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:26.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:77:0) after 1m0s
[08:03:26.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:77:0)
[08:03:26.771] Timer tick, asking Buildbucket for the build status
[08:03:26.851] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:26.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:78:0) after 1m0s
[08:04:26.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:78:0)
[08:04:26.879] Timer tick, asking Buildbucket for the build status
[08:04:26.950] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:26.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:79:0) after 1m0s
[08:05:27.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:79:0)
[08:05:27.023] Timer tick, asking Buildbucket for the build status
[08:05:27.184] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:27.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:80:0) after 1m0s
[08:06:27.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:80:0)
[08:06:27.209] Timer tick, asking Buildbucket for the build status
[08:06:27.437] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:27.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:81:0) after 1m0s
[08:07:27.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:81:0)
[08:07:27.467] Timer tick, asking Buildbucket for the build status
[08:07:27.570] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:27.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:82:0) after 1m0s
[08:08:27.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:82:0)
[08:08:27.586] Timer tick, asking Buildbucket for the build status
[08:08:27.668] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:27.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:83:0) after 1m0s
[08:09:27.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:83:0)
[08:09:27.810] Timer tick, asking Buildbucket for the build status
[08:09:27.882] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:27.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:84:0) after 1m0s
[08:10:28.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:84:0)
[08:10:28.049] Timer tick, asking Buildbucket for the build status
[08:10:28.112] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:28.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:85:0) after 1m0s
[08:11:28.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:85:0)
[08:11:28.414] Timer tick, asking Buildbucket for the build status
[08:11:28.482] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:86:0) after 1m0s
[08:12:28.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:86:0)
[08:12:28.505] Timer tick, asking Buildbucket for the build status
[08:12:28.849] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:28.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:87:0) after 1m0s
[08:13:28.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:87:0)
[08:13:28.853] Timer tick, asking Buildbucket for the build status
[08:13:29.110] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:29.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:88:0) after 1m0s
[08:14:29.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:88:0)
[08:14:29.264] Timer tick, asking Buildbucket for the build status
[08:14:29.469] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:29.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:89:0) after 1m0s
[08:15:29.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:89:0)
[08:15:29.506] Timer tick, asking Buildbucket for the build status
[08:15:29.586] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:29.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:90:0) after 1m0s
[08:16:29.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:90:0)
[08:16:29.609] Timer tick, asking Buildbucket for the build status
[08:16:29.670] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:29.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:91:0) after 1m0s
[08:17:29.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:91:0)
[08:17:29.691] Timer tick, asking Buildbucket for the build status
[08:17:29.800] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:29.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:92:0) after 1m0s
[08:18:29.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:92:0)
[08:18:29.890] Timer tick, asking Buildbucket for the build status
[08:18:29.998] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:29.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:93:0) after 1m0s
[08:19:30.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:93:0)
[08:19:30.149] Timer tick, asking Buildbucket for the build status
[08:19:30.495] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:30.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:94:0) after 1m0s
[08:20:30.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:94:0)
[08:20:30.651] Timer tick, asking Buildbucket for the build status
[08:20:30.731] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:30.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:95:0) after 1m0s
[08:21:30.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:95:0)
[08:21:30.805] Timer tick, asking Buildbucket for the build status
[08:21:31.108] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:31.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:96:0) after 1m0s
[08:22:31.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:96:0)
[08:22:31.130] Timer tick, asking Buildbucket for the build status
[08:22:31.206] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:31.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:97:0) after 1m0s
[08:23:31.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:97:0)
[08:23:31.214] Timer tick, asking Buildbucket for the build status
[08:23:31.305] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:31.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:98:0) after 1m0s
[08:24:31.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:98:0)
[08:24:31.329] Timer tick, asking Buildbucket for the build status
[08:24:31.558] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:99:0) after 1m0s
[08:25:31.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:99:0)
[08:25:31.644] Timer tick, asking Buildbucket for the build status
[08:25:31.744] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:100:0) after 1m0s
[08:26:31.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:100:0)
[08:26:31.867] Timer tick, asking Buildbucket for the build status
[08:26:32.013] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:32.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:101:0) after 1m0s
[08:27:32.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:101:0)
[08:27:32.035] Timer tick, asking Buildbucket for the build status
[08:27:32.116] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:32.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:102:0) after 1m0s
[08:28:32.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:102:0)
[08:28:32.172] Timer tick, asking Buildbucket for the build status
[08:28:32.264] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:32.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:103:0) after 1m0s
[08:29:32.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:103:0)
[08:29:32.452] Timer tick, asking Buildbucket for the build status
[08:29:32.540] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:32.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:104:0) after 1m0s
[08:30:32.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:104:0)
[08:30:32.658] Timer tick, asking Buildbucket for the build status
[08:30:32.739] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:32.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:105:0) after 1m0s
[08:31:32.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:105:0)
[08:31:32.962] Timer tick, asking Buildbucket for the build status
[08:31:33.028] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:33.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:106:0) after 1m0s
[08:32:33.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:106:0)
[08:32:33.124] Timer tick, asking Buildbucket for the build status
[08:32:33.216] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:33.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:107:0) after 1m0s
[08:33:33.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:107:0)
[08:33:33.325] Timer tick, asking Buildbucket for the build status
[08:33:33.393] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:33.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:108:0) after 1m0s
[08:34:33.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:108:0)
[08:34:33.417] Timer tick, asking Buildbucket for the build status
[08:34:33.513] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:33.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:109:0) after 1m0s
[08:35:33.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:109:0)
[08:35:33.741] Timer tick, asking Buildbucket for the build status
[08:35:34.104] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:34.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:110:0) after 1m0s
[08:36:34.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:110:0)
[08:36:34.177] Timer tick, asking Buildbucket for the build status
[08:36:34.259] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:34.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:111:0) after 1m0s
[08:37:34.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:111:0)
[08:37:34.324] Timer tick, asking Buildbucket for the build status
[08:37:34.399] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:34.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:112:0) after 1m0s
[08:38:34.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:112:0)
[08:38:34.476] Timer tick, asking Buildbucket for the build status
[08:38:34.569] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:34.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:113:0) after 1m0s
[08:39:34.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:113:0)
[08:39:34.587] Timer tick, asking Buildbucket for the build status
[08:39:34.916] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:114:0) after 1m0s
[08:40:35.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:114:0)
[08:40:35.015] Timer tick, asking Buildbucket for the build status
[08:40:35.096] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:35.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:115:0) after 1m0s
[08:41:35.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:115:0)
[08:41:35.186] Timer tick, asking Buildbucket for the build status
[08:41:35.312] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:35.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:116:0) after 1m0s
[08:42:35.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:116:0)
[08:42:35.351] Timer tick, asking Buildbucket for the build status
[08:42:35.602] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:35.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:117:0) after 1m0s
[08:43:35.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:117:0)
[08:43:35.733] Timer tick, asking Buildbucket for the build status
[08:43:35.949] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:35.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:118:0) after 1m0s
[08:44:36.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:118:0)
[08:44:36.068] Timer tick, asking Buildbucket for the build status
[08:44:36.145] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:36.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:119:0) after 1m0s
[08:45:36.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:119:0)
[08:45:36.310] Timer tick, asking Buildbucket for the build status
[08:45:36.413] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:36.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:120:0) after 1m0s
[08:46:36.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:120:0)
[08:46:36.414] Timer tick, asking Buildbucket for the build status
[08:46:36.488] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:36.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:121:0) after 1m0s
[08:47:36.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:121:0)
[08:47:36.642] Timer tick, asking Buildbucket for the build status
[08:47:36.755] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:36.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:122:0) after 1m0s
[08:48:36.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:122:0)
[08:48:36.808] Timer tick, asking Buildbucket for the build status
[08:48:36.939] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:36.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:123:0) after 1m0s
[08:49:37.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:123:0)
[08:49:37.000] Timer tick, asking Buildbucket for the build status
[08:49:37.065] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:37.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:124:0) after 1m0s
[08:50:37.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:124:0)
[08:50:37.126] Timer tick, asking Buildbucket for the build status
[08:50:37.189] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:37.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:125:0) after 1m0s
[08:51:37.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:125:0)
[08:51:37.241] Timer tick, asking Buildbucket for the build status
[08:51:37.369] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:37.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:126:0) after 1m0s
[08:52:37.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:126:0)
[08:52:37.475] Timer tick, asking Buildbucket for the build status
[08:52:37.559] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:37.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:127:0) after 1m0s
[08:53:37.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:127:0)
[08:53:37.658] Timer tick, asking Buildbucket for the build status
[08:53:37.731] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:37.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:128:0) after 1m0s
[08:54:37.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:128:0)
[08:54:37.833] Timer tick, asking Buildbucket for the build status
[08:54:37.900] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:37.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:129:0) after 1m0s
[08:55:38.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:129:0)
[08:55:38.241] Timer tick, asking Buildbucket for the build status
[08:55:38.303] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:38.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:130:0) after 1m0s
[08:56:38.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:130:0)
[08:56:38.410] Timer tick, asking Buildbucket for the build status
[08:56:38.486] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:38.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:131:0) after 1m0s
[08:57:38.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:131:0)
[08:57:38.695] Timer tick, asking Buildbucket for the build status
[08:57:38.867] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:38.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:132:0) after 1m0s
[08:58:39.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:132:0)
[08:58:39.132] Timer tick, asking Buildbucket for the build status
[08:58:39.205] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:133:0) after 1m0s
[08:59:39.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:133:0)
[08:59:39.297] Timer tick, asking Buildbucket for the build status
[08:59:39.403] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:39.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:134:0) after 1m0s
[09:00:39.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:134:0)
[09:00:39.411] Timer tick, asking Buildbucket for the build status
[09:00:39.625] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:39.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:135:0) after 1m0s
[09:01:39.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:135:0)
[09:01:39.788] Timer tick, asking Buildbucket for the build status
[09:01:39.860] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:39.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:136:0) after 1m0s
[09:02:39.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:136:0)
[09:02:39.947] Timer tick, asking Buildbucket for the build status
[09:02:40.110] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:40.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:137:0) after 1m0s
[09:03:40.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:137:0)
[09:03:40.154] Timer tick, asking Buildbucket for the build status
[09:03:40.226] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:40.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:138:0) after 1m0s
[09:04:40.269] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:138:0)
[09:04:40.270] Timer tick, asking Buildbucket for the build status
[09:04:40.340] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:40.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:139:0) after 1m0s
[09:05:40.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:139:0)
[09:05:40.387] Timer tick, asking Buildbucket for the build status
[09:05:40.463] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:40.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:140:0) after 1m0s
[09:06:40.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:140:0)
[09:06:40.490] Timer tick, asking Buildbucket for the build status
[09:06:40.700] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:40.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:141:0) after 1m0s
[09:07:40.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:141:0)
[09:07:40.729] Timer tick, asking Buildbucket for the build status
[09:07:40.933] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:40.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:142:0) after 1m0s
[09:08:40.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:142:0)
[09:08:40.961] Timer tick, asking Buildbucket for the build status
[09:08:41.097] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:143:0) after 1m0s
[09:09:41.135] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:143:0)
[09:09:41.135] Timer tick, asking Buildbucket for the build status
[09:09:41.213] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:41.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:144:0) after 1m0s
[09:10:41.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:144:0)
[09:10:41.262] Timer tick, asking Buildbucket for the build status
[09:10:41.343] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:41.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:145:0) after 1m0s
[09:11:41.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:145:0)
[09:11:41.398] Timer tick, asking Buildbucket for the build status
[09:11:41.491] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:41.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:146:0) after 1m0s
[09:12:41.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:146:0)
[09:12:41.518] Timer tick, asking Buildbucket for the build status
[09:12:41.606] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:41.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:147:0) after 1m0s
[09:13:41.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:147:0)
[09:13:41.650] Timer tick, asking Buildbucket for the build status
[09:13:41.779] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:41.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:148:0) after 1m0s
[09:14:41.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:148:0)
[09:14:41.806] Timer tick, asking Buildbucket for the build status
[09:14:41.871] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:149:0) after 1m0s
[09:15:41.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:149:0)
[09:15:41.985] Timer tick, asking Buildbucket for the build status
[09:15:42.061] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:42.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:150:0) after 1m0s
[09:16:42.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:150:0)
[09:16:42.124] Timer tick, asking Buildbucket for the build status
[09:16:42.196] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:42.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:151:0) after 1m0s
[09:17:42.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:151:0)
[09:17:42.233] Timer tick, asking Buildbucket for the build status
[09:17:42.322] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:42.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:152:0) after 1m0s
[09:18:42.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:152:0)
[09:18:42.395] Timer tick, asking Buildbucket for the build status
[09:18:42.514] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:42.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:153:0) after 1m0s
[09:19:42.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:153:0)
[09:19:42.690] Timer tick, asking Buildbucket for the build status
[09:19:42.756] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:42.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:154:0) after 1m0s
[09:20:42.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:154:0)
[09:20:42.879] Timer tick, asking Buildbucket for the build status
[09:20:42.952] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:42.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:155:0) after 1m0s
[09:21:43.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:155:0)
[09:21:43.080] Timer tick, asking Buildbucket for the build status
[09:21:43.160] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:43.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:156:0) after 1m0s
[09:22:43.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:156:0)
[09:22:43.390] Timer tick, asking Buildbucket for the build status
[09:22:43.610] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:43.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:157:0) after 1m0s
[09:23:43.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:157:0)
[09:23:43.626] Timer tick, asking Buildbucket for the build status
[09:23:43.697] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:43.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:158:0) after 1m0s
[09:24:43.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:158:0)
[09:24:43.729] Timer tick, asking Buildbucket for the build status
[09:24:43.805] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:43.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:159:0) after 1m0s
[09:25:44.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:159:0)
[09:25:44.026] Timer tick, asking Buildbucket for the build status
[09:25:44.099] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:44.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:160:0) after 1m0s
[09:26:44.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:160:0)
[09:26:44.197] Timer tick, asking Buildbucket for the build status
[09:26:44.282] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:44.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:161:0) after 1m0s
[09:27:44.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:161:0)
[09:27:44.399] Timer tick, asking Buildbucket for the build status
[09:27:44.522] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:44.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:162:0) after 1m0s
[09:28:44.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:162:0)
[09:28:44.608] Timer tick, asking Buildbucket for the build status
[09:28:44.718] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:163:0) after 1m0s
[09:29:45.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:163:0)
[09:29:45.857] Timer tick, asking Buildbucket for the build status
[09:29:45.940] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:164:0) after 1m0s
[09:30:46.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:164:0)
[09:30:46.229] Timer tick, asking Buildbucket for the build status
[09:30:46.886] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:46.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:165:0) after 1m0s
[09:31:47.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:165:0)
[09:31:47.061] Timer tick, asking Buildbucket for the build status
[09:31:47.134] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:166:0) after 1m0s
[09:32:47.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:166:0)
[09:32:47.204] Timer tick, asking Buildbucket for the build status
[09:32:47.389] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:47.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:167:0) after 1m0s
[09:33:47.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:167:0)
[09:33:47.466] Timer tick, asking Buildbucket for the build status
[09:33:47.527] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:47.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:168:0) after 1m0s
[09:34:47.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:168:0)
[09:34:47.624] Timer tick, asking Buildbucket for the build status
[09:34:47.903] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:47.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:169:0) after 1m0s
[09:35:48.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:169:0)
[09:35:48.006] Timer tick, asking Buildbucket for the build status
[09:35:48.065] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:48.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:170:0) after 1m0s
[09:36:48.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:170:0)
[09:36:48.153] Timer tick, asking Buildbucket for the build status
[09:36:48.315] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:48.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:171:0) after 1m0s
[09:37:48.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:171:0)
[09:37:48.384] Timer tick, asking Buildbucket for the build status
[09:37:48.472] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:48.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:172:0) after 1m0s
[09:38:48.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:172:0)
[09:38:48.802] Timer tick, asking Buildbucket for the build status
[09:38:48.897] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:48.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:173:0) after 1m0s
[09:39:48.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:173:0)
[09:39:48.949] Timer tick, asking Buildbucket for the build status
[09:39:49.056] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:49.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:174:0) after 1m0s
[09:40:49.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:174:0)
[09:40:49.172] Timer tick, asking Buildbucket for the build status
[09:40:49.359] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:49.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:175:0) after 1m0s
[09:41:49.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:175:0)
[09:41:49.489] Timer tick, asking Buildbucket for the build status
[09:41:49.684] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:49.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:176:0) after 1m0s
[09:42:49.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:176:0)
[09:42:49.729] Timer tick, asking Buildbucket for the build status
[09:42:49.982] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:49.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:177:0) after 1m0s
[09:43:50.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:177:0)
[09:43:50.052] Timer tick, asking Buildbucket for the build status
[09:43:50.127] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:50.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:178:0) after 1m0s
[09:44:50.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:178:0)
[09:44:50.187] Timer tick, asking Buildbucket for the build status
[09:44:50.251] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:50.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:179:0) after 1m0s
[09:45:50.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:179:0)
[09:45:50.308] Timer tick, asking Buildbucket for the build status
[09:45:50.366] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:50.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:180:0) after 1m0s
[09:46:50.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:180:0)
[09:46:50.419] Timer tick, asking Buildbucket for the build status
[09:46:50.524] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:50.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:181:0) after 1m0s
[09:47:50.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:181:0)
[09:47:50.546] Timer tick, asking Buildbucket for the build status
[09:47:50.621] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:50.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:182:0) after 1m0s
[09:48:50.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:182:0)
[09:48:50.718] Timer tick, asking Buildbucket for the build status
[09:48:50.779] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:50.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:183:0) after 1m0s
[09:49:50.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:183:0)
[09:49:50.850] Timer tick, asking Buildbucket for the build status
[09:49:50.972] Build 8852445882338889920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:50.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9017875944303520864:184:0) after 1m0s
[09:50:45.567] Received PubSub notification, asking Buildbucket for the build status
[09:50:45.656] Build 8852445882338889920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:50:45.656] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616061044910156",
"created_by": "project:chromium",
"created_ts": "1616046746845806",
"id": "8852445882338889920",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {}}",
"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\": \"10a2d55093ad21f2c94206bf9e8ef3611b9cb875\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-4-8d4r\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1764, \"got_angle_revision\": \"bb7c1442587acf6bdee94f62f18d85e0485c3ab7\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"10a2d55093ad21f2c94206bf9e8ef3611b9cb875\", \"got_revision_cp\": \"refs/heads/master@{#864128}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"4f0f4e2a3c5ad9dc7312774da5197e0179c30863\", \"got_v8_revision_cp\": \"refs/heads/9.1.146@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-8d4r\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.13\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616046749714501",
"status": "COMPLETED",
"status_changed_ts": "1616061045277012",
"tags": [
"build_address:luci.chromium.ci/win-official/1764",
"builder:win-official",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10a2d55093ad21f2c94206bf9e8ef3611b9cb875",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017875944303520864",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852445882338889920/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:525cb5f94bc4e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1616061045280542",
"url": "https://ci.chromium.org/b/8852445882338889920",
"utcnow_ts": "1616061045645662"
}
}
[09:50:45.660] Invocation finished in 3h58m20.073194149s with status SUCCEEDED