[20:15:29.609] New invocation is queued and will start shortly
[20:15:30.745] Starting the invocation (attempt 1)
[20:15:30.769] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/123d19d0732351879a95d92582303f5f4cdb4954"
[20:15:30.769] Popped gitiles commit info from properties and tags
[20:15:30.769] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:15:30.769] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:15:30.769] Buildbucket request:
{
"requestId": "8909195882121963200",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "123d19d0732351879a95d92582303f5f4cdb4954",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8909195882121963200"
},
{
"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"
}
}
[20:15:31.297] Scheduled build:
{
"id": "8743765820192926577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3525,
"createdBy": "project:chromium",
"createTime": "2024-06-29T20:15:30.819924991Z",
"updateTime": "2024-06-29T20:15:30.819924991Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "123d19d0732351879a95d92582303f5f4cdb4954",
"ref": "refs/heads/main"
}
}
}
[20:15:31.297] Task URL: https://cr-buildbucket.appspot.com/build/8743765820192926577
[20:15:31.297] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:2:0) after 2m20s
[20:15:32.213] Received PubSub notification, asking Buildbucket for the build status
[20:15:32.250] Build status: SCHEDULED
[20:15:38.924] Received PubSub notification, asking Buildbucket for the build status
[20:15:38.951] Build status: STARTED
[20:17:51.353] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:2:0)
[20:17:51.372] Build status: STARTED
[20:17:51.373] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:5:0) after 8m51s
[20:26:42.396] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:5:0)
[20:26:42.413] Build status: STARTED
[20:26:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:6:0) after 6m18s
[20:33:00.480] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:6:0)
[20:33:00.508] Build status: STARTED
[20:33:00.508] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:7:0) after 3m44s
[20:36:44.524] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:7:0)
[20:36:44.542] Build status: STARTED
[20:36:44.542] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:8:0) after 6m32s
[20:43:16.637] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:8:0)
[20:43:16.660] Build status: STARTED
[20:43:16.660] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:9:0) after 1m0s
[20:44:16.707] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:9:0)
[20:44:16.731] Build status: STARTED
[20:44:16.732] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:10:0) after 1m0s
[20:45:16.902] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:10:0)
[20:45:16.923] Build status: STARTED
[20:45:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:11:0) after 8m2s
[20:53:19.137] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:11:0)
[20:53:19.161] Build status: STARTED
[20:53:19.161] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:12:0) after 5m28s
[20:58:47.196] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:12:0)
[20:58:47.220] Build status: STARTED
[20:58:47.220] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:13:0) after 9m17s
[21:08:04.235] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:13:0)
[21:08:04.252] Build status: STARTED
[21:08:04.252] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:14:0) after 3m1s
[21:11:05.269] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:14:0)
[21:11:05.287] Build status: STARTED
[21:11:05.287] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:15:0) after 9m41s
[21:20:46.500] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:15:0)
[21:20:46.518] Build status: STARTED
[21:20:46.518] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:16:0) after 2m28s
[21:23:14.545] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:16:0)
[21:23:14.580] Build status: STARTED
[21:23:14.580] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:17:0) after 4m38s
[21:27:52.714] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:17:0)
[21:27:52.731] Build status: STARTED
[21:27:52.731] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:18:0) after 6m32s
[21:34:24.751] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:18:0)
[21:34:24.781] Build status: STARTED
[21:34:24.781] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:19:0) after 4m3s
[21:38:27.800] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:19:0)
[21:38:27.818] Build status: STARTED
[21:38:27.818] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:20:0) after 1m37s
[21:40:04.943] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:20:0)
[21:40:04.964] Build status: STARTED
[21:40:04.964] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:21:0) after 1m57s
[21:42:01.985] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:21:0)
[21:42:02.101] Build status: STARTED
[21:42:02.101] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:22:0) after 4m35s
[21:46:37.361] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:22:0)
[21:46:37.378] Build status: STARTED
[21:46:37.378] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:23:0) after 3m0s
[21:49:37.534] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:23:0)
[21:49:37.555] Build status: STARTED
[21:49:37.555] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:24:0) after 5m5s
[21:54:42.820] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:24:0)
[21:54:42.839] Build status: STARTED
[21:54:42.839] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:25:0) after 5m30s
[22:00:12.845] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:25:0)
[22:00:12.863] Build status: STARTED
[22:00:12.863] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:26:0) after 6m37s
[22:06:49.880] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:26:0)
[22:06:49.899] Build status: STARTED
[22:06:49.899] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:27:0) after 6m17s
[22:13:07.023] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:27:0)
[22:13:07.048] Build status: STARTED
[22:13:07.048] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:28:0) after 8m27s
[22:21:34.067] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:28:0)
[22:21:34.093] Build status: STARTED
[22:21:34.093] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:29:0) after 4m2s
[22:25:36.117] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:29:0)
[22:25:36.137] Build status: STARTED
[22:25:36.137] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:30:0) after 3m3s
[22:28:39.133] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:30:0)
[22:28:39.151] Build status: STARTED
[22:28:39.151] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:31:0) after 3m14s
[22:31:53.172] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:31:0)
[22:31:53.196] Build status: STARTED
[22:31:53.196] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:32:0) after 5m43s
[22:37:36.315] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:32:0)
[22:37:36.335] Build status: STARTED
[22:37:36.335] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:33:0) after 5m1s
[22:42:37.434] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:33:0)
[22:42:37.452] Build status: STARTED
[22:42:37.452] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:34:0) after 8m38s
[22:51:15.476] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:34:0)
[22:51:15.496] Build status: STARTED
[22:51:15.496] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:35:0) after 6m57s
[22:58:12.721] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:35:0)
[22:58:12.776] Build status: STARTED
[22:58:12.776] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:36:0) after 1m41s
[22:59:53.854] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:36:0)
[22:59:53.902] Build status: STARTED
[22:59:53.902] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:37:0) after 7m33s
[23:07:26.931] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:37:0)
[23:07:26.949] Build status: STARTED
[23:07:26.949] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:38:0) after 9m5s
[23:16:31.980] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:38:0)
[23:16:31.998] Build status: STARTED
[23:16:31.998] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:39:0) after 7m11s
[23:23:43.122] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:39:0)
[23:23:43.146] Build status: STARTED
[23:23:43.146] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:40:0) after 1m58s
[23:25:41.397] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:40:0)
[23:25:41.414] Build status: STARTED
[23:25:41.414] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:41:0) after 6m47s
[23:32:28.428] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:41:0)
[23:32:28.446] Build status: STARTED
[23:32:28.446] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:42:0) after 9m5s
[23:41:33.515] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:42:0)
[23:41:33.561] Build status: STARTED
[23:41:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:43:0) after 8m1s
[23:49:34.580] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:43:0)
[23:49:34.615] Build status: STARTED
[23:49:34.615] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:44:0) after 1m37s
[23:51:11.633] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:44:0)
[23:51:11.655] Build status: STARTED
[23:51:11.655] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:45:0) after 8m5s
[23:59:16.755] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:45:0)
[23:59:16.773] Build status: STARTED
[23:59:16.773] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:46:0) after 9m59s
[00:09:15.795] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:46:0)
[00:09:15.813] Build status: STARTED
[00:09:15.813] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:47:0) after 8m47s
[00:18:02.842] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:47:0)
[00:18:02.858] Build status: STARTED
[00:18:02.858] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:48:0) after 6m40s
[00:24:42.877] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:48:0)
[00:24:42.894] Build status: STARTED
[00:24:42.894] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:49:0) after 4m25s
[00:29:07.966] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:49:0)
[00:29:07.983] Build status: STARTED
[00:29:07.983] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:50:0) after 6m48s
[00:35:56.003] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:50:0)
[00:35:56.061] Build status: STARTED
[00:35:56.061] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:51:0) after 9m55s
[00:45:51.229] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:51:0)
[00:45:51.246] Build status: STARTED
[00:45:51.246] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:52:0) after 9m50s
[00:55:41.235] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:52:0)
[00:55:41.253] Build status: STARTED
[00:55:41.253] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:53:0) after 7m51s
[01:03:32.284] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:53:0)
[01:03:32.315] Build status: STARTED
[01:03:32.315] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:54:0) after 3m3s
[01:06:35.519] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:54:0)
[01:06:35.533] Build status: STARTED
[01:06:35.533] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:55:0) after 9m59s
[01:16:34.537] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:55:0)
[01:16:34.560] Build status: STARTED
[01:16:34.560] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:56:0) after 1m48s
[01:18:22.590] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:56:0)
[01:18:22.609] Build status: STARTED
[01:18:22.609] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:57:0) after 5m11s
[01:23:33.596] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:57:0)
[01:23:33.613] Build status: STARTED
[01:23:33.613] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:58:0) after 5m13s
[01:28:47.029] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:58:0)
[01:28:47.045] Build status: STARTED
[01:28:47.045] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:59:0) after 8m0s
[01:36:47.083] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:59:0)
[01:36:47.099] Build status: STARTED
[01:36:47.099] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:60:0) after 9m27s
[01:46:14.147] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:60:0)
[01:46:14.164] Build status: STARTED
[01:46:14.164] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:61:0) after 2m43s
[01:48:57.184] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:61:0)
[01:48:57.209] Build status: STARTED
[01:48:57.209] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:62:0) after 7m55s
[01:56:52.238] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:62:0)
[01:56:52.288] Build status: STARTED
[01:56:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:63:0) after 7m52s
[02:04:44.307] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:63:0)
[02:04:44.397] Build status: STARTED
[02:04:44.397] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:64:0) after 4m37s
[02:09:21.413] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:64:0)
[02:09:21.429] Build status: STARTED
[02:09:21.429] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:65:0) after 8m47s
[02:18:08.545] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:65:0)
[02:18:08.567] Build status: STARTED
[02:18:08.567] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:66:0) after 7m19s
[02:25:27.698] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:66:0)
[02:25:27.718] Build status: STARTED
[02:25:27.718] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:67:0) after 2m23s
[02:27:50.848] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:67:0)
[02:27:50.872] Build status: STARTED
[02:27:50.872] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:68:0) after 7m13s
[02:35:03.889] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:68:0)
[02:35:03.906] Build status: STARTED
[02:35:03.906] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:69:0) after 8m1s
[02:43:04.935] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:69:0)
[02:43:04.959] Build status: STARTED
[02:43:04.959] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:70:0) after 5m48s
[02:48:53.009] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:70:0)
[02:48:53.026] Build status: STARTED
[02:48:53.026] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:71:0) after 6m27s
[02:55:20.118] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:71:0)
[02:55:20.138] Build status: STARTED
[02:55:20.138] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:72:0) after 4m46s
[03:00:06.182] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:72:0)
[03:00:06.200] Build status: STARTED
[03:00:06.200] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:73:0) after 5m27s
[03:05:33.219] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:73:0)
[03:05:33.238] Build status: STARTED
[03:05:33.238] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:74:0) after 2m21s
[03:07:54.327] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:74:0)
[03:07:54.346] Build status: STARTED
[03:07:54.346] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:75:0) after 2m37s
[03:10:31.386] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:75:0)
[03:10:31.403] Build status: STARTED
[03:10:31.403] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:76:0) after 8m29s
[03:19:00.643] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:76:0)
[03:19:00.659] Build status: STARTED
[03:19:00.659] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:77:0) after 8m10s
[03:27:10.706] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:77:0)
[03:27:10.894] Build status: STARTED
[03:27:10.894] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:78:0) after 5m42s
[03:32:52.914] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:78:0)
[03:32:52.932] Build status: STARTED
[03:32:52.932] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:79:0) after 9m47s
[03:42:40.093] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:79:0)
[03:42:40.190] Build status: STARTED
[03:42:40.190] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:80:0) after 9m10s
[03:51:50.573] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:80:0)
[03:51:50.593] Build status: STARTED
[03:51:50.593] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:81:0) after 3m29s
[03:55:19.815] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:81:0)
[03:55:19.833] Build status: STARTED
[03:55:19.833] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:82:0) after 5m40s
[04:00:59.865] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:82:0)
[04:00:59.904] Build status: STARTED
[04:00:59.904] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:83:0) after 8m24s
[04:09:24.085] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:83:0)
[04:09:24.102] Build status: STARTED
[04:09:24.102] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:84:0) after 5m42s
[04:15:08.096] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:84:0)
[04:15:08.113] Build status: STARTED
[04:15:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:85:0) after 1m48s
[04:16:56.187] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:85:0)
[04:16:56.208] Build status: STARTED
[04:16:56.208] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:86:0) after 4m36s
[04:21:32.230] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:86:0)
[04:21:32.252] Build status: STARTED
[04:21:32.252] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:87:0) after 1m31s
[04:23:03.274] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:87:0)
[04:23:03.293] Build status: STARTED
[04:23:03.293] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:88:0) after 1m10s
[04:24:13.297] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:88:0)
[04:24:13.323] Build status: STARTED
[04:24:13.323] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:89:0) after 3m18s
[04:27:31.581] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:89:0)
[04:27:31.601] Build status: STARTED
[04:27:31.601] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:90:0) after 9m10s
[04:36:41.719] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:90:0)
[04:36:41.800] Build status: STARTED
[04:36:41.800] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:91:0) after 5m18s
[04:41:59.771] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:91:0)
[04:41:59.786] Build status: STARTED
[04:41:59.786] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:92:0) after 7m0s
[04:48:59.826] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:92:0)
[04:48:59.843] Build status: STARTED
[04:48:59.843] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:93:0) after 5m27s
[04:54:26.860] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:93:0)
[04:54:26.880] Build status: STARTED
[04:54:26.880] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:94:0) after 5m7s
[04:59:34.005] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:94:0)
[04:59:34.024] Build status: STARTED
[04:59:34.024] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:95:0) after 9m14s
[05:08:48.096] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:95:0)
[05:08:48.130] Build status: STARTED
[05:08:48.130] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:96:0) after 1m0s
[05:09:48.255] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:96:0)
[05:09:48.282] Build status: STARTED
[05:09:48.282] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:97:0) after 7m40s
[05:17:28.328] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:97:0)
[05:17:28.345] Build status: STARTED
[05:17:28.345] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:98:0) after 3m5s
[05:20:33.362] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:98:0)
[05:20:33.399] Build status: STARTED
[05:20:33.399] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:99:0) after 1m50s
[05:22:23.419] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:99:0)
[05:22:23.438] Build status: STARTED
[05:22:23.438] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:100:0) after 8m13s
[05:30:36.458] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:100:0)
[05:30:36.490] Build status: STARTED
[05:30:36.490] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8909195882121963200:101:0) after 8m38s
[05:35:53.580] Received PubSub notification, asking Buildbucket for the build status
[05:35:53.666] Build:
{
"id": "8743765820192926577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3525,
"createdBy": "project:chromium",
"createTime": "2024-06-29T20:15:30.819924991Z",
"startTime": "2024-06-29T20:15:38.710130834Z",
"endTime": "2024-06-30T05:35:53.331590457Z",
"updateTime": "2024-06-30T05:35:53.331590457Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "123d19d0732351879a95d92582303f5f4cdb4954",
"ref": "refs/heads/main"
}
}
}
[05:35:53.666] Invocation finished in 9h20m24.070658986s with status FAILED