[04:31:40.193] New invocation is queued and will start shortly
[04:31:41.372] Starting the invocation (attempt 1)
[04:31:41.411] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f879cd50e5a2d2f4cc106a4de23453f0e29badc"
[04:31:41.411] Popped gitiles commit info from properties and tags
[04:31:41.411] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:31:41.411] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:31:41.411] Buildbucket request:
{
"requestId": "8985447311112066816",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f879cd50e5a2d2f4cc106a4de23453f0e29badc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8985447311112066816"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:31:41.997] Scheduled build:
{
"id": "8820017249088061249",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1164,
"createdBy": "project:chromium",
"createTime": "2022-03-11T04:31:41.492513054Z",
"updateTime": "2022-03-11T04:31:41.492513054Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f879cd50e5a2d2f4cc106a4de23453f0e29badc",
"ref": "refs/heads/main"
}
}
}
[04:31:41.997] Task URL: https://cr-buildbucket.appspot.com/build/8820017249088061249
[04:31:41.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:2:0) after 5m17s
[04:36:59.027] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:2:0)
[04:36:59.050] Build status: SCHEDULED
[04:36:59.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:3:0) after 1m43s
[04:38:42.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:3:0)
[04:38:42.164] Build status: SCHEDULED
[04:38:42.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:4:0) after 4m47s
[04:43:29.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:4:0)
[04:43:29.245] Build status: SCHEDULED
[04:43:29.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:5:0) after 5m36s
[04:49:05.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:5:0)
[04:49:05.570] Build status: SCHEDULED
[04:49:05.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:6:0) after 4m3s
[04:53:08.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:6:0)
[04:53:08.635] Build status: SCHEDULED
[04:53:08.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:7:0) after 7m31s
[05:00:39.756] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:7:0)
[05:00:39.791] Build status: SCHEDULED
[05:00:39.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:8:0) after 5m22s
[05:06:01.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:8:0)
[05:06:01.925] Build status: SCHEDULED
[05:06:01.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:9:0) after 9m7s
[05:15:09.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:9:0)
[05:15:09.134] Build status: SCHEDULED
[05:15:09.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:10:0) after 2m29s
[05:17:38.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:10:0)
[05:17:38.257] Build status: SCHEDULED
[05:17:38.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:11:0) after 3m42s
[05:21:20.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:11:0)
[05:21:20.429] Build status: SCHEDULED
[05:21:20.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:12:0) after 2m41s
[05:24:01.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:12:0)
[05:24:01.641] Build status: SCHEDULED
[05:24:01.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:13:0) after 6m27s
[05:30:28.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:13:0)
[05:30:28.854] Build status: SCHEDULED
[05:30:28.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:14:0) after 5m5s
[05:35:33.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:14:0)
[05:35:33.981] Build status: SCHEDULED
[05:35:33.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:15:0) after 8m50s
[05:44:24.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:15:0)
[05:44:24.227] Build status: SCHEDULED
[05:44:24.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:16:0) after 4m41s
[05:49:05.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:16:0)
[05:49:05.398] Build status: SCHEDULED
[05:49:05.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:17:0) after 3m9s
[05:52:14.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:17:0)
[05:52:14.613] Build status: SCHEDULED
[05:52:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:18:0) after 5m2s
[05:57:16.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:18:0)
[05:57:16.672] Build status: SCHEDULED
[05:57:16.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:19:0) after 1m25s
[05:58:41.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:19:0)
[05:58:41.928] Build status: SCHEDULED
[05:58:41.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:20:0) after 1m6s
[05:59:48.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:20:0)
[05:59:48.059] Build status: SCHEDULED
[05:59:48.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:21:0) after 9m28s
[06:09:16.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:21:0)
[06:09:16.212] Build status: SCHEDULED
[06:09:16.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:22:0) after 6m16s
[06:15:32.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:22:0)
[06:15:32.267] Build status: SCHEDULED
[06:15:32.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:23:0) after 3m50s
[06:19:22.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:23:0)
[06:19:22.384] Build status: SCHEDULED
[06:19:22.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:24:0) after 9m53s
[06:29:15.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:24:0)
[06:29:15.471] Build status: SCHEDULED
[06:29:15.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:25:0) after 5m37s
[06:34:52.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:25:0)
[06:34:52.653] Build status: SCHEDULED
[06:34:52.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:26:0) after 1m27s
[06:36:19.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:26:0)
[06:36:19.814] Build status: SCHEDULED
[06:36:19.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:27:0) after 7m0s
[06:43:19.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:27:0)
[06:43:19.877] Build status: SCHEDULED
[06:43:19.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:28:0) after 4m17s
[06:43:59.360] Received PubSub notification, asking Buildbucket for the build status
[06:43:59.391] Build status: STARTED
[06:47:36.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:28:0)
[06:47:36.994] Build status: STARTED
[06:47:36.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:30:0) after 7m20s
[06:54:57.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:30:0)
[06:54:57.122] Build status: STARTED
[06:54:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:31:0) after 6m19s
[07:01:16.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:31:0)
[07:01:16.198] Build status: STARTED
[07:01:16.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:32:0) after 4m33s
[07:05:49.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:32:0)
[07:05:49.283] Build status: STARTED
[07:05:49.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:33:0) after 6m10s
[07:11:59.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:33:0)
[07:11:59.338] Build status: STARTED
[07:11:59.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:34:0) after 5m30s
[07:17:29.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:34:0)
[07:17:29.495] Build status: STARTED
[07:17:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:35:0) after 4m50s
[07:22:19.527] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:35:0)
[07:22:19.548] Build status: STARTED
[07:22:19.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:36:0) after 3m39s
[07:25:58.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:36:0)
[07:25:58.672] Build status: STARTED
[07:25:58.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:37:0) after 1m46s
[07:27:45.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:37:0)
[07:27:45.099] Build status: STARTED
[07:27:45.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:38:0) after 1m21s
[07:29:06.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:38:0)
[07:29:06.190] Build status: STARTED
[07:29:06.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:39:0) after 4m27s
[07:33:33.223] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:39:0)
[07:33:33.261] Build status: STARTED
[07:33:33.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:40:0) after 9m31s
[07:43:04.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:40:0)
[07:43:04.331] Build status: STARTED
[07:43:04.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:41:0) after 4m10s
[07:47:14.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:41:0)
[07:47:14.473] Build status: STARTED
[07:47:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:42:0) after 9m43s
[07:56:57.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:42:0)
[07:56:57.543] Build status: STARTED
[07:56:57.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:43:0) after 2m0s
[07:58:57.602] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:43:0)
[07:58:57.636] Build status: STARTED
[07:58:57.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:44:0) after 8m23s
[08:07:20.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:44:0)
[08:07:20.694] Build status: STARTED
[08:07:20.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:45:0) after 6m49s
[08:14:09.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:45:0)
[08:14:09.759] Build status: STARTED
[08:14:09.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:46:0) after 2m37s
[08:16:46.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:46:0)
[08:16:46.831] Build status: STARTED
[08:16:46.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:47:0) after 4m32s
[08:21:18.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:47:0)
[08:21:18.901] Build status: STARTED
[08:21:18.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:48:0) after 7m45s
[08:29:03.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:48:0)
[08:29:03.966] Build status: STARTED
[08:29:03.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:49:0) after 3m12s
[08:32:16.003] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:49:0)
[08:32:16.047] Build status: STARTED
[08:32:16.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:50:0) after 5m29s
[08:37:45.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:50:0)
[08:37:45.159] Build status: STARTED
[08:37:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:51:0) after 8m9s
[08:45:54.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:51:0)
[08:45:54.285] Build status: STARTED
[08:45:54.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:52:0) after 4m29s
[08:50:23.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:52:0)
[08:50:23.721] Build status: STARTED
[08:50:23.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:53:0) after 5m50s
[08:56:13.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:53:0)
[08:56:14.993] Build status: STARTED
[08:56:14.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:54:0) after 9m51s
[09:06:06.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:54:0)
[09:06:06.828] Build status: STARTED
[09:06:06.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:55:0) after 3m39s
[09:09:45.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:55:0)
[09:09:45.881] Build status: STARTED
[09:09:45.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:56:0) after 4m12s
[09:13:57.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:56:0)
[09:13:57.959] Build status: STARTED
[09:13:57.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:57:0) after 3m50s
[09:17:48.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:57:0)
[09:17:48.179] Build status: STARTED
[09:17:48.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:58:0) after 6m54s
[09:24:42.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:58:0)
[09:24:42.342] Build status: STARTED
[09:24:42.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:59:0) after 3m36s
[09:28:18.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:59:0)
[09:28:18.442] Build status: STARTED
[09:28:18.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:60:0) after 1m48s
[09:30:06.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:60:0)
[09:30:06.506] Build status: STARTED
[09:30:06.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:61:0) after 2m25s
[09:32:31.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:61:0)
[09:32:31.849] Build status: STARTED
[09:32:31.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:62:0) after 4m25s
[09:36:57.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:62:0)
[09:36:57.079] Build status: STARTED
[09:36:57.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:63:0) after 5m24s
[09:42:21.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:63:0)
[09:42:21.136] Build status: STARTED
[09:42:21.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:64:0) after 9m50s
[09:52:11.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:64:0)
[09:52:11.341] Build status: STARTED
[09:52:11.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:65:0) after 1m15s
[09:53:26.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:65:0)
[09:53:26.518] Build status: STARTED
[09:53:26.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:66:0) after 8m27s
[10:01:53.875] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:66:0)
[10:01:53.902] Build status: STARTED
[10:01:53.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:67:0) after 2m11s
[10:04:05.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:67:0)
[10:04:05.319] Build status: STARTED
[10:04:05.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:68:0) after 1m42s
[10:05:47.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:68:0)
[10:05:47.742] Build status: STARTED
[10:05:47.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:69:0) after 3m9s
[10:08:56.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:69:0)
[10:08:56.834] Build status: STARTED
[10:08:56.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:70:0) after 9m10s
[10:18:06.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:70:0)
[10:18:07.004] Build status: STARTED
[10:18:07.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:71:0) after 5m29s
[10:23:36.035] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:71:0)
[10:23:36.065] Build status: STARTED
[10:23:36.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:72:0) after 8m17s
[10:31:53.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:72:0)
[10:31:53.162] Build status: STARTED
[10:31:53.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:73:0) after 2m5s
[10:33:58.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:73:0)
[10:33:58.235] Build status: STARTED
[10:33:58.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:74:0) after 6m33s
[10:40:31.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:74:0)
[10:40:31.547] Build status: STARTED
[10:40:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:75:0) after 7m42s
[10:48:13.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:75:0)
[10:48:13.779] Build status: STARTED
[10:48:13.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:76:0) after 1m12s
[10:49:25.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:76:0)
[10:49:25.848] Build status: STARTED
[10:49:25.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:77:0) after 4m12s
[10:53:37.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:77:0)
[10:53:37.900] Build status: STARTED
[10:53:37.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:78:0) after 8m11s
[11:01:48.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:78:0)
[11:01:48.936] Build status: STARTED
[11:01:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:79:0) after 7m12s
[11:09:01.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:79:0)
[11:09:01.040] Build status: STARTED
[11:09:01.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:80:0) after 5m50s
[11:14:51.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:80:0)
[11:14:51.437] Build status: STARTED
[11:14:51.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:81:0) after 2m7s
[11:16:58.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:81:0)
[11:16:58.575] Build status: STARTED
[11:16:58.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:82:0) after 1m26s
[11:18:24.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:82:0)
[11:18:24.829] Build status: STARTED
[11:18:24.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:83:0) after 1m36s
[11:20:00.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:83:0)
[11:20:00.897] Build status: STARTED
[11:20:00.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:84:0) after 2m14s
[11:22:14.927] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:84:0)
[11:22:14.962] Build status: STARTED
[11:22:14.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:85:0) after 2m49s
[11:25:04.148] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:85:0)
[11:25:04.221] Build status: STARTED
[11:25:04.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:86:0) after 5m10s
[11:30:14.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:86:0)
[11:30:14.404] Build status: STARTED
[11:30:14.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:87:0) after 1m2s
[11:31:16.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:87:0)
[11:31:16.473] Build status: STARTED
[11:31:16.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:88:0) after 2m43s
[11:33:59.511] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:88:0)
[11:33:59.530] Build status: STARTED
[11:33:59.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:89:0) after 8m46s
[11:42:45.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:89:0)
[11:42:45.585] Build status: STARTED
[11:42:45.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:90:0) after 8m23s
[11:51:08.671] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:90:0)
[11:51:08.748] Build status: STARTED
[11:51:08.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:91:0) after 2m18s
[11:53:26.782] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:91:0)
[11:53:26.806] Build status: STARTED
[11:53:26.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:92:0) after 1m15s
[11:54:41.846] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:92:0)
[11:54:41.871] Build status: STARTED
[11:54:41.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:93:0) after 6m34s
[12:01:15.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:93:0)
[12:01:15.972] Build status: STARTED
[12:01:15.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:94:0) after 3m57s
[12:05:13.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:94:0)
[12:05:13.174] Build status: STARTED
[12:05:13.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:95:0) after 9m25s
[12:14:38.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:95:0)
[12:14:38.355] Build status: STARTED
[12:14:38.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:96:0) after 7m42s
[12:22:20.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:96:0)
[12:22:20.466] Build status: STARTED
[12:22:20.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:97:0) after 8m6s
[12:30:26.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:97:0)
[12:30:26.538] Build status: STARTED
[12:30:26.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:98:0) after 4m23s
[12:34:49.634] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:98:0)
[12:34:49.675] Build status: STARTED
[12:34:49.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:99:0) after 9m14s
[12:44:03.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:99:0)
[12:44:03.845] Build status: STARTED
[12:44:03.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:100:0) after 7m25s
[12:51:28.908] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:100:0)
[12:51:29.065] Build status: STARTED
[12:51:29.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:101:0) after 2m58s
[12:54:27.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:101:0)
[12:54:27.162] Build status: STARTED
[12:54:27.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:102:0) after 9m49s
[13:04:16.210] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:102:0)
[13:04:16.244] Build status: STARTED
[13:04:16.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:103:0) after 8m15s
[13:12:31.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:103:0)
[13:12:31.290] Build status: STARTED
[13:12:31.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:104:0) after 4m21s
[13:16:52.326] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:104:0)
[13:16:52.352] Build status: STARTED
[13:16:52.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:105:0) after 2m4s
[13:18:56.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:105:0)
[13:18:56.431] Build status: STARTED
[13:18:56.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:106:0) after 3m4s
[13:22:00.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:106:0)
[13:22:00.604] Build status: STARTED
[13:22:00.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:107:0) after 8m25s
[13:30:25.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:107:0)
[13:30:25.747] Build status: STARTED
[13:30:25.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:108:0) after 3m49s
[13:34:14.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:108:0)
[13:34:14.833] Build status: STARTED
[13:34:14.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:109:0) after 6m4s
[13:40:19.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:109:0)
[13:40:19.088] Build status: STARTED
[13:40:19.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:110:0) after 8m50s
[13:49:09.223] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:110:0)
[13:49:09.323] Build status: STARTED
[13:49:09.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:111:0) after 4m35s
[13:53:44.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:111:0)
[13:53:44.387] Build status: STARTED
[13:53:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:112:0) after 4m24s
[13:58:08.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:112:0)
[13:58:08.591] Build status: STARTED
[13:58:08.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:113:0) after 1m23s
[13:59:31.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:113:0)
[13:59:31.647] Build status: STARTED
[13:59:31.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:114:0) after 3m20s
[14:02:52.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:114:0)
[14:02:52.071] Build status: STARTED
[14:02:52.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:115:0) after 1m14s
[14:04:06.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:115:0)
[14:04:06.244] Build status: STARTED
[14:04:06.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:116:0) after 3m14s
[14:07:20.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:116:0)
[14:07:20.409] Build status: STARTED
[14:07:20.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:117:0) after 2m27s
[14:09:47.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:117:0)
[14:09:47.628] Build status: STARTED
[14:09:47.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:118:0) after 7m21s
[14:17:08.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:118:0)
[14:17:08.718] Build status: STARTED
[14:17:08.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:119:0) after 5m36s
[14:22:44.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:119:0)
[14:22:44.857] Build status: STARTED
[14:22:44.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:120:0) after 6m9s
[14:28:54.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:120:0)
[14:28:54.127] Build status: STARTED
[14:28:54.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:121:0) after 6m11s
[14:35:05.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:121:0)
[14:35:05.285] Build status: STARTED
[14:35:05.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:122:0) after 1m22s
[14:36:27.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:122:0)
[14:36:27.345] Build status: STARTED
[14:36:27.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:123:0) after 1m30s
[14:37:57.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:123:0)
[14:37:57.501] Build status: STARTED
[14:37:57.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:124:0) after 6m13s
[14:44:10.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:124:0)
[14:44:10.558] Build status: STARTED
[14:44:10.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:125:0) after 3m3s
[14:47:13.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:125:0)
[14:47:13.738] Build status: STARTED
[14:47:13.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:126:0) after 5m52s
[14:53:05.780] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:126:0)
[14:53:05.814] Build status: STARTED
[14:53:05.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:127:0) after 2m9s
[14:55:14.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:127:0)
[14:55:14.884] Build status: STARTED
[14:55:14.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:128:0) after 7m46s
[15:03:00.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:128:0)
[15:03:00.960] Build status: STARTED
[15:03:00.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:129:0) after 2m27s
[15:05:28.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:129:0)
[15:05:28.035] Build status: STARTED
[15:05:28.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:130:0) after 9m32s
[15:15:00.140] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:130:0)
[15:15:00.181] Build status: STARTED
[15:15:00.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:131:0) after 7m18s
[15:22:18.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:131:0)
[15:22:18.287] Build status: STARTED
[15:22:18.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:132:0) after 2m12s
[15:24:30.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:132:0)
[15:24:30.450] Build status: STARTED
[15:24:30.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:133:0) after 3m55s
[15:28:25.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:133:0)
[15:28:25.577] Build status: STARTED
[15:28:25.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:134:0) after 6m25s
[15:34:50.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:134:0)
[15:34:50.697] Build status: STARTED
[15:34:50.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:135:0) after 8m2s
[15:42:52.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:135:0)
[15:42:52.762] Build status: STARTED
[15:42:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:136:0) after 3m50s
[15:46:42.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:136:0)
[15:46:42.899] Build status: STARTED
[15:46:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:137:0) after 6m21s
[15:53:04.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:137:0)
[15:53:04.187] Build status: STARTED
[15:53:04.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:138:0) after 4m23s
[15:57:27.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:138:0)
[15:57:27.372] Build status: STARTED
[15:57:27.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:139:0) after 7m59s
[16:05:26.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:139:0)
[16:05:26.437] Build status: STARTED
[16:05:26.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:140:0) after 5m9s
[16:10:35.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:140:0)
[16:10:35.507] Build status: STARTED
[16:10:35.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:141:0) after 6m12s
[16:16:47.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:141:0)
[16:16:47.647] Build status: STARTED
[16:16:47.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:142:0) after 1m42s
[16:18:29.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:142:0)
[16:18:30.104] Build status: STARTED
[16:18:30.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:143:0) after 1m15s
[16:19:45.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:143:0)
[16:19:45.185] Build status: STARTED
[16:19:45.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:144:0) after 6m57s
[16:26:42.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:144:0)
[16:26:42.285] Build status: STARTED
[16:26:42.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:145:0) after 3m39s
[16:30:21.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:145:0)
[16:30:21.463] Build status: STARTED
[16:30:21.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985447311112066816:146:0) after 7m30s
[16:33:59.676] Received PubSub notification, asking Buildbucket for the build status
[16:33:59.728] Build:
{
"id": "8820017249088061249",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1164,
"createdBy": "project:chromium",
"createTime": "2022-03-11T04:31:41.492513054Z",
"startTime": "2022-03-11T06:43:58.777778Z",
"endTime": "2022-03-11T16:33:59.209293719Z",
"updateTime": "2022-03-11T16:33:59.209293719Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f879cd50e5a2d2f4cc106a4de23453f0e29badc",
"ref": "refs/heads/main"
}
}
}
[16:33:59.728] Invocation finished in 12h2m19.54976843s with status SUCCEEDED