[19:38:30.244] New invocation is queued and will start shortly
[19:38:31.397] Starting the invocation (attempt 1)
[19:38:31.427] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f23eb59e847f43317e7ae4611c9da57b76d2355a"
[19:38:31.427] Popped gitiles commit info from properties and tags
[19:38:31.427] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:38:31.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:38:31.428] Buildbucket request:
{
"requestId": "8914996415142450032",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f23eb59e847f43317e7ae4611c9da57b76d2355a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914996415142450032"
},
{
"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"
}
}
[19:38:32.092] Scheduled build:
{
"id": "8749566353183621873",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3271,
"createdBy": "project:chromium",
"createTime": "2024-04-26T19:38:31.484485687Z",
"updateTime": "2024-04-26T19:38:31.484485687Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f23eb59e847f43317e7ae4611c9da57b76d2355a",
"ref": "refs/heads/main"
}
}
}
[19:38:32.092] Task URL: https://cr-buildbucket.appspot.com/build/8749566353183621873
[19:38:32.092] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:2:0) after 5m8s
[19:38:32.999] Received PubSub notification, asking Buildbucket for the build status
[19:38:33.014] Build status: SCHEDULED
[19:40:02.433] Received PubSub notification, asking Buildbucket for the build status
[19:40:02.484] Build status: STARTED
[19:43:40.116] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:2:0)
[19:43:40.152] Build status: STARTED
[19:43:40.152] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:5:0) after 8m2s
[19:51:42.292] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:5:0)
[19:51:42.315] Build status: STARTED
[19:51:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:6:0) after 7m48s
[19:59:30.332] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:6:0)
[19:59:30.365] Build status: STARTED
[19:59:30.365] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:7:0) after 1m20s
[20:00:50.390] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:7:0)
[20:00:50.421] Build status: STARTED
[20:00:50.421] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:8:0) after 5m48s
[20:06:38.489] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:8:0)
[20:06:38.514] Build status: STARTED
[20:06:38.514] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:9:0) after 6m20s
[20:12:58.567] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:9:0)
[20:12:58.586] Build status: STARTED
[20:12:58.586] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:10:0) after 4m29s
[20:17:27.614] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:10:0)
[20:17:27.654] Build status: STARTED
[20:17:27.654] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:11:0) after 6m8s
[20:23:35.709] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:11:0)
[20:23:35.760] Build status: STARTED
[20:23:35.760] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:12:0) after 2m5s
[20:25:40.801] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:12:0)
[20:25:40.858] Build status: STARTED
[20:25:40.858] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:13:0) after 5m34s
[20:31:14.901] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:13:0)
[20:31:14.926] Build status: STARTED
[20:31:14.926] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:14:0) after 9m48s
[20:41:02.954] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:14:0)
[20:41:02.974] Build status: STARTED
[20:41:02.974] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:15:0) after 3m55s
[20:44:58.000] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:15:0)
[20:44:58.056] Build status: STARTED
[20:44:58.056] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:16:0) after 5m58s
[20:50:56.111] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:16:0)
[20:50:56.193] Build status: STARTED
[20:50:56.193] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:17:0) after 5m8s
[20:56:04.252] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:17:0)
[20:56:04.270] Build status: STARTED
[20:56:04.270] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:18:0) after 7m35s
[21:03:39.310] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:18:0)
[21:03:39.333] Build status: STARTED
[21:03:39.333] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:19:0) after 3m34s
[21:07:13.421] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:19:0)
[21:07:13.441] Build status: STARTED
[21:07:13.441] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:20:0) after 6m7s
[21:13:20.491] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:20:0)
[21:13:20.577] Build status: STARTED
[21:13:20.577] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:21:0) after 4m18s
[21:17:38.604] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:21:0)
[21:17:38.635] Build status: STARTED
[21:17:38.635] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:22:0) after 4m41s
[21:22:19.799] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:22:0)
[21:22:19.909] Build status: STARTED
[21:22:19.909] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:23:0) after 7m37s
[21:29:57.000] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:23:0)
[21:29:57.019] Build status: STARTED
[21:29:57.019] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:24:0) after 6m52s
[21:36:49.104] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:24:0)
[21:36:49.125] Build status: STARTED
[21:36:49.125] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:25:0) after 2m8s
[21:38:57.151] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:25:0)
[21:38:57.173] Build status: STARTED
[21:38:57.173] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:26:0) after 3m21s
[21:42:18.247] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:26:0)
[21:42:18.275] Build status: STARTED
[21:42:18.276] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:27:0) after 6m53s
[21:49:11.411] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:27:0)
[21:49:11.433] Build status: STARTED
[21:49:11.433] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:28:0) after 6m26s
[21:55:37.506] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:28:0)
[21:55:37.538] Build status: STARTED
[21:55:37.538] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:29:0) after 1m20s
[21:56:57.615] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:29:0)
[21:56:57.636] Build status: STARTED
[21:56:57.636] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:30:0) after 9m22s
[22:06:19.657] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:30:0)
[22:06:19.676] Build status: STARTED
[22:06:19.676] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:31:0) after 2m54s
[22:09:13.696] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:31:0)
[22:09:13.711] Build status: STARTED
[22:09:13.711] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:32:0) after 4m16s
[22:13:29.860] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:32:0)
[22:13:29.925] Build status: STARTED
[22:13:29.925] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:33:0) after 5m7s
[22:18:36.958] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:33:0)
[22:18:36.997] Build status: STARTED
[22:18:36.997] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:34:0) after 4m1s
[22:22:38.018] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:34:0)
[22:22:38.057] Build status: STARTED
[22:22:38.057] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:35:0) after 2m46s
[22:25:24.080] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:35:0)
[22:25:24.237] Build status: STARTED
[22:25:24.237] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:36:0) after 1m46s
[22:27:10.294] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:36:0)
[22:27:10.309] Build status: STARTED
[22:27:10.309] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:37:0) after 7m17s
[22:34:27.357] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:37:0)
[22:34:27.384] Build status: STARTED
[22:34:27.384] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:38:0) after 8m12s
[22:42:39.435] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:38:0)
[22:42:39.452] Build status: STARTED
[22:42:39.452] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:39:0) after 3m54s
[22:46:33.540] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:39:0)
[22:46:33.569] Build status: STARTED
[22:46:33.569] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:40:0) after 1m59s
[22:48:32.609] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:40:0)
[22:48:32.627] Build status: STARTED
[22:48:32.627] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:41:0) after 6m46s
[22:55:18.652] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:41:0)
[22:55:18.683] Build status: STARTED
[22:55:18.683] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:42:0) after 2m30s
[22:57:48.706] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:42:0)
[22:57:48.736] Build status: STARTED
[22:57:48.736] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:43:0) after 5m48s
[23:03:36.758] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:43:0)
[23:03:36.860] Build status: STARTED
[23:03:36.860] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:44:0) after 6m13s
[23:09:49.901] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:44:0)
[23:09:49.956] Build status: STARTED
[23:09:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:45:0) after 6m41s
[23:16:31.001] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:45:0)
[23:16:31.036] Build status: STARTED
[23:16:31.036] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:46:0) after 2m24s
[23:18:55.024] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:46:0)
[23:18:55.077] Build status: STARTED
[23:18:55.077] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:47:0) after 1m9s
[23:20:04.073] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:47:0)
[23:20:04.095] Build status: STARTED
[23:20:04.096] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:48:0) after 3m38s
[23:23:42.087] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:48:0)
[23:23:42.114] Build status: STARTED
[23:23:42.114] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:49:0) after 7m35s
[23:31:17.161] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:49:0)
[23:31:17.178] Build status: STARTED
[23:31:17.178] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:50:0) after 4m34s
[23:35:51.283] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:50:0)
[23:35:51.302] Build status: STARTED
[23:35:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:51:0) after 8m24s
[23:44:15.333] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:51:0)
[23:44:15.352] Build status: STARTED
[23:44:15.352] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:52:0) after 2m54s
[23:47:09.444] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:52:0)
[23:47:09.464] Build status: STARTED
[23:47:09.464] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:53:0) after 4m2s
[23:51:11.710] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:53:0)
[23:51:11.730] Build status: STARTED
[23:51:11.730] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:54:0) after 5m29s
[23:56:41.191] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:54:0)
[23:56:41.215] Build status: STARTED
[23:56:41.215] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:55:0) after 1m37s
[23:58:18.670] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:55:0)
[23:58:18.687] Build status: STARTED
[23:58:18.687] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:56:0) after 8m7s
[00:06:25.711] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:56:0)
[00:06:25.731] Build status: STARTED
[00:06:25.731] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:57:0) after 9m37s
[00:16:02.822] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:57:0)
[00:16:02.934] Build status: STARTED
[00:16:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:58:0) after 4m38s
[00:20:40.904] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:58:0)
[00:20:40.922] Build status: STARTED
[00:20:40.922] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:59:0) after 3m58s
[00:24:38.943] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:59:0)
[00:24:38.966] Build status: STARTED
[00:24:38.966] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:60:0) after 3m42s
[00:28:20.989] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:60:0)
[00:28:21.009] Build status: STARTED
[00:28:21.009] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:61:0) after 2m48s
[00:31:09.075] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:61:0)
[00:31:09.103] Build status: STARTED
[00:31:09.103] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:62:0) after 5m56s
[00:37:05.152] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:62:0)
[00:37:05.183] Build status: STARTED
[00:37:05.183] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:63:0) after 2m2s
[00:39:07.277] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:63:0)
[00:39:07.317] Build status: STARTED
[00:39:07.317] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:64:0) after 7m39s
[00:46:46.497] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:64:0)
[00:46:46.520] Build status: STARTED
[00:46:46.520] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:65:0) after 8m19s
[00:55:05.545] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:65:0)
[00:55:05.609] Build status: STARTED
[00:55:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:66:0) after 1m46s
[00:56:51.634] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:66:0)
[00:56:51.658] Build status: STARTED
[00:56:51.658] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:67:0) after 8m30s
[01:05:21.761] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:67:0)
[01:05:21.779] Build status: STARTED
[01:05:21.779] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:68:0) after 1m14s
[01:06:35.814] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:68:0)
[01:06:35.927] Build status: STARTED
[01:06:35.927] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:69:0) after 8m22s
[01:14:58.109] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:69:0)
[01:14:58.160] Build status: STARTED
[01:14:58.160] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:70:0) after 4m1s
[01:18:59.283] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:70:0)
[01:18:59.299] Build status: STARTED
[01:18:59.299] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:71:0) after 6m8s
[01:25:07.377] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:71:0)
[01:25:07.399] Build status: STARTED
[01:25:07.399] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:72:0) after 2m33s
[01:27:40.788] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:72:0)
[01:27:40.808] Build status: STARTED
[01:27:40.809] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:73:0) after 9m33s
[01:37:14.043] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:73:0)
[01:37:14.077] Build status: STARTED
[01:37:14.077] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:74:0) after 8m30s
[01:45:44.104] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:74:0)
[01:45:44.131] Build status: STARTED
[01:45:44.131] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:75:0) after 7m20s
[01:53:04.390] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:75:0)
[01:53:04.407] Build status: STARTED
[01:53:04.408] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:76:0) after 5m10s
[01:58:14.604] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:76:0)
[01:58:14.626] Build status: STARTED
[01:58:14.626] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:77:0) after 8m45s
[02:06:59.645] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:77:0)
[02:06:59.660] Build status: STARTED
[02:06:59.660] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:78:0) after 1m29s
[02:08:28.747] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:78:0)
[02:08:28.779] Build status: STARTED
[02:08:28.779] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:79:0) after 6m30s
[02:14:58.864] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:79:0)
[02:14:58.886] Build status: STARTED
[02:14:58.886] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:80:0) after 6m17s
[02:21:15.869] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:80:0)
[02:21:15.901] Build status: STARTED
[02:21:15.901] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:81:0) after 6m24s
[02:27:40.135] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:81:0)
[02:27:40.227] Build status: STARTED
[02:27:40.227] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:82:0) after 6m30s
[02:34:10.300] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:82:0)
[02:34:10.327] Build status: STARTED
[02:34:10.327] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:83:0) after 2m22s
[02:36:32.393] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:83:0)
[02:36:32.467] Build status: STARTED
[02:36:32.467] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:84:0) after 4m52s
[02:41:24.542] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:84:0)
[02:41:24.561] Build status: STARTED
[02:41:24.561] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:85:0) after 4m34s
[02:45:58.584] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:85:0)
[02:45:58.624] Build status: STARTED
[02:45:58.626] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:86:0) after 6m53s
[02:52:51.681] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:86:0)
[02:52:51.700] Build status: STARTED
[02:52:51.700] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:87:0) after 9m33s
[03:02:24.725] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:87:0)
[03:02:24.769] Build status: STARTED
[03:02:24.769] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:88:0) after 4m53s
[03:07:18.017] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:88:0)
[03:07:18.094] Build status: STARTED
[03:07:18.094] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:89:0) after 3m46s
[03:11:04.551] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:89:0)
[03:11:04.575] Build status: STARTED
[03:11:04.575] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:90:0) after 2m35s
[03:13:40.179] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:90:0)
[03:13:40.197] Build status: STARTED
[03:13:40.197] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:91:0) after 5m17s
[03:18:57.216] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:91:0)
[03:18:57.244] Build status: STARTED
[03:18:57.244] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:92:0) after 4m41s
[03:23:38.450] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:92:0)
[03:23:38.514] Build status: STARTED
[03:23:38.514] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:93:0) after 3m32s
[03:27:11.037] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:93:0)
[03:27:11.065] Build status: STARTED
[03:27:11.065] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:94:0) after 2m30s
[03:29:41.112] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:94:0)
[03:29:41.134] Build status: STARTED
[03:29:41.134] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:95:0) after 6m19s
[03:36:00.156] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:95:0)
[03:36:00.175] Build status: STARTED
[03:36:00.175] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:96:0) after 3m33s
[03:39:33.208] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:96:0)
[03:39:33.246] Build status: STARTED
[03:39:33.246] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:97:0) after 3m53s
[03:43:26.672] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:97:0)
[03:43:26.688] Build status: STARTED
[03:43:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:98:0) after 5m52s
[03:49:18.754] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:98:0)
[03:49:18.774] Build status: STARTED
[03:49:18.774] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:99:0) after 9m56s
[03:59:14.798] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:99:0)
[03:59:14.835] Build status: STARTED
[03:59:14.835] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:100:0) after 5m28s
[04:04:42.836] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:100:0)
[04:04:42.853] Build status: STARTED
[04:04:42.854] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:101:0) after 8m8s
[04:12:50.875] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:101:0)
[04:12:50.979] Build status: STARTED
[04:12:50.979] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:102:0) after 8m25s
[04:21:16.082] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:102:0)
[04:21:16.113] Build status: STARTED
[04:21:16.113] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:103:0) after 6m26s
[04:27:42.152] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:103:0)
[04:27:42.218] Build status: STARTED
[04:27:42.218] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:104:0) after 3m16s
[04:30:58.387] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:104:0)
[04:30:58.407] Build status: STARTED
[04:30:58.407] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:105:0) after 4m34s
[04:35:32.527] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:105:0)
[04:35:32.549] Build status: STARTED
[04:35:32.549] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:106:0) after 2m44s
[04:38:16.533] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:106:0)
[04:38:16.559] Build status: STARTED
[04:38:16.559] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:107:0) after 3m43s
[04:41:59.807] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:107:0)
[04:41:59.828] Build status: STARTED
[04:41:59.828] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:108:0) after 7m4s
[04:49:04.114] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:108:0)
[04:49:04.132] Build status: STARTED
[04:49:04.132] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:109:0) after 2m24s
[04:51:28.256] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:109:0)
[04:51:28.274] Build status: STARTED
[04:51:28.274] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:110:0) after 4m14s
[04:55:42.294] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:110:0)
[04:55:42.315] Build status: STARTED
[04:55:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:111:0) after 2m53s
[04:58:35.330] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:111:0)
[04:58:35.349] Build status: STARTED
[04:58:35.349] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:112:0) after 3m0s
[05:01:35.479] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:112:0)
[05:01:35.496] Build status: STARTED
[05:01:35.496] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:113:0) after 2m33s
[05:04:08.519] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:113:0)
[05:04:08.545] Build status: STARTED
[05:04:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:114:0) after 5m15s
[05:09:23.590] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:114:0)
[05:09:23.618] Build status: STARTED
[05:09:23.619] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:115:0) after 5m32s
[05:14:55.843] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:115:0)
[05:14:55.868] Build status: STARTED
[05:14:55.868] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:116:0) after 9m41s
[05:24:36.886] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:116:0)
[05:24:36.921] Build status: STARTED
[05:24:36.921] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:117:0) after 1m33s
[05:26:09.945] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:117:0)
[05:26:09.989] Build status: STARTED
[05:26:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:118:0) after 2m45s
[05:28:55.023] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:118:0)
[05:28:55.053] Build status: STARTED
[05:28:55.053] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:119:0) after 6m33s
[05:35:28.074] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:119:0)
[05:35:28.096] Build status: STARTED
[05:35:28.096] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:120:0) after 4m15s
[05:39:43.458] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:120:0)
[05:39:43.550] Build status: STARTED
[05:39:43.550] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:121:0) after 2m30s
[05:42:13.817] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:121:0)
[05:42:13.836] Build status: STARTED
[05:42:13.836] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:122:0) after 6m48s
[05:49:01.857] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:122:0)
[05:49:01.875] Build status: STARTED
[05:49:01.875] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:123:0) after 2m54s
[05:51:55.905] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:123:0)
[05:51:55.976] Build status: STARTED
[05:51:55.976] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:124:0) after 5m36s
[05:57:31.995] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:124:0)
[05:57:32.036] Build status: STARTED
[05:57:32.036] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:125:0) after 1m22s
[05:58:54.063] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:125:0)
[05:58:54.091] Build status: STARTED
[05:58:54.091] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:126:0) after 7m46s
[06:06:40.209] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:126:0)
[06:06:40.232] Build status: STARTED
[06:06:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:127:0) after 1m40s
[06:08:20.332] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:127:0)
[06:08:20.353] Build status: STARTED
[06:08:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:128:0) after 5m9s
[06:13:29.388] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:128:0)
[06:13:29.417] Build status: STARTED
[06:13:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:129:0) after 6m23s
[06:19:52.562] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:129:0)
[06:19:52.631] Build status: STARTED
[06:19:52.631] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:130:0) after 4m55s
[06:24:47.649] Handling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:130:0)
[06:24:47.710] Build status: STARTED
[06:24:47.710] Scheduling timer "check-buildbucket-build-status" (chromium/win10-rel-no-external-ip:8914996415142450032:131:0) after 4m33s
[06:28:20.518] Received PubSub notification, asking Buildbucket for the build status
[06:28:20.531] Build:
{
"id": "8749566353183621873",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-rel-no-external-ip"
},
"number": 3271,
"createdBy": "project:chromium",
"createTime": "2024-04-26T19:38:31.484485687Z",
"startTime": "2024-04-26T19:40:02.179284082Z",
"endTime": "2024-04-27T06:28:20.135012699Z",
"updateTime": "2024-04-27T06:28:20.135012699Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f23eb59e847f43317e7ae4611c9da57b76d2355a",
"ref": "refs/heads/main"
}
}
}
[06:28:20.531] Invocation finished in 10h49m50.299441731s with status SUCCEEDED