[15:04:44.434] New invocation is queued and will start shortly
[15:04:45.536] Starting the invocation (attempt 1)
[15:04:45.566] Ignoring unrecognized buildset tag "buildset:commit/git/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c"
[15:04:45.566] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c"
[15:04:45.566] Popped gitiles commit info from properties and tags
[15:04:45.566] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:04:45.567] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:04:45.567] Buildbucket request:
{
"requestId": "9017660001788011376",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017660001788011376"
},
{
"key": "scheduler_job_id",
"value": "chromium/Windows deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:04:46.193] Scheduled build:
{
"id": "8852229939848535488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 18092,
"createdBy": "project:chromium",
"createTime": "2021-03-20T15:04:45.652874Z",
"updateTime": "2021-03-20T15:04:46.096706Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"ref": "refs/heads/master"
}
}
}
[15:04:46.193] Task URL: https://cr-buildbucket.appspot.com/build/8852229939848535488
[15:04:46.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:2:0) after 1m16s
[15:04:48.594] Received PubSub notification, asking Buildbucket for the build status
[15:04:48.727] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:02.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:2:0)
[15:06:02.348] Timer tick, asking Buildbucket for the build status
[15:06:02.414] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:02.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:4:0) after 1m0s
[15:07:02.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:4:0)
[15:07:02.434] Timer tick, asking Buildbucket for the build status
[15:07:02.502] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:02.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:5:0) after 1m0s
[15:08:02.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:5:0)
[15:08:02.614] Timer tick, asking Buildbucket for the build status
[15:08:02.675] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:02.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:6:0) after 1m0s
[15:09:02.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:6:0)
[15:09:02.695] Timer tick, asking Buildbucket for the build status
[15:09:02.767] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:02.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:7:0) after 1m0s
[15:10:02.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:7:0)
[15:10:02.953] Build status: STARTED
[15:10:02.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:8:0) after 2m42s
[15:12:45.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:8:0)
[15:12:45.068] Timer tick, asking Buildbucket for the build status
[15:12:45.158] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:45.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:9:0) after 1m0s
[15:13:45.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:9:0)
[15:13:45.293] Timer tick, asking Buildbucket for the build status
[15:13:45.377] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:45.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:10:0) after 1m0s
[15:14:45.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:10:0)
[15:14:45.706] Build status: STARTED
[15:14:45.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:11:0) after 1m22s
[15:16:07.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:11:0)
[15:16:07.691] Timer tick, asking Buildbucket for the build status
[15:16:07.772] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:07.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:12:0) after 1m0s
[15:17:07.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:12:0)
[15:17:07.864] Build status: STARTED
[15:17:07.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:13:0) after 9m43s
[15:26:50.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:13:0)
[15:26:50.912] Build status: STARTED
[15:26:50.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:14:0) after 6m36s
[15:33:26.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:14:0)
[15:33:26.929] Timer tick, asking Buildbucket for the build status
[15:33:27.183] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:27.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:15:0) after 1m0s
[15:34:27.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:15:0)
[15:34:27.204] Timer tick, asking Buildbucket for the build status
[15:34:27.492] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:27.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:16:0) after 1m0s
[15:35:27.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:16:0)
[15:35:27.499] Build status: STARTED
[15:35:27.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:17:0) after 6m56s
[15:42:24.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:17:0)
[15:42:24.074] Build status: STARTED
[15:42:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:18:0) after 3m25s
[15:45:55.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:18:0)
[15:45:55.071] Build status: STARTED
[15:45:55.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:19:0) after 3m41s
[15:49:36.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:19:0)
[15:49:36.174] Build status: STARTED
[15:49:36.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:20:0) after 5m41s
[15:55:17.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:20:0)
[15:55:17.309] Timer tick, asking Buildbucket for the build status
[15:55:17.521] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:17.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:21:0) after 1m0s
[15:56:17.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:21:0)
[15:56:17.540] Timer tick, asking Buildbucket for the build status
[15:56:17.630] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:17.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:22:0) after 1m0s
[15:57:17.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:22:0)
[15:57:17.671] Build status: STARTED
[15:57:17.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:23:0) after 9m29s
[16:06:46.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:23:0)
[16:06:46.714] Build status: STARTED
[16:06:46.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:24:0) after 3m4s
[16:09:50.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:24:0)
[16:09:50.742] Timer tick, asking Buildbucket for the build status
[16:09:50.970] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:50.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:25:0) after 1m0s
[16:10:50.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:25:0)
[16:10:50.992] Timer tick, asking Buildbucket for the build status
[16:10:51.061] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:51.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:26:0) after 1m0s
[16:11:51.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:26:0)
[16:11:51.176] Build status: STARTED
[16:11:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:27:0) after 9m59s
[16:21:50.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:27:0)
[16:21:50.193] Timer tick, asking Buildbucket for the build status
[16:21:50.425] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:50.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:28:0) after 1m0s
[16:22:50.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:28:0)
[16:22:50.433] Timer tick, asking Buildbucket for the build status
[16:22:50.559] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:50.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:29:0) after 1m0s
[16:23:50.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:29:0)
[16:23:50.756] Timer tick, asking Buildbucket for the build status
[16:23:50.894] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:50.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:30:0) after 1m0s
[16:24:50.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:30:0)
[16:24:50.921] Timer tick, asking Buildbucket for the build status
[16:24:51.088] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:51.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:31:0) after 1m0s
[16:25:51.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:31:0)
[16:25:51.467] Build status: STARTED
[16:25:51.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:32:0) after 3m45s
[16:29:36.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:32:0)
[16:29:36.628] Timer tick, asking Buildbucket for the build status
[16:29:36.712] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:36.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:33:0) after 1m0s
[16:30:36.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:33:0)
[16:30:36.887] Build status: STARTED
[16:30:36.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:34:0) after 1m50s
[16:32:26.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:34:0)
[16:32:26.910] Timer tick, asking Buildbucket for the build status
[16:32:27.166] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:27.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:35:0) after 1m0s
[16:33:27.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:35:0)
[16:33:27.316] Build status: STARTED
[16:33:27.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:36:0) after 3m36s
[16:37:03.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:36:0)
[16:37:03.361] Timer tick, asking Buildbucket for the build status
[16:37:03.587] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:03.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:37:0) after 1m0s
[16:38:03.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:37:0)
[16:38:03.693] Build status: STARTED
[16:38:03.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:38:0) after 6m10s
[16:44:13.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:38:0)
[16:44:13.747] Build status: STARTED
[16:44:13.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:39:0) after 5m16s
[16:49:29.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:39:0)
[16:49:29.766] Timer tick, asking Buildbucket for the build status
[16:49:29.909] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:29.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:40:0) after 1m0s
[16:50:29.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:40:0)
[16:50:30.005] Build status: STARTED
[16:50:30.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:41:0) after 9m45s
[17:00:15.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:41:0)
[17:00:15.095] Build status: STARTED
[17:00:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:42:0) after 3m23s
[17:03:38.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:42:0)
[17:03:38.188] Timer tick, asking Buildbucket for the build status
[17:03:38.311] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:38.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:43:0) after 1m0s
[17:04:38.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:43:0)
[17:04:38.425] Timer tick, asking Buildbucket for the build status
[17:04:38.518] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:38.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:44:0) after 1m0s
[17:05:38.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:44:0)
[17:05:38.609] Build status: STARTED
[17:05:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:45:0) after 4m44s
[17:10:22.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:45:0)
[17:10:22.686] Timer tick, asking Buildbucket for the build status
[17:10:23.206] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:23.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:46:0) after 1m0s
[17:11:23.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:46:0)
[17:11:23.380] Build status: STARTED
[17:11:23.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:47:0) after 5m45s
[17:17:08.490] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:47:0)
[17:17:08.490] Timer tick, asking Buildbucket for the build status
[17:17:08.759] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:08.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:48:0) after 1m0s
[17:18:08.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:48:0)
[17:18:08.926] Timer tick, asking Buildbucket for the build status
[17:18:09.189] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:09.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:49:0) after 1m0s
[17:19:09.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:49:0)
[17:19:09.254] Build status: STARTED
[17:19:09.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:50:0) after 2m13s
[17:21:22.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:50:0)
[17:21:22.286] Timer tick, asking Buildbucket for the build status
[17:21:22.413] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:22.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:51:0) after 1m0s
[17:22:22.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:51:0)
[17:22:22.474] Timer tick, asking Buildbucket for the build status
[17:22:22.548] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:22.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:52:0) after 1m0s
[17:23:22.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:52:0)
[17:23:22.630] Timer tick, asking Buildbucket for the build status
[17:23:22.771] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:22.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:53:0) after 1m0s
[17:24:23.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:53:0)
[17:24:23.107] Build status: STARTED
[17:24:23.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:54:0) after 9m45s
[17:34:08.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:54:0)
[17:34:08.159] Build status: STARTED
[17:34:08.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:55:0) after 4m2s
[17:38:10.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:55:0)
[17:38:10.221] Build status: STARTED
[17:38:10.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:56:0) after 7m58s
[17:46:08.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:56:0)
[17:46:08.289] Build status: STARTED
[17:46:08.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:57:0) after 2m6s
[17:48:14.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:57:0)
[17:48:14.336] Build status: STARTED
[17:48:14.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:58:0) after 7m39s
[17:55:53.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:58:0)
[17:55:53.480] Timer tick, asking Buildbucket for the build status
[17:55:53.684] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:53.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:59:0) after 1m0s
[17:56:53.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:59:0)
[17:56:53.714] Timer tick, asking Buildbucket for the build status
[17:56:53.965] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:53.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:60:0) after 1m0s
[17:57:53.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:60:0)
[17:57:53.987] Timer tick, asking Buildbucket for the build status
[17:57:54.375] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:54.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:61:0) after 1m0s
[17:58:54.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:61:0)
[17:58:54.507] Timer tick, asking Buildbucket for the build status
[17:58:54.668] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:54.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:62:0) after 1m0s
[17:59:54.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:62:0)
[17:59:54.685] Timer tick, asking Buildbucket for the build status
[17:59:54.749] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:54.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:63:0) after 1m0s
[18:00:54.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:63:0)
[18:00:54.772] Timer tick, asking Buildbucket for the build status
[18:00:54.894] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:54.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:64:0) after 1m0s
[18:01:56.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:64:0)
[18:01:56.897] Timer tick, asking Buildbucket for the build status
[18:01:57.025] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:57.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:65:0) after 1m0s
[18:02:57.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:65:0)
[18:02:57.268] Build status: STARTED
[18:02:57.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:66:0) after 7m23s
[18:10:20.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:66:0)
[18:10:20.319] Timer tick, asking Buildbucket for the build status
[18:10:20.424] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:20.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:67:0) after 1m0s
[18:11:20.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:67:0)
[18:11:20.605] Build status: STARTED
[18:11:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:68:0) after 4m2s
[18:15:22.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:68:0)
[18:15:22.862] Build status: STARTED
[18:15:22.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:69:0) after 4m45s
[18:20:07.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:69:0)
[18:20:07.903] Timer tick, asking Buildbucket for the build status
[18:20:08.080] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:08.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:70:0) after 1m0s
[18:21:08.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:70:0)
[18:21:08.110] Timer tick, asking Buildbucket for the build status
[18:21:08.180] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:08.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:71:0) after 1m0s
[18:22:08.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:71:0)
[18:22:08.212] Timer tick, asking Buildbucket for the build status
[18:22:08.369] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:72:0) after 1m0s
[18:23:08.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:72:0)
[18:23:08.402] Timer tick, asking Buildbucket for the build status
[18:23:08.493] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:73:0) after 1m0s
[18:24:08.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:73:0)
[18:24:08.541] Timer tick, asking Buildbucket for the build status
[18:24:08.613] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:08.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:74:0) after 1m0s
[18:25:08.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:74:0)
[18:25:08.744] Timer tick, asking Buildbucket for the build status
[18:25:09.011] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:09.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:75:0) after 1m0s
[18:26:09.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:75:0)
[18:26:09.162] Timer tick, asking Buildbucket for the build status
[18:26:09.246] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:09.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:76:0) after 1m0s
[18:27:09.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:76:0)
[18:27:09.266] Timer tick, asking Buildbucket for the build status
[18:27:09.356] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:09.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:77:0) after 1m0s
[18:28:09.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:77:0)
[18:28:09.397] Timer tick, asking Buildbucket for the build status
[18:28:09.490] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:09.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:78:0) after 1m0s
[18:29:09.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:78:0)
[18:29:09.520] Timer tick, asking Buildbucket for the build status
[18:29:09.701] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:79:0) after 1m0s
[18:30:09.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:79:0)
[18:30:09.752] Build status: STARTED
[18:30:09.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:80:0) after 7m6s
[18:37:15.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:80:0)
[18:37:15.778] Timer tick, asking Buildbucket for the build status
[18:37:16.052] Build 8852229939848535488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:16.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:81:0) after 1m0s
[18:38:16.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:81:0)
[18:38:16.100] Build status: STARTED
[18:38:16.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9017660001788011376:82:0) after 6m20s
[18:40:52.144] Received PubSub notification, asking Buildbucket for the build status
[18:40:52.173] Build:
{
"id": "8852229939848535488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 18092,
"createdBy": "project:chromium",
"createTime": "2021-03-20T15:04:45.652874Z",
"startTime": "2021-03-20T15:04:47.717960Z",
"endTime": "2021-03-20T18:40:51.472541Z",
"updateTime": "2021-03-20T18:40:51.867420Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8373ebc7eb9ca8fe3cd58af41c2f6d09cc5a081c",
"ref": "refs/heads/master"
}
}
}
[18:40:52.173] Invocation finished in 3h36m7.755035801s with status SUCCEEDED