[18:33:33.255] New invocation is queued and will start shortly
[18:33:35.176] Starting the invocation (attempt 1)
[18:33:35.216] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7f928273efe064e9ea34f92977f0b1e9551aa97"
[18:33:35.216] Popped gitiles commit info from properties and tags
[18:33:35.216] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:35.216] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:35.216] Buildbucket request:
{
"requestId": "8914638113568195776",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7f928273efe064e9ea34f92977f0b1e9551aa97",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914638113568195776"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-rel-no-external-ip"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:33:35.826] Scheduled build:
{
"id": "8749208050790881921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3289,
"createdBy": "project:chromium",
"createTime": "2024-04-30T18:33:35.273548031Z",
"updateTime": "2024-04-30T18:33:35.273548031Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7f928273efe064e9ea34f92977f0b1e9551aa97",
"ref": "refs/heads/main"
}
}
}
[18:33:35.826] Task URL: https://cr-buildbucket.appspot.com/build/8749208050790881921
[18:33:35.826] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:2:0) after 7m7s
[18:33:36.796] Received PubSub notification, asking Buildbucket for the build status
[18:33:36.855] Build status: SCHEDULED
[18:33:43.589] Received PubSub notification, asking Buildbucket for the build status
[18:33:43.712] Build status: STARTED
[18:40:42.820] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:2:0)
[18:40:42.855] Build status: STARTED
[18:40:42.855] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:5:0) after 6m11s
[18:46:53.907] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:5:0)
[18:46:53.946] Build status: STARTED
[18:46:53.946] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:6:0) after 6m34s
[18:53:27.980] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:6:0)
[18:53:28.001] Build status: STARTED
[18:53:28.001] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:7:0) after 1m2s
[18:54:29.974] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:7:0)
[18:54:29.992] Build status: STARTED
[18:54:29.992] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:8:0) after 8m40s
[19:03:10.024] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:8:0)
[19:03:10.051] Build status: STARTED
[19:03:10.051] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:9:0) after 3m48s
[19:06:58.089] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:9:0)
[19:06:58.139] Build status: STARTED
[19:06:58.139] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:10:0) after 3m11s
[19:10:09.241] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:10:0)
[19:10:09.405] Build status: STARTED
[19:10:09.405] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:11:0) after 8m12s
[19:18:21.444] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:11:0)
[19:18:21.467] Build status: STARTED
[19:18:21.467] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:12:0) after 2m53s
[19:21:14.542] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:12:0)
[19:21:14.558] Build status: STARTED
[19:21:14.558] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:13:0) after 4m14s
[19:25:28.603] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:13:0)
[19:25:28.623] Build status: STARTED
[19:25:28.623] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:14:0) after 9m13s
[19:34:41.646] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:14:0)
[19:34:41.663] Build status: STARTED
[19:34:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:15:0) after 4m2s
[19:38:43.683] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:15:0)
[19:38:43.719] Build status: STARTED
[19:38:43.720] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:16:0) after 7m32s
[19:46:15.753] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:16:0)
[19:46:15.815] Build status: STARTED
[19:46:15.815] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:17:0) after 2m57s
[19:49:12.854] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:17:0)
[19:49:12.924] Build status: STARTED
[19:49:12.924] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:18:0) after 5m51s
[19:55:03.977] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:18:0)
[19:55:04.099] Build status: STARTED
[19:55:04.099] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:19:0) after 2m37s
[19:57:41.184] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:19:0)
[19:57:41.200] Build status: STARTED
[19:57:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:20:0) after 4m7s
[20:01:48.238] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:20:0)
[20:01:48.257] Build status: STARTED
[20:01:48.257] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:21:0) after 7m53s
[20:09:41.258] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:21:0)
[20:09:41.276] Build status: STARTED
[20:09:41.277] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:22:0) after 6m58s
[20:16:39.340] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:22:0)
[20:16:39.363] Build status: STARTED
[20:16:39.363] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:23:0) after 4m33s
[20:21:12.440] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:23:0)
[20:21:12.494] Build status: STARTED
[20:21:12.496] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:24:0) after 5m17s
[20:26:29.549] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:24:0)
[20:26:29.601] Build status: STARTED
[20:26:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:25:0) after 2m8s
[20:28:37.727] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:25:0)
[20:28:37.782] Build status: STARTED
[20:28:37.782] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:26:0) after 2m21s
[20:30:58.797] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:26:0)
[20:30:58.832] Build status: STARTED
[20:30:58.832] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:27:0) after 8m34s
[20:39:32.893] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:27:0)
[20:39:33.053] Build status: STARTED
[20:39:33.053] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:28:0) after 6m20s
[20:45:53.119] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:28:0)
[20:45:53.154] Build status: STARTED
[20:45:53.154] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:29:0) after 4m16s
[20:50:09.177] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:29:0)
[20:50:09.205] Build status: STARTED
[20:50:09.205] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:30:0) after 7m22s
[20:57:31.253] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:30:0)
[20:57:31.279] Build status: STARTED
[20:57:31.280] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:31:0) after 2m42s
[21:00:13.308] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:31:0)
[21:00:13.353] Build status: STARTED
[21:00:13.353] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:32:0) after 7m20s
[21:07:33.378] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:32:0)
[21:07:33.400] Build status: STARTED
[21:07:33.400] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:33:0) after 3m32s
[21:11:05.482] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:33:0)
[21:11:05.508] Build status: STARTED
[21:11:05.508] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:34:0) after 6m33s
[21:17:38.537] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:34:0)
[21:17:38.555] Build status: STARTED
[21:17:38.555] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:35:0) after 7m27s
[21:25:05.582] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:35:0)
[21:25:05.601] Build status: STARTED
[21:25:05.601] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:36:0) after 3m25s
[21:28:30.648] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:36:0)
[21:28:30.671] Build status: STARTED
[21:28:30.671] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:37:0) after 2m31s
[21:31:01.699] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:37:0)
[21:31:01.724] Build status: STARTED
[21:31:01.724] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:38:0) after 3m7s
[21:34:08.816] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:38:0)
[21:34:08.835] Build status: STARTED
[21:34:08.835] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:39:0) after 9m40s
[21:43:48.862] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:39:0)
[21:43:48.880] Build status: STARTED
[21:43:48.880] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:40:0) after 1m15s
[21:45:03.901] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:40:0)
[21:45:03.929] Build status: STARTED
[21:45:03.929] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:41:0) after 8m13s
[21:53:16.949] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:41:0)
[21:53:16.971] Build status: STARTED
[21:53:16.971] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:42:0) after 7m24s
[22:00:40.994] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:42:0)
[22:00:41.087] Build status: STARTED
[22:00:41.087] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:43:0) after 7m43s
[22:08:24.158] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:43:0)
[22:08:24.178] Build status: STARTED
[22:08:24.178] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:44:0) after 2m52s
[22:11:16.249] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:44:0)
[22:11:16.269] Build status: STARTED
[22:11:16.269] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:45:0) after 8m43s
[22:19:59.367] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:45:0)
[22:19:59.382] Build status: STARTED
[22:19:59.382] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:46:0) after 6m32s
[22:26:31.377] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:46:0)
[22:26:31.393] Build status: STARTED
[22:26:31.393] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:47:0) after 9m12s
[22:35:43.417] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:47:0)
[22:35:43.436] Build status: STARTED
[22:35:43.436] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:48:0) after 7m36s
[22:43:19.473] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:48:0)
[22:43:19.494] Build status: STARTED
[22:43:19.494] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:49:0) after 3m36s
[22:46:55.586] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:49:0)
[22:46:55.605] Build status: STARTED
[22:46:55.605] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:50:0) after 4m6s
[22:51:01.653] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:50:0)
[22:51:01.673] Build status: STARTED
[22:51:01.674] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:51:0) after 9m57s
[23:00:58.778] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:51:0)
[23:00:58.837] Build status: STARTED
[23:00:58.837] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:52:0) after 4m30s
[23:05:28.875] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:52:0)
[23:05:29.114] Build status: STARTED
[23:05:29.114] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:53:0) after 5m35s
[23:11:04.153] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:53:0)
[23:11:04.171] Build status: STARTED
[23:11:04.171] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:54:0) after 7m1s
[23:18:05.192] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:54:0)
[23:18:05.222] Build status: STARTED
[23:18:05.222] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:55:0) after 4m2s
[23:22:07.244] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:55:0)
[23:22:07.264] Build status: STARTED
[23:22:07.264] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:56:0) after 4m41s
[23:26:48.292] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:56:0)
[23:26:48.312] Build status: STARTED
[23:26:48.312] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:57:0) after 2m9s
[23:28:57.380] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:57:0)
[23:28:57.427] Build status: STARTED
[23:28:57.427] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:58:0) after 9m11s
[23:38:08.453] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:58:0)
[23:38:08.472] Build status: STARTED
[23:38:08.472] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:59:0) after 2m34s
[23:40:42.593] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:59:0)
[23:40:42.613] Build status: STARTED
[23:40:42.613] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:60:0) after 2m14s
[23:42:56.666] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:60:0)
[23:42:56.686] Build status: STARTED
[23:42:56.686] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:61:0) after 6m53s
[23:49:49.764] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:61:0)
[23:49:49.812] Build status: STARTED
[23:49:49.812] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:62:0) after 3m3s
[23:52:52.792] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:62:0)
[23:52:52.810] Build status: STARTED
[23:52:52.810] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:63:0) after 8m42s
[00:01:34.968] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:63:0)
[00:01:35.003] Build status: STARTED
[00:01:35.004] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:64:0) after 1m13s
[00:02:48.253] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:64:0)
[00:02:48.277] Build status: STARTED
[00:02:48.277] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:65:0) after 3m45s
[00:06:33.607] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:65:0)
[00:06:33.641] Build status: STARTED
[00:06:33.641] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:66:0) after 3m31s
[00:10:04.703] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:66:0)
[00:10:04.725] Build status: STARTED
[00:10:04.726] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:67:0) after 8m33s
[00:18:37.748] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:67:0)
[00:18:37.780] Build status: STARTED
[00:18:37.780] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:68:0) after 9m23s
[00:28:00.766] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:68:0)
[00:28:00.791] Build status: STARTED
[00:28:00.791] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:69:0) after 3m10s
[00:31:10.819] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:69:0)
[00:31:10.840] Build status: STARTED
[00:31:10.840] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:70:0) after 7m19s
[00:38:29.869] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:70:0)
[00:38:30.047] Build status: STARTED
[00:38:30.047] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:71:0) after 2m1s
[00:40:31.073] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:71:0)
[00:40:31.100] Build status: STARTED
[00:40:31.100] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:72:0) after 5m31s
[00:46:02.170] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:72:0)
[00:46:02.197] Build status: STARTED
[00:46:02.197] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:73:0) after 7m53s
[00:53:55.286] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:73:0)
[00:53:55.387] Build status: STARTED
[00:53:55.387] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:74:0) after 1m38s
[00:55:33.424] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:74:0)
[00:55:33.443] Build status: STARTED
[00:55:33.443] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:75:0) after 1m1s
[00:56:34.544] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:75:0)
[00:56:34.565] Build status: STARTED
[00:56:34.565] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:76:0) after 8m56s
[01:05:30.586] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:76:0)
[01:05:30.606] Build status: STARTED
[01:05:30.606] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:77:0) after 2m46s
[01:08:17.112] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:77:0)
[01:08:17.135] Build status: STARTED
[01:08:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:78:0) after 6m32s
[01:14:49.255] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:78:0)
[01:14:49.279] Build status: STARTED
[01:14:49.279] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:79:0) after 4m43s
[01:19:32.291] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:79:0)
[01:19:32.311] Build status: STARTED
[01:19:32.311] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:80:0) after 9m3s
[01:28:35.667] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:80:0)
[01:28:35.721] Build status: STARTED
[01:28:35.721] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:81:0) after 5m46s
[01:34:21.846] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:81:0)
[01:34:21.869] Build status: STARTED
[01:34:21.869] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:82:0) after 4m20s
[01:38:42.332] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:82:0)
[01:38:42.358] Build status: STARTED
[01:38:42.358] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:83:0) after 3m58s
[01:42:40.455] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:83:0)
[01:42:40.481] Build status: STARTED
[01:42:40.481] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:84:0) after 7m58s
[01:50:38.603] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:84:0)
[01:50:38.622] Build status: STARTED
[01:50:38.622] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:85:0) after 6m58s
[01:57:36.636] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:85:0)
[01:57:36.661] Build status: STARTED
[01:57:36.661] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:86:0) after 8m18s
[02:05:54.686] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:86:0)
[02:05:54.720] Build status: STARTED
[02:05:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:87:0) after 8m8s
[02:14:02.832] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:87:0)
[02:14:02.894] Build status: STARTED
[02:14:02.895] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:88:0) after 5m32s
[02:19:34.977] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:88:0)
[02:19:34.998] Build status: STARTED
[02:19:34.998] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:89:0) after 7m17s
[02:26:52.291] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:89:0)
[02:26:52.414] Build status: STARTED
[02:26:52.414] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:90:0) after 8m55s
[02:35:47.411] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:90:0)
[02:35:47.478] Build status: STARTED
[02:35:47.478] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:91:0) after 8m3s
[02:43:50.535] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:91:0)
[02:43:50.580] Build status: STARTED
[02:43:50.580] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:92:0) after 7m52s
[02:51:43.242] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:92:0)
[02:51:43.263] Build status: STARTED
[02:51:43.263] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:93:0) after 1m52s
[02:53:35.428] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:93:0)
[02:53:35.455] Build status: STARTED
[02:53:35.455] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:94:0) after 8m47s
[03:02:22.583] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:94:0)
[03:02:22.603] Build status: STARTED
[03:02:22.603] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:95:0) after 5m23s
[03:07:45.629] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:95:0)
[03:07:45.650] Build status: STARTED
[03:07:45.650] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:96:0) after 5m1s
[03:12:46.846] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:96:0)
[03:12:46.873] Build status: STARTED
[03:12:46.873] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:97:0) after 3m47s
[03:16:33.900] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:97:0)
[03:16:33.919] Build status: STARTED
[03:16:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:98:0) after 6m47s
[03:23:20.965] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:98:0)
[03:23:20.983] Build status: STARTED
[03:23:20.983] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:99:0) after 8m20s
[03:31:41.055] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:99:0)
[03:31:41.077] Build status: STARTED
[03:31:41.077] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:100:0) after 5m51s
[03:37:32.875] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:100:0)
[03:37:32.922] Build status: STARTED
[03:37:32.922] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:101:0) after 5m28s
[03:43:01.208] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:101:0)
[03:43:01.226] Build status: STARTED
[03:43:01.226] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:102:0) after 6m44s
[03:49:45.596] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:102:0)
[03:49:45.614] Build status: STARTED
[03:49:45.614] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:103:0) after 9m23s
[03:59:08.994] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:103:0)
[03:59:09.021] Build status: STARTED
[03:59:09.021] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:104:0) after 4m3s
[04:03:12.040] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:104:0)
[04:03:12.064] Build status: STARTED
[04:03:12.064] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:105:0) after 9m39s
[04:12:51.086] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:105:0)
[04:12:51.108] Build status: STARTED
[04:12:51.108] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:106:0) after 3m55s
[04:16:46.139] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:106:0)
[04:16:46.163] Build status: STARTED
[04:16:46.163] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:107:0) after 3m12s
[04:19:58.357] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:107:0)
[04:19:58.375] Build status: STARTED
[04:19:58.376] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914638113568195776:108:0) after 7m19s
[04:20:04.090] Received PubSub notification, asking Buildbucket for the build status
[04:20:04.114] Build:
{
"id": "8749208050790881921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3289,
"createdBy": "project:chromium",
"createTime": "2024-04-30T18:33:35.273548031Z",
"startTime": "2024-04-30T18:33:43.367313514Z",
"endTime": "2024-05-01T04:20:03.299294716Z",
"updateTime": "2024-05-01T04:20:03.299294716Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7f928273efe064e9ea34f92977f0b1e9551aa97",
"ref": "refs/heads/main"
}
}
}
[04:20:04.114] Invocation finished in 9h46m30.872751219s with status SUCCEEDED