[03:52:22.847] New invocation is queued and will start shortly
[03:52:23.933] Starting the invocation (attempt 1)
[03:52:23.968] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d4d684bb66f398b9be4b35e971098ca9aedb705"
[03:52:23.968] Popped gitiles commit info from properties and tags
[03:52:23.968] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:52:23.968] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:52:23.968] Buildbucket request:
{
"requestId": "8956277559789410544",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d4d684bb66f398b9be4b35e971098ca9aedb705",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956277559789410544"
},
{
"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"
}
}
[03:52:24.450] Scheduled build:
{
"id": "8790847497864252481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13112,
"createdBy": "project:chromium",
"createTime": "2023-01-27T03:52:24.050175716Z",
"updateTime": "2023-01-27T03:52:24.050175716Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d4d684bb66f398b9be4b35e971098ca9aedb705",
"ref": "refs/heads/main"
}
}
}
[03:52:24.450] Task URL: https://cr-buildbucket.appspot.com/build/8790847497864252481
[03:52:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:2:0) after 2m51s
[03:55:15.564] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:2:0)
[03:55:15.585] Build status: SCHEDULED
[03:55:15.586] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:3:0) after 9m8s
[03:57:41.766] Received PubSub notification, asking Buildbucket for the build status
[03:57:41.798] Build status: STARTED
[04:04:23.623] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:3:0)
[04:04:23.650] Build status: STARTED
[04:04:23.650] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:5:0) after 8m31s
[04:12:54.797] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:5:0)
[04:12:54.824] Build status: STARTED
[04:12:54.824] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:6:0) after 4m11s
[04:17:05.868] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:6:0)
[04:17:05.894] Build status: STARTED
[04:17:05.894] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:7:0) after 4m40s
[04:21:46.088] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:7:0)
[04:21:46.121] Build status: STARTED
[04:21:46.121] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:8:0) after 3m27s
[04:25:13.258] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:8:0)
[04:25:13.283] Build status: STARTED
[04:25:13.283] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:9:0) after 7m15s
[04:32:28.317] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:9:0)
[04:32:28.340] Build status: STARTED
[04:32:28.340] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:10:0) after 2m3s
[04:34:31.366] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:10:0)
[04:34:31.388] Build status: STARTED
[04:34:31.388] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:11:0) after 2m50s
[04:37:21.552] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:11:0)
[04:37:21.598] Build status: STARTED
[04:37:21.598] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:12:0) after 7m12s
[04:44:33.638] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:12:0)
[04:44:33.658] Build status: STARTED
[04:44:33.658] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:13:0) after 6m0s
[04:50:33.709] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:13:0)
[04:50:33.736] Build status: STARTED
[04:50:33.736] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:14:0) after 8m27s
[04:59:01.101] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:14:0)
[04:59:01.208] Build status: STARTED
[04:59:01.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:15:0) after 4m30s
[05:03:31.253] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:15:0)
[05:03:31.279] Build status: STARTED
[05:03:31.279] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:16:0) after 3m6s
[05:06:37.306] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:16:0)
[05:06:37.338] Build status: STARTED
[05:06:37.338] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:17:0) after 8m51s
[05:15:28.379] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:17:0)
[05:15:28.444] Build status: STARTED
[05:15:28.444] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:18:0) after 2m5s
[05:17:33.484] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:18:0)
[05:17:33.502] Build status: STARTED
[05:17:33.502] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:19:0) after 6m53s
[05:24:26.637] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:19:0)
[05:24:26.656] Build status: STARTED
[05:24:26.656] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:20:0) after 7m33s
[05:31:59.694] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:20:0)
[05:31:59.718] Build status: STARTED
[05:31:59.718] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:21:0) after 3m17s
[05:35:16.751] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:21:0)
[05:35:16.770] Build status: STARTED
[05:35:16.770] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:22:0) after 8m28s
[05:43:44.816] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:22:0)
[05:43:44.842] Build status: STARTED
[05:43:44.842] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:23:0) after 1m22s
[05:45:06.869] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:23:0)
[05:45:06.895] Build status: STARTED
[05:45:06.895] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:24:0) after 4m51s
[05:49:58.003] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:24:0)
[05:49:58.025] Build status: STARTED
[05:49:58.026] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:25:0) after 3m44s
[05:53:42.053] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:25:0)
[05:53:42.081] Build status: STARTED
[05:53:42.081] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:26:0) after 1m43s
[05:55:25.108] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:26:0)
[05:55:25.130] Build status: STARTED
[05:55:25.130] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:27:0) after 1m40s
[05:57:05.165] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:27:0)
[05:57:05.185] Build status: STARTED
[05:57:05.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:28:0) after 9m45s
[06:06:50.256] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:28:0)
[06:06:50.288] Build status: STARTED
[06:06:50.288] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:29:0) after 1m6s
[06:07:56.330] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:29:0)
[06:07:56.352] Build status: STARTED
[06:07:56.352] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:30:0) after 7m22s
[06:15:18.483] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:30:0)
[06:15:18.504] Build status: STARTED
[06:15:18.504] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:31:0) after 2m59s
[06:18:17.690] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:31:0)
[06:18:17.712] Build status: STARTED
[06:18:17.712] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:32:0) after 2m34s
[06:20:51.738] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:32:0)
[06:20:51.762] Build status: STARTED
[06:20:51.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:33:0) after 2m4s
[06:22:55.789] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:33:0)
[06:22:55.811] Build status: STARTED
[06:22:55.811] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:34:0) after 8m31s
[06:31:26.843] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:34:0)
[06:31:26.865] Build status: STARTED
[06:31:26.865] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:35:0) after 7m44s
[06:39:10.924] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:35:0)
[06:39:10.946] Build status: STARTED
[06:39:10.946] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:36:0) after 7m17s
[06:46:28.077] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:36:0)
[06:46:28.098] Build status: STARTED
[06:46:28.098] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:37:0) after 8m3s
[06:54:31.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:37:0)
[06:54:31.161] Build status: STARTED
[06:54:31.161] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:38:0) after 1m40s
[06:56:11.332] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:38:0)
[06:56:11.354] Build status: STARTED
[06:56:11.354] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:39:0) after 3m1s
[06:59:12.391] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:39:0)
[06:59:12.411] Build status: STARTED
[06:59:12.411] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:40:0) after 1m42s
[07:00:54.530] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:40:0)
[07:00:54.557] Build status: STARTED
[07:00:54.557] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:41:0) after 8m42s
[07:09:36.692] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:41:0)
[07:09:36.715] Build status: STARTED
[07:09:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:42:0) after 5m58s
[07:15:34.734] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:42:0)
[07:15:34.760] Build status: STARTED
[07:15:34.760] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:43:0) after 9m22s
[07:24:56.864] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:43:0)
[07:24:56.888] Build status: STARTED
[07:24:56.888] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:44:0) after 5m22s
[07:30:18.923] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:44:0)
[07:30:18.948] Build status: STARTED
[07:30:18.948] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:45:0) after 1m3s
[07:31:22.041] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:45:0)
[07:31:22.067] Build status: STARTED
[07:31:22.068] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:46:0) after 2m15s
[07:33:37.107] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:46:0)
[07:33:37.128] Build status: STARTED
[07:33:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:47:0) after 7m57s
[07:41:34.175] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:47:0)
[07:41:34.196] Build status: STARTED
[07:41:34.196] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:48:0) after 2m10s
[07:43:44.309] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:48:0)
[07:43:44.332] Build status: STARTED
[07:43:44.332] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:49:0) after 8m15s
[07:51:59.489] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:49:0)
[07:51:59.512] Build status: STARTED
[07:51:59.512] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:50:0) after 3m10s
[07:55:09.535] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:50:0)
[07:55:09.555] Build status: STARTED
[07:55:09.555] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:51:0) after 3m6s
[07:58:15.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:51:0)
[07:58:15.674] Build status: STARTED
[07:58:15.674] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:52:0) after 3m45s
[08:02:00.721] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:52:0)
[08:02:00.796] Build status: STARTED
[08:02:00.796] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:53:0) after 7m56s
[08:09:56.830] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:53:0)
[08:09:56.852] Build status: STARTED
[08:09:56.852] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:54:0) after 5m11s
[08:15:07.968] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:54:0)
[08:15:07.992] Build status: STARTED
[08:15:07.992] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:55:0) after 2m28s
[08:17:36.162] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:55:0)
[08:17:36.185] Build status: STARTED
[08:17:36.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:56:0) after 7m53s
[08:25:29.364] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:56:0)
[08:25:29.392] Build status: STARTED
[08:25:29.392] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:57:0) after 4m11s
[08:29:40.401] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:57:0)
[08:29:40.424] Build status: STARTED
[08:29:40.424] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:58:0) after 3m40s
[08:33:20.629] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:58:0)
[08:33:20.651] Build status: STARTED
[08:33:20.651] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:59:0) after 4m58s
[08:38:18.690] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:59:0)
[08:38:18.730] Build status: STARTED
[08:38:18.730] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:60:0) after 9m0s
[08:47:18.844] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:60:0)
[08:47:18.875] Build status: STARTED
[08:47:18.875] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:61:0) after 9m38s
[08:56:57.255] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:61:0)
[08:56:57.276] Build status: STARTED
[08:56:57.276] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:62:0) after 8m42s
[09:05:39.332] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:62:0)
[09:05:39.381] Build status: STARTED
[09:05:39.381] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:63:0) after 3m3s
[09:08:42.413] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:63:0)
[09:08:42.442] Build status: STARTED
[09:08:42.442] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:64:0) after 9m55s
[09:18:37.662] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:64:0)
[09:18:37.683] Build status: STARTED
[09:18:37.683] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:65:0) after 4m10s
[09:22:47.815] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:65:0)
[09:22:47.839] Build status: STARTED
[09:22:47.839] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:66:0) after 7m34s
[09:30:22.236] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:66:0)
[09:30:22.264] Build status: STARTED
[09:30:22.264] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:67:0) after 6m10s
[09:36:32.300] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:67:0)
[09:36:32.320] Build status: STARTED
[09:36:32.320] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:68:0) after 6m28s
[09:43:00.379] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:68:0)
[09:43:00.421] Build status: STARTED
[09:43:00.421] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:69:0) after 6m41s
[09:49:41.663] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:69:0)
[09:49:41.949] Build status: STARTED
[09:49:41.950] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:70:0) after 4m23s
[09:54:04.975] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:70:0)
[09:54:04.999] Build status: STARTED
[09:54:04.999] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:71:0) after 6m42s
[10:00:47.024] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:71:0)
[10:00:47.052] Build status: STARTED
[10:00:47.052] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:72:0) after 9m29s
[10:10:16.140] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:72:0)
[10:10:16.165] Build status: STARTED
[10:10:16.165] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:73:0) after 2m13s
[10:12:29.305] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:73:0)
[10:12:29.323] Build status: STARTED
[10:12:29.323] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:74:0) after 9m25s
[10:21:54.499] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:74:0)
[10:21:54.536] Build status: STARTED
[10:21:54.536] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:75:0) after 8m27s
[10:30:21.770] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:75:0)
[10:30:21.798] Build status: STARTED
[10:30:21.798] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:76:0) after 9m0s
[10:39:22.036] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:76:0)
[10:39:22.069] Build status: STARTED
[10:39:22.069] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:77:0) after 7m21s
[10:46:43.099] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:77:0)
[10:46:43.140] Build status: STARTED
[10:46:43.140] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:78:0) after 9m54s
[10:56:37.154] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:78:0)
[10:56:37.177] Build status: STARTED
[10:56:37.177] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:79:0) after 7m37s
[11:04:14.205] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:79:0)
[11:04:14.234] Build status: STARTED
[11:04:14.234] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:80:0) after 7m3s
[11:11:17.575] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:80:0)
[11:11:17.596] Build status: STARTED
[11:11:17.596] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:81:0) after 7m15s
[11:18:32.660] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:81:0)
[11:18:32.691] Build status: STARTED
[11:18:32.691] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:82:0) after 8m6s
[11:26:38.707] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:82:0)
[11:26:38.742] Build status: STARTED
[11:26:38.742] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:83:0) after 6m2s
[11:32:40.832] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:83:0)
[11:32:40.861] Build status: STARTED
[11:32:40.861] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:84:0) after 1m24s
[11:34:04.896] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:84:0)
[11:34:04.920] Build status: STARTED
[11:34:04.920] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:85:0) after 6m1s
[11:40:06.048] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:85:0)
[11:40:06.071] Build status: STARTED
[11:40:06.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:86:0) after 9m24s
[11:49:30.110] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:86:0)
[11:49:30.131] Build status: STARTED
[11:49:30.131] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:87:0) after 5m47s
[11:55:17.271] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:87:0)
[11:55:17.292] Build status: STARTED
[11:55:17.292] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:88:0) after 4m28s
[11:59:45.331] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:88:0)
[11:59:45.352] Build status: STARTED
[11:59:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:89:0) after 3m8s
[12:02:53.532] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:89:0)
[12:02:53.561] Build status: STARTED
[12:02:53.561] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:90:0) after 2m36s
[12:05:29.739] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:90:0)
[12:05:29.775] Build status: STARTED
[12:05:29.775] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:91:0) after 1m1s
[12:06:30.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:91:0)
[12:06:30.852] Build status: STARTED
[12:06:30.852] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:92:0) after 4m29s
[12:11:00.064] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:92:0)
[12:11:00.085] Build status: STARTED
[12:11:00.085] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:93:0) after 7m34s
[12:18:34.368] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:93:0)
[12:18:34.445] Build status: STARTED
[12:18:34.445] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:94:0) after 8m11s
[12:26:45.845] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:94:0)
[12:26:46.049] Build status: STARTED
[12:26:46.049] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:95:0) after 7m57s
[12:34:43.469] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:95:0)
[12:34:43.488] Build status: STARTED
[12:34:43.488] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:96:0) after 1m59s
[12:36:42.692] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:96:0)
[12:36:42.715] Build status: STARTED
[12:36:42.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:97:0) after 2m51s
[12:39:33.741] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:97:0)
[12:39:33.762] Build status: STARTED
[12:39:33.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:98:0) after 9m42s
[12:49:15.811] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:98:0)
[12:49:15.845] Build status: STARTED
[12:49:15.845] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:99:0) after 8m50s
[12:58:05.985] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:99:0)
[12:58:06.015] Build status: STARTED
[12:58:06.015] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:100:0) after 7m3s
[13:05:09.097] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:100:0)
[13:05:09.125] Build status: STARTED
[13:05:09.125] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:101:0) after 6m25s
[13:11:34.157] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:101:0)
[13:11:34.177] Build status: STARTED
[13:11:34.177] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:102:0) after 4m57s
[13:16:31.216] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:102:0)
[13:16:31.253] Build status: STARTED
[13:16:31.253] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:103:0) after 5m59s
[13:22:30.419] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:103:0)
[13:22:30.441] Build status: STARTED
[13:22:30.441] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:104:0) after 8m57s
[13:31:27.647] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:104:0)
[13:31:27.685] Build status: STARTED
[13:31:27.685] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:105:0) after 6m58s
[13:38:25.731] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:105:0)
[13:38:25.750] Build status: STARTED
[13:38:25.750] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:106:0) after 4m38s
[13:43:04.080] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:106:0)
[13:43:04.103] Build status: STARTED
[13:43:04.103] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:107:0) after 2m14s
[13:45:18.146] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:107:0)
[13:45:18.200] Build status: STARTED
[13:45:18.200] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:108:0) after 8m35s
[13:53:53.301] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:108:0)
[13:53:53.321] Build status: STARTED
[13:53:53.321] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:109:0) after 2m21s
[13:56:15.355] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:109:0)
[13:56:15.395] Build status: STARTED
[13:56:15.395] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956277559789410544:110:0) after 8m22s
[13:58:22.213] Received PubSub notification, asking Buildbucket for the build status
[13:58:22.240] Build:
{
"id": "8790847497864252481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13112,
"createdBy": "project:chromium",
"createTime": "2023-01-27T03:52:24.050175716Z",
"startTime": "2023-01-27T03:57:41.218107Z",
"endTime": "2023-01-27T13:58:18.635539592Z",
"updateTime": "2023-01-27T13:58:18.635539592Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d4d684bb66f398b9be4b35e971098ca9aedb705",
"ref": "refs/heads/main"
}
}
}
[13:58:22.240] Invocation finished in 10h5m59.409151599s with status ABORTED