[20:19:39.431] New invocation is queued and will start shortly
[20:19:40.824] Starting the invocation (attempt 1)
[20:19:40.854] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8853f0ded32041f6379d0e531eb7e805175a7d8"
[20:19:40.855] Popped gitiles commit info from properties and tags
[20:19:40.855] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:19:40.855] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:19:40.855] Buildbucket request:
{
"requestId": "8951051418637352080",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8853f0ded32041f6379d0e531eb7e805175a7d8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951051418637352080"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win 10 Fast Ring"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:19:41.243] Scheduled build:
{
"id": "8785621356421171025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13249,
"createdBy": "project:chromium",
"createTime": "2023-03-25T20:19:40.918724166Z",
"updateTime": "2023-03-25T20:19:40.918724166Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8853f0ded32041f6379d0e531eb7e805175a7d8",
"ref": "refs/heads/main"
}
}
}
[20:19:41.243] Task URL: https://cr-buildbucket.appspot.com/build/8785621356421171025
[20:19:41.243] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:2:0) after 1m17s
[20:20:58.267] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:2:0)
[20:20:58.306] Build status: SCHEDULED
[20:20:58.306] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:3:0) after 6m8s
[20:27:06.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:3:0)
[20:27:06.622] Build status: SCHEDULED
[20:27:06.622] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:4:0) after 7m10s
[20:30:01.287] Received PubSub notification, asking Buildbucket for the build status
[20:30:01.307] Build status: STARTED
[20:34:16.652] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:4:0)
[20:34:16.682] Build status: STARTED
[20:34:16.682] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:6:0) after 2m21s
[20:36:37.853] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:6:0)
[20:36:37.879] Build status: STARTED
[20:36:37.879] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:7:0) after 3m24s
[20:40:01.901] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:7:0)
[20:40:01.921] Build status: STARTED
[20:40:01.921] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:8:0) after 5m8s
[20:45:10.163] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:8:0)
[20:45:10.184] Build status: STARTED
[20:45:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:9:0) after 5m30s
[20:50:40.406] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:9:0)
[20:50:40.435] Build status: STARTED
[20:50:40.435] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:10:0) after 3m8s
[20:53:48.675] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:10:0)
[20:53:48.708] Build status: STARTED
[20:53:48.708] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:11:0) after 3m30s
[20:57:18.715] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:11:0)
[20:57:18.751] Build status: STARTED
[20:57:18.751] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:12:0) after 9m9s
[21:06:27.752] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:12:0)
[21:06:27.778] Build status: STARTED
[21:06:27.778] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:13:0) after 3m32s
[21:10:00.085] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:13:0)
[21:10:00.153] Build status: STARTED
[21:10:00.153] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:14:0) after 6m16s
[21:16:16.359] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:14:0)
[21:16:16.383] Build status: STARTED
[21:16:16.383] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:15:0) after 3m31s
[21:19:47.454] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:15:0)
[21:19:47.474] Build status: STARTED
[21:19:47.474] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:16:0) after 1m35s
[21:21:22.492] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:16:0)
[21:21:22.521] Build status: STARTED
[21:21:22.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:17:0) after 7m54s
[21:29:16.538] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:17:0)
[21:29:16.556] Build status: STARTED
[21:29:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:18:0) after 8m39s
[21:37:55.709] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:18:0)
[21:37:55.730] Build status: STARTED
[21:37:55.730] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:19:0) after 5m11s
[21:43:06.977] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:19:0)
[21:43:07.003] Build status: STARTED
[21:43:07.003] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:20:0) after 6m32s
[21:49:39.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:20:0)
[21:49:39.192] Build status: STARTED
[21:49:39.192] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:21:0) after 2m2s
[21:51:41.209] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:21:0)
[21:51:41.231] Build status: STARTED
[21:51:41.231] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:22:0) after 7m7s
[21:58:48.250] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:22:0)
[21:58:48.273] Build status: STARTED
[21:58:48.273] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:23:0) after 1m43s
[22:00:31.301] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:23:0)
[22:00:31.333] Build status: STARTED
[22:00:31.333] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:24:0) after 9m42s
[22:10:13.591] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:24:0)
[22:10:13.619] Build status: STARTED
[22:10:13.619] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:25:0) after 5m2s
[22:15:15.641] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:25:0)
[22:15:15.663] Build status: STARTED
[22:15:15.663] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:26:0) after 4m21s
[22:19:36.686] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:26:0)
[22:19:36.705] Build status: STARTED
[22:19:36.705] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:27:0) after 7m48s
[22:27:24.741] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:27:0)
[22:27:24.763] Build status: STARTED
[22:27:24.763] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:28:0) after 7m57s
[22:35:21.889] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:28:0)
[22:35:21.910] Build status: STARTED
[22:35:21.910] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:29:0) after 7m50s
[22:43:11.929] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:29:0)
[22:43:11.955] Build status: STARTED
[22:43:11.955] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:30:0) after 4m3s
[22:47:14.973] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:30:0)
[22:47:14.991] Build status: STARTED
[22:47:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:31:0) after 6m44s
[22:53:59.079] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:31:0)
[22:53:59.101] Build status: STARTED
[22:53:59.101] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:32:0) after 1m0s
[22:54:59.118] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:32:0)
[22:54:59.141] Build status: STARTED
[22:54:59.141] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:33:0) after 7m8s
[23:02:07.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:33:0)
[23:02:07.190] Build status: STARTED
[23:02:07.190] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:34:0) after 6m27s
[23:08:34.308] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:34:0)
[23:08:34.329] Build status: STARTED
[23:08:34.329] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:35:0) after 2m9s
[23:10:43.356] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:35:0)
[23:10:43.376] Build status: STARTED
[23:10:43.376] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:36:0) after 2m23s
[23:13:06.690] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:36:0)
[23:13:06.717] Build status: STARTED
[23:13:06.717] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:37:0) after 5m10s
[23:18:17.349] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:37:0)
[23:18:17.378] Build status: STARTED
[23:18:17.378] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:38:0) after 9m54s
[23:28:11.401] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:38:0)
[23:28:11.428] Build status: STARTED
[23:28:11.428] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:39:0) after 8m29s
[23:36:40.447] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:39:0)
[23:36:40.469] Build status: STARTED
[23:36:40.469] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:40:0) after 3m45s
[23:40:25.989] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:40:0)
[23:40:26.013] Build status: STARTED
[23:40:26.013] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:41:0) after 2m55s
[23:43:21.230] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:41:0)
[23:43:21.262] Build status: STARTED
[23:43:21.262] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:42:0) after 8m52s
[23:52:13.970] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:42:0)
[23:52:13.999] Build status: STARTED
[23:52:13.999] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:43:0) after 6m20s
[23:58:34.570] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:43:0)
[23:58:34.616] Build status: STARTED
[23:58:34.616] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:44:0) after 2m11s
[00:00:46.607] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:44:0)
[00:00:46.633] Build status: STARTED
[00:00:46.633] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:45:0) after 5m55s
[00:06:41.667] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:45:0)
[00:06:41.695] Build status: STARTED
[00:06:41.695] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:46:0) after 3m37s
[00:10:18.836] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:46:0)
[00:10:18.863] Build status: STARTED
[00:10:18.863] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:47:0) after 2m17s
[00:12:36.365] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:47:0)
[00:12:36.402] Build status: STARTED
[00:12:36.402] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:48:0) after 6m17s
[00:18:54.494] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:48:0)
[00:18:54.524] Build status: STARTED
[00:18:54.524] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:49:0) after 9m9s
[00:28:03.564] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:49:0)
[00:28:03.600] Build status: STARTED
[00:28:03.600] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:50:0) after 1m25s
[00:29:28.580] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:50:0)
[00:29:28.602] Build status: STARTED
[00:29:28.602] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:51:0) after 2m46s
[00:32:14.621] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:51:0)
[00:32:14.659] Build status: STARTED
[00:32:14.659] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:52:0) after 4m15s
[00:36:30.188] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:52:0)
[00:36:30.209] Build status: STARTED
[00:36:30.209] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:53:0) after 8m27s
[00:44:57.227] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:53:0)
[00:44:57.248] Build status: STARTED
[00:44:57.248] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:54:0) after 3m2s
[00:47:59.268] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:54:0)
[00:47:59.287] Build status: STARTED
[00:47:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:55:0) after 6m6s
[00:54:05.305] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:55:0)
[00:54:05.330] Build status: STARTED
[00:54:05.330] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:56:0) after 5m51s
[00:59:58.174] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:56:0)
[00:59:58.197] Build status: STARTED
[00:59:58.197] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:57:0) after 8m46s
[01:08:44.219] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:57:0)
[01:08:44.238] Build status: STARTED
[01:08:44.238] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:58:0) after 6m31s
[01:15:15.326] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:58:0)
[01:15:15.351] Build status: STARTED
[01:15:15.351] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:59:0) after 3m49s
[01:19:04.479] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:59:0)
[01:19:04.541] Build status: STARTED
[01:19:04.541] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:60:0) after 8m0s
[01:27:04.638] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:60:0)
[01:27:04.783] Build status: STARTED
[01:27:04.783] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:61:0) after 7m12s
[01:34:16.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:61:0)
[01:34:16.830] Build status: STARTED
[01:34:16.830] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:62:0) after 4m18s
[01:38:34.850] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:62:0)
[01:38:34.871] Build status: STARTED
[01:38:34.871] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:63:0) after 2m28s
[01:41:02.935] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:63:0)
[01:41:02.966] Build status: STARTED
[01:41:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:64:0) after 8m10s
[01:49:12.990] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:64:0)
[01:49:13.025] Build status: STARTED
[01:49:13.025] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:65:0) after 2m22s
[01:51:35.139] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:65:0)
[01:51:35.160] Build status: STARTED
[01:51:35.160] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:66:0) after 7m59s
[01:59:34.365] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:66:0)
[01:59:34.401] Build status: STARTED
[01:59:34.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:67:0) after 6m10s
[02:05:44.435] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:67:0)
[02:05:44.458] Build status: STARTED
[02:05:44.458] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:68:0) after 8m26s
[02:14:10.493] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:68:0)
[02:14:10.526] Build status: STARTED
[02:14:10.526] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:69:0) after 4m13s
[02:18:23.506] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:69:0)
[02:18:23.550] Build status: STARTED
[02:18:23.550] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:70:0) after 5m58s
[02:24:21.974] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:70:0)
[02:24:22.014] Build status: STARTED
[02:24:22.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:71:0) after 4m26s
[02:28:48.557] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:71:0)
[02:28:48.578] Build status: STARTED
[02:28:48.578] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:72:0) after 7m34s
[02:36:22.606] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:72:0)
[02:36:22.629] Build status: STARTED
[02:36:22.629] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:73:0) after 3m28s
[02:39:50.660] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:73:0)
[02:39:50.684] Build status: STARTED
[02:39:50.684] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:74:0) after 3m58s
[02:43:48.711] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:74:0)
[02:43:48.734] Build status: STARTED
[02:43:48.734] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:75:0) after 3m51s
[02:47:39.838] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:75:0)
[02:47:39.874] Build status: STARTED
[02:47:39.874] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:76:0) after 6m28s
[02:54:07.993] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:76:0)
[02:54:08.022] Build status: STARTED
[02:54:08.022] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:77:0) after 3m2s
[02:57:10.240] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:77:0)
[02:57:10.272] Build status: STARTED
[02:57:10.273] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:78:0) after 8m46s
[03:05:56.304] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:78:0)
[03:05:56.337] Build status: STARTED
[03:05:56.337] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:79:0) after 6m7s
[03:12:03.361] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:79:0)
[03:12:03.382] Build status: STARTED
[03:12:03.382] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:80:0) after 1m52s
[03:13:55.400] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:80:0)
[03:13:55.423] Build status: STARTED
[03:13:55.423] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:81:0) after 1m38s
[03:15:33.400] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:81:0)
[03:15:33.426] Build status: STARTED
[03:15:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:82:0) after 7m11s
[03:22:44.426] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:82:0)
[03:22:44.458] Build status: STARTED
[03:22:44.458] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:83:0) after 1m13s
[03:23:57.476] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:83:0)
[03:23:57.496] Build status: STARTED
[03:23:57.496] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:84:0) after 6m41s
[03:30:38.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:84:0)
[03:30:38.900] Build status: STARTED
[03:30:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:85:0) after 2m5s
[03:32:43.922] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:85:0)
[03:32:43.942] Build status: STARTED
[03:32:43.942] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:86:0) after 6m6s
[03:38:49.964] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:86:0)
[03:38:49.993] Build status: STARTED
[03:38:49.993] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:87:0) after 1m15s
[03:40:05.115] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:87:0)
[03:40:05.138] Build status: STARTED
[03:40:05.138] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:88:0) after 1m54s
[03:41:59.156] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:88:0)
[03:41:59.179] Build status: STARTED
[03:41:59.179] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:89:0) after 7m12s
[03:49:11.251] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:89:0)
[03:49:11.345] Build status: STARTED
[03:49:11.345] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:90:0) after 3m55s
[03:53:06.366] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:90:0)
[03:53:06.435] Build status: STARTED
[03:53:06.435] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:91:0) after 5m23s
[03:58:29.458] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:91:0)
[03:58:29.479] Build status: STARTED
[03:58:29.479] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:92:0) after 1m39s
[04:00:08.500] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:92:0)
[04:00:08.576] Build status: STARTED
[04:00:08.576] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:93:0) after 4m23s
[04:04:31.670] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:93:0)
[04:04:31.713] Build status: STARTED
[04:04:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:94:0) after 7m1s
[04:11:32.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:94:0)
[04:11:32.796] Build status: STARTED
[04:11:32.796] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:95:0) after 8m38s
[04:20:10.997] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:95:0)
[04:20:11.027] Build status: STARTED
[04:20:11.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:96:0) after 3m34s
[04:23:45.012] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:96:0)
[04:23:45.034] Build status: STARTED
[04:23:45.034] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:97:0) after 5m16s
[04:29:01.039] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:97:0)
[04:29:01.062] Build status: STARTED
[04:29:01.062] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:98:0) after 9m55s
[04:38:56.670] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:98:0)
[04:38:56.688] Build status: STARTED
[04:38:56.688] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:99:0) after 9m1s
[04:47:58.099] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:99:0)
[04:47:58.119] Build status: STARTED
[04:47:58.119] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:100:0) after 4m55s
[04:52:53.363] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:100:0)
[04:52:53.393] Build status: STARTED
[04:52:53.393] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:101:0) after 9m12s
[05:02:06.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:101:0)
[05:02:06.193] Build status: STARTED
[05:02:06.193] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:102:0) after 1m14s
[05:03:20.217] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:102:0)
[05:03:20.240] Build status: STARTED
[05:03:20.240] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:103:0) after 8m34s
[05:11:54.383] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:103:0)
[05:11:54.463] Build status: STARTED
[05:11:54.463] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:104:0) after 2m4s
[05:13:58.497] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:104:0)
[05:13:58.550] Build status: STARTED
[05:13:58.550] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:105:0) after 9m54s
[05:23:52.572] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:105:0)
[05:23:52.596] Build status: STARTED
[05:23:52.596] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:106:0) after 7m28s
[05:31:20.658] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:106:0)
[05:31:20.731] Build status: STARTED
[05:31:20.731] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:107:0) after 9m28s
[05:40:48.753] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:107:0)
[05:40:48.775] Build status: STARTED
[05:40:48.775] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:108:0) after 4m29s
[05:45:17.811] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:108:0)
[05:45:17.830] Build status: STARTED
[05:45:17.830] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:109:0) after 3m4s
[05:48:21.981] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:109:0)
[05:48:22.005] Build status: STARTED
[05:48:22.005] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:110:0) after 5m49s
[05:54:11.057] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:110:0)
[05:54:11.079] Build status: STARTED
[05:54:11.079] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:111:0) after 4m27s
[05:58:38.101] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:111:0)
[05:58:38.122] Build status: STARTED
[05:58:38.122] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:112:0) after 9m57s
[06:08:35.211] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:112:0)
[06:08:35.232] Build status: STARTED
[06:08:35.232] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:113:0) after 1m3s
[06:09:38.396] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:113:0)
[06:09:38.418] Build status: STARTED
[06:09:38.418] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:114:0) after 4m5s
[06:13:43.444] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:114:0)
[06:13:43.463] Build status: STARTED
[06:13:43.463] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:115:0) after 7m39s
[06:21:22.486] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:115:0)
[06:21:22.508] Build status: STARTED
[06:21:22.508] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:116:0) after 3m51s
[06:25:13.482] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:116:0)
[06:25:13.529] Build status: STARTED
[06:25:13.529] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8951051418637352080:117:0) after 7m52s
[06:30:02.834] Received PubSub notification, asking Buildbucket for the build status
[06:30:02.869] Build:
{
"id": "8785621356421171025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13249,
"createdBy": "project:chromium",
"createTime": "2023-03-25T20:19:40.918724166Z",
"startTime": "2023-03-25T20:29:49.661595Z",
"endTime": "2023-03-26T06:30:02.533072560Z",
"updateTime": "2023-03-26T06:30:02.533072560Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8853f0ded32041f6379d0e531eb7e805175a7d8",
"ref": "refs/heads/main"
}
}
}
[06:30:02.869] Invocation finished in 10h10m23.447494448s with status ABORTED