[22:26:49.516] New invocation is queued and will start shortly
[22:26:50.610] Starting the invocation (attempt 1)
[22:26:50.661] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f778f05036b831c682166b59b8061f29a481ef17"
[22:26:50.661] Popped gitiles commit info from properties and tags
[22:26:50.661] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:26:50.661] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:26:50.661] Buildbucket request:
{
"requestId": "8964179978042585136",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f778f05036b831c682166b59b8061f29a481ef17",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8964179978042585136"
},
{
"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"
}
}
[22:26:51.343] Scheduled build:
{
"id": "8798749915978463105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11950,
"createdBy": "project:chromium",
"createTime": "2022-10-31T22:26:50.857564957Z",
"updateTime": "2022-10-31T22:26:50.857564957Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f778f05036b831c682166b59b8061f29a481ef17",
"ref": "refs/heads/main"
}
}
}
[22:26:51.343] Task URL: https://cr-buildbucket.appspot.com/build/8798749915978463105
[22:26:51.343] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:2:0) after 8m10s
[22:35:01.719] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:2:0)
[22:35:01.740] Build status: SCHEDULED
[22:35:01.740] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:3:0) after 3m33s
[22:35:54.209] Received PubSub notification, asking Buildbucket for the build status
[22:35:54.250] Build status: STARTED
[22:38:34.921] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:3:0)
[22:38:34.940] Build status: STARTED
[22:38:34.940] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:5:0) after 5m26s
[22:44:00.968] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:5:0)
[22:44:00.995] Build status: STARTED
[22:44:00.995] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:6:0) after 8m57s
[22:52:58.031] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:6:0)
[22:52:58.056] Build status: STARTED
[22:52:58.056] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:7:0) after 9m25s
[23:02:23.218] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:7:0)
[23:02:23.241] Build status: STARTED
[23:02:23.241] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:8:0) after 4m59s
[23:07:22.270] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:8:0)
[23:07:22.314] Build status: STARTED
[23:07:22.314] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:9:0) after 9m30s
[23:16:52.342] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:9:0)
[23:16:52.419] Build status: STARTED
[23:16:52.419] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:10:0) after 4m14s
[23:21:06.501] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:10:0)
[23:21:06.525] Build status: STARTED
[23:21:06.525] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:11:0) after 2m31s
[23:23:37.554] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:11:0)
[23:23:37.579] Build status: STARTED
[23:23:37.579] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:12:0) after 2m27s
[23:26:04.714] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:12:0)
[23:26:04.745] Build status: STARTED
[23:26:04.745] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:13:0) after 7m27s
[23:33:31.877] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:13:0)
[23:33:31.903] Build status: STARTED
[23:33:31.903] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:14:0) after 1m14s
[23:34:45.969] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:14:0)
[23:34:45.991] Build status: STARTED
[23:34:45.991] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:15:0) after 3m4s
[23:37:50.361] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:15:0)
[23:37:50.385] Build status: STARTED
[23:37:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:16:0) after 1m29s
[23:39:19.419] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:16:0)
[23:39:19.445] Build status: STARTED
[23:39:19.446] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:17:0) after 4m53s
[23:44:12.579] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:17:0)
[23:44:12.605] Build status: STARTED
[23:44:12.605] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:18:0) after 7m50s
[23:52:02.976] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:18:0)
[23:52:02.999] Build status: STARTED
[23:52:02.999] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:19:0) after 9m2s
[00:01:04.985] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:19:0)
[00:01:05.013] Build status: STARTED
[00:01:05.013] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:20:0) after 5m7s
[00:06:12.046] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:20:0)
[00:06:12.071] Build status: STARTED
[00:06:12.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:21:0) after 3m17s
[00:09:29.551] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:21:0)
[00:09:29.578] Build status: STARTED
[00:09:29.578] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:22:0) after 1m57s
[00:11:26.635] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:22:0)
[00:11:26.661] Build status: STARTED
[00:11:26.661] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:23:0) after 5m13s
[00:16:39.883] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:23:0)
[00:16:39.915] Build status: STARTED
[00:16:39.915] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:24:0) after 8m16s
[00:24:56.287] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:24:0)
[00:24:56.312] Build status: STARTED
[00:24:56.312] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:25:0) after 4m5s
[00:29:01.455] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:25:0)
[00:29:01.479] Build status: STARTED
[00:29:01.479] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:26:0) after 7m56s
[00:36:57.541] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:26:0)
[00:36:57.571] Build status: STARTED
[00:36:57.571] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:27:0) after 2m11s
[00:39:08.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:27:0)
[00:39:08.582] Build status: STARTED
[00:39:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:28:0) after 2m24s
[00:41:32.621] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:28:0)
[00:41:32.651] Build status: STARTED
[00:41:32.651] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:29:0) after 7m13s
[00:48:45.820] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:29:0)
[00:48:45.843] Build status: STARTED
[00:48:45.843] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:30:0) after 7m55s
[00:56:41.271] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:30:0)
[00:56:41.298] Build status: STARTED
[00:56:41.298] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:31:0) after 1m39s
[00:58:20.827] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:31:0)
[00:58:20.853] Build status: STARTED
[00:58:20.853] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:32:0) after 5m24s
[01:03:44.889] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:32:0)
[01:03:44.917] Build status: STARTED
[01:03:44.917] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:33:0) after 3m56s
[01:07:41.188] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:33:0)
[01:07:41.221] Build status: STARTED
[01:07:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:34:0) after 9m51s
[01:17:32.364] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:34:0)
[01:17:32.389] Build status: STARTED
[01:17:32.389] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:35:0) after 6m46s
[01:24:18.981] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:35:0)
[01:24:19.010] Build status: STARTED
[01:24:19.010] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:36:0) after 1m21s
[01:25:40.045] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:36:0)
[01:25:40.074] Build status: STARTED
[01:25:40.074] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:37:0) after 7m43s
[01:33:23.324] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:37:0)
[01:33:23.509] Build status: STARTED
[01:33:23.509] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:38:0) after 7m23s
[01:40:46.654] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:38:0)
[01:40:46.687] Build status: STARTED
[01:40:46.688] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:39:0) after 4m8s
[01:44:54.925] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:39:0)
[01:44:54.951] Build status: STARTED
[01:44:54.951] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:40:0) after 1m39s
[01:46:34.086] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:40:0)
[01:46:34.110] Build status: STARTED
[01:46:34.110] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:41:0) after 8m15s
[01:54:49.185] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:41:0)
[01:54:49.206] Build status: STARTED
[01:54:49.206] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:42:0) after 6m14s
[02:01:03.491] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:42:0)
[02:01:03.524] Build status: STARTED
[02:01:03.524] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:43:0) after 7m28s
[02:08:31.585] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:43:0)
[02:08:31.609] Build status: STARTED
[02:08:31.609] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:44:0) after 2m3s
[02:10:34.635] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:44:0)
[02:10:34.664] Build status: STARTED
[02:10:34.664] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:45:0) after 1m6s
[02:11:40.703] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:45:0)
[02:11:40.732] Build status: STARTED
[02:11:40.732] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:46:0) after 2m9s
[02:13:49.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:46:0)
[02:13:49.822] Build status: STARTED
[02:13:49.822] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:47:0) after 6m42s
[02:20:31.853] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:47:0)
[02:20:31.877] Build status: STARTED
[02:20:31.877] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:48:0) after 8m9s
[02:28:40.907] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:48:0)
[02:28:40.932] Build status: STARTED
[02:28:40.932] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:49:0) after 2m18s
[02:30:59.075] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:49:0)
[02:30:59.100] Build status: STARTED
[02:30:59.100] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:50:0) after 2m9s
[02:33:08.131] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:50:0)
[02:33:08.155] Build status: STARTED
[02:33:08.155] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:51:0) after 9m21s
[02:42:29.280] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:51:0)
[02:42:29.299] Build status: STARTED
[02:42:29.299] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:52:0) after 1m2s
[02:43:31.333] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:52:0)
[02:43:31.411] Build status: STARTED
[02:43:31.411] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:53:0) after 6m11s
[02:49:42.495] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:53:0)
[02:49:42.561] Build status: STARTED
[02:49:42.561] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:54:0) after 9m35s
[02:59:17.843] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:54:0)
[02:59:17.898] Build status: STARTED
[02:59:17.898] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:55:0) after 3m49s
[03:03:06.938] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:55:0)
[03:03:06.967] Build status: STARTED
[03:03:06.967] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:56:0) after 4m12s
[03:07:19.002] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:56:0)
[03:07:19.027] Build status: STARTED
[03:07:19.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:57:0) after 7m34s
[03:14:53.109] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:57:0)
[03:14:53.141] Build status: STARTED
[03:14:53.141] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:58:0) after 6m29s
[03:21:22.346] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:58:0)
[03:21:22.387] Build status: STARTED
[03:21:22.387] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:59:0) after 9m17s
[03:30:39.449] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:59:0)
[03:30:39.473] Build status: STARTED
[03:30:39.473] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:60:0) after 5m28s
[03:36:07.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:60:0)
[03:36:07.789] Build status: STARTED
[03:36:07.789] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:61:0) after 6m30s
[03:42:37.925] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:61:0)
[03:42:37.948] Build status: STARTED
[03:42:37.948] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:62:0) after 2m34s
[03:45:12.069] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:62:0)
[03:45:12.098] Build status: STARTED
[03:45:12.098] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:63:0) after 6m23s
[03:51:35.234] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:63:0)
[03:51:35.285] Build status: STARTED
[03:51:35.285] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:64:0) after 2m22s
[03:53:57.320] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:64:0)
[03:53:57.346] Build status: STARTED
[03:53:57.346] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:65:0) after 8m41s
[04:02:38.512] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:65:0)
[04:02:38.533] Build status: STARTED
[04:02:38.533] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:66:0) after 5m23s
[04:08:01.572] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:66:0)
[04:08:01.673] Build status: STARTED
[04:08:01.673] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:67:0) after 4m26s
[04:12:27.750] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:67:0)
[04:12:27.772] Build status: STARTED
[04:12:27.772] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:68:0) after 6m10s
[04:18:37.804] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:68:0)
[04:18:37.852] Build status: STARTED
[04:18:37.852] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:69:0) after 3m24s
[04:22:02.148] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:69:0)
[04:22:02.188] Build status: STARTED
[04:22:02.188] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:70:0) after 6m50s
[04:28:52.415] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:70:0)
[04:28:52.446] Build status: STARTED
[04:28:52.446] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:71:0) after 5m25s
[04:34:17.510] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:71:0)
[04:34:17.547] Build status: STARTED
[04:34:17.547] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:72:0) after 1m11s
[04:35:28.571] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:72:0)
[04:35:28.613] Build status: STARTED
[04:35:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:73:0) after 8m13s
[04:43:41.671] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:73:0)
[04:43:41.698] Build status: STARTED
[04:43:41.698] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:74:0) after 2m36s
[04:46:17.814] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:74:0)
[04:46:17.861] Build status: STARTED
[04:46:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:75:0) after 7m34s
[04:53:51.973] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:75:0)
[04:53:51.999] Build status: STARTED
[04:53:51.999] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:76:0) after 1m6s
[04:54:58.038] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:76:0)
[04:54:58.066] Build status: STARTED
[04:54:58.066] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:77:0) after 8m37s
[05:03:35.204] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:77:0)
[05:03:35.268] Build status: STARTED
[05:03:35.268] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:78:0) after 3m38s
[05:07:13.433] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:78:0)
[05:07:13.469] Build status: STARTED
[05:07:13.469] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:79:0) after 2m43s
[05:09:56.654] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:79:0)
[05:09:56.680] Build status: STARTED
[05:09:56.680] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:80:0) after 9m8s
[05:19:04.722] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:80:0)
[05:19:04.750] Build status: STARTED
[05:19:04.750] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:81:0) after 9m6s
[05:28:10.735] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:81:0)
[05:28:10.759] Build status: STARTED
[05:28:10.759] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:82:0) after 8m28s
[05:36:38.928] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:82:0)
[05:36:38.954] Build status: STARTED
[05:36:38.954] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:83:0) after 2m10s
[05:38:48.993] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:83:0)
[05:38:49.015] Build status: STARTED
[05:38:49.015] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:84:0) after 9m59s
[05:48:48.148] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:84:0)
[05:48:48.191] Build status: STARTED
[05:48:48.191] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:85:0) after 7m19s
[05:56:07.230] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:85:0)
[05:56:07.263] Build status: STARTED
[05:56:07.263] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:86:0) after 3m45s
[05:59:52.292] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:86:0)
[05:59:52.314] Build status: STARTED
[05:59:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:87:0) after 5m16s
[06:05:08.455] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:87:0)
[06:05:08.491] Build status: STARTED
[06:05:08.491] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:88:0) after 7m57s
[06:13:05.895] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:88:0)
[06:13:05.966] Build status: STARTED
[06:13:05.966] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:89:0) after 8m32s
[06:21:37.992] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:89:0)
[06:21:38.018] Build status: STARTED
[06:21:38.018] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:90:0) after 2m51s
[06:24:29.472] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:90:0)
[06:24:29.626] Build status: STARTED
[06:24:29.626] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:91:0) after 2m30s
[06:26:59.657] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:91:0)
[06:26:59.684] Build status: STARTED
[06:26:59.684] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:92:0) after 3m7s
[06:30:06.726] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:92:0)
[06:30:06.787] Build status: STARTED
[06:30:06.787] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:93:0) after 6m0s
[06:36:06.827] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:93:0)
[06:36:06.900] Build status: STARTED
[06:36:06.900] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:94:0) after 3m19s
[06:39:26.000] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:94:0)
[06:39:26.049] Build status: STARTED
[06:39:26.049] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:95:0) after 9m25s
[06:48:51.307] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:95:0)
[06:48:51.329] Build status: STARTED
[06:48:51.329] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:96:0) after 1m26s
[06:50:17.360] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:96:0)
[06:50:17.387] Build status: STARTED
[06:50:17.387] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:97:0) after 1m3s
[06:51:20.419] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:97:0)
[06:51:20.442] Build status: STARTED
[06:51:20.442] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:98:0) after 5m1s
[06:56:21.488] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:98:0)
[06:56:21.513] Build status: STARTED
[06:56:21.513] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:99:0) after 8m4s
[07:04:25.788] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:99:0)
[07:04:25.835] Build status: STARTED
[07:04:25.835] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:100:0) after 7m55s
[07:12:20.974] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:100:0)
[07:12:21.013] Build status: STARTED
[07:12:21.013] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:101:0) after 3m14s
[07:15:35.050] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:101:0)
[07:15:35.088] Build status: STARTED
[07:15:35.088] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:102:0) after 6m39s
[07:22:14.124] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:102:0)
[07:22:14.145] Build status: STARTED
[07:22:14.145] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:103:0) after 9m23s
[07:31:37.240] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:103:0)
[07:31:37.265] Build status: STARTED
[07:31:37.266] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:104:0) after 5m46s
[07:37:23.298] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:104:0)
[07:37:23.333] Build status: STARTED
[07:37:23.333] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:105:0) after 8m34s
[07:45:57.372] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:105:0)
[07:45:57.399] Build status: STARTED
[07:45:57.399] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:106:0) after 8m4s
[07:54:01.614] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:106:0)
[07:54:01.639] Build status: STARTED
[07:54:01.639] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:107:0) after 5m31s
[07:59:32.748] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:107:0)
[07:59:32.771] Build status: STARTED
[07:59:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:108:0) after 2m37s
[08:02:10.027] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:108:0)
[08:02:10.088] Build status: STARTED
[08:02:10.088] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:109:0) after 1m14s
[08:03:24.120] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:109:0)
[08:03:24.145] Build status: STARTED
[08:03:24.145] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:110:0) after 1m43s
[08:05:07.182] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:110:0)
[08:05:07.206] Build status: STARTED
[08:05:07.207] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:111:0) after 1m10s
[08:06:17.235] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:111:0)
[08:06:17.257] Build status: STARTED
[08:06:17.257] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:112:0) after 6m33s
[08:12:50.698] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:112:0)
[08:12:50.722] Build status: STARTED
[08:12:50.722] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:113:0) after 5m29s
[08:18:19.781] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:113:0)
[08:18:19.809] Build status: STARTED
[08:18:19.809] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:114:0) after 2m4s
[08:20:23.891] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:114:0)
[08:20:23.925] Build status: STARTED
[08:20:23.925] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:115:0) after 7m50s
[08:28:13.961] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:115:0)
[08:28:14.047] Build status: STARTED
[08:28:14.047] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:116:0) after 7m43s
[08:35:57.199] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:116:0)
[08:35:57.223] Build status: STARTED
[08:35:57.223] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8964179978042585136:117:0) after 2m15s
[08:36:04.695] Received PubSub notification, asking Buildbucket for the build status
[08:36:04.717] Build:
{
"id": "8798749915978463105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11950,
"createdBy": "project:chromium",
"createTime": "2022-10-31T22:26:50.857564957Z",
"startTime": "2022-10-31T22:35:52.638450Z",
"endTime": "2022-11-01T08:36:04.385236464Z",
"updateTime": "2022-11-01T08:36:04.385236464Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f778f05036b831c682166b59b8061f29a481ef17",
"ref": "refs/heads/main"
}
}
}
[08:36:04.717] Invocation finished in 10h9m15.212542044s with status ABORTED