[01:40:16.433] New invocation is queued and will start shortly
[01:40:17.645] Starting the invocation (attempt 1)
[01:40:17.673] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3f1c3d65b5cc61bd0966515eb75e43e8d0a7961"
[01:40:17.673] Popped gitiles commit info from properties and tags
[01:40:17.673] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:40:17.673] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:40:17.673] Buildbucket request:
{
"requestId": "8946591995829279424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b3f1c3d65b5cc61bd0966515eb75e43e8d0a7961",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946591995829279424"
},
{
"key": "scheduler_job_id",
"value": "chromium/Windows deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:40:18.054] Scheduled build:
{
"id": "8781161933802748977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 21525,
"createdBy": "project:chromium",
"createTime": "2023-05-14T01:40:17.736612295Z",
"updateTime": "2023-05-14T01:40:17.736612295Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b3f1c3d65b5cc61bd0966515eb75e43e8d0a7961",
"ref": "refs/heads/main"
}
}
}
[01:40:18.054] Task URL: https://cr-buildbucket.appspot.com/build/8781161933802748977
[01:40:18.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:2:0) after 9m38s
[01:49:56.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:2:0)
[01:49:56.381] Build status: SCHEDULED
[01:49:56.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:3:0) after 4m45s
[01:54:41.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:3:0)
[01:54:41.479] Build status: SCHEDULED
[01:54:41.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:4:0) after 9m57s
[02:04:38.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:4:0)
[02:04:38.794] Build status: SCHEDULED
[02:04:38.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:5:0) after 4m34s
[02:09:12.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:5:0)
[02:09:12.830] Build status: SCHEDULED
[02:09:12.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:6:0) after 7m57s
[02:12:41.846] Received PubSub notification, asking Buildbucket for the build status
[02:12:41.866] Build status: STARTED
[02:17:09.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:6:0)
[02:17:10.015] Build status: STARTED
[02:17:10.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:8:0) after 3m39s
[02:20:50.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:8:0)
[02:20:50.048] Build status: STARTED
[02:20:50.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:9:0) after 6m45s
[02:27:35.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:9:0)
[02:27:35.088] Build status: STARTED
[02:27:35.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:10:0) after 8m26s
[02:36:01.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:10:0)
[02:36:01.632] Build status: STARTED
[02:36:01.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:11:0) after 5m44s
[02:41:45.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:11:0)
[02:41:45.682] Build status: STARTED
[02:41:45.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:12:0) after 5m10s
[02:46:55.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:12:0)
[02:46:55.732] Build status: STARTED
[02:46:55.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:13:0) after 4m27s
[02:51:22.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:13:0)
[02:51:22.852] Build status: STARTED
[02:51:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:14:0) after 9m37s
[03:00:59.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:14:0)
[03:01:00.042] Build status: STARTED
[03:01:00.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:15:0) after 1m42s
[03:02:42.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:15:0)
[03:02:42.265] Build status: STARTED
[03:02:42.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:16:0) after 1m27s
[03:04:09.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:16:0)
[03:04:09.343] Build status: STARTED
[03:04:09.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:17:0) after 3m42s
[03:07:51.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:17:0)
[03:07:51.392] Build status: STARTED
[03:07:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:18:0) after 8m5s
[03:15:56.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:18:0)
[03:15:56.430] Build status: STARTED
[03:15:56.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:19:0) after 2m16s
[03:18:12.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:19:0)
[03:18:12.799] Build status: STARTED
[03:18:12.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:20:0) after 1m41s
[03:19:53.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:20:0)
[03:19:53.843] Build status: STARTED
[03:19:53.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:21:0) after 8m33s
[03:28:26.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:21:0)
[03:28:26.973] Build status: STARTED
[03:28:26.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:22:0) after 7m52s
[03:36:18.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:22:0)
[03:36:19.011] Build status: STARTED
[03:36:19.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:23:0) after 7m18s
[03:43:37.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:23:0)
[03:43:37.039] Build status: STARTED
[03:43:37.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:24:0) after 8m47s
[03:52:25.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:24:0)
[03:52:25.091] Build status: STARTED
[03:52:25.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:25:0) after 1m50s
[03:54:15.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:25:0)
[03:54:15.154] Build status: STARTED
[03:54:15.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:26:0) after 3m23s
[03:57:38.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:26:0)
[03:57:38.206] Build status: STARTED
[03:57:38.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:27:0) after 7m6s
[04:04:44.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:27:0)
[04:04:44.550] Build status: STARTED
[04:04:44.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:28:0) after 5m27s
[04:10:11.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:28:0)
[04:10:11.585] Build status: STARTED
[04:10:11.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:29:0) after 3m16s
[04:13:27.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:29:0)
[04:13:27.749] Build status: STARTED
[04:13:27.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:30:0) after 2m54s
[04:16:21.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:30:0)
[04:16:21.950] Build status: STARTED
[04:16:21.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:31:0) after 8m27s
[04:24:49.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:31:0)
[04:24:49.616] Build status: STARTED
[04:24:49.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:32:0) after 4m58s
[04:29:47.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:32:0)
[04:29:47.657] Build status: STARTED
[04:29:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:33:0) after 2m25s
[04:32:12.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:33:0)
[04:32:12.880] Build status: STARTED
[04:32:12.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:34:0) after 8m57s
[04:41:10.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:34:0)
[04:41:10.103] Build status: STARTED
[04:41:10.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:35:0) after 7m43s
[04:48:53.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:35:0)
[04:48:53.225] Build status: STARTED
[04:48:53.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:36:0) after 5m40s
[04:54:33.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:36:0)
[04:54:33.549] Build status: STARTED
[04:54:33.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:37:0) after 1m53s
[04:56:26.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:37:0)
[04:56:26.592] Build status: STARTED
[04:56:26.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:38:0) after 4m13s
[05:00:39.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:38:0)
[05:00:39.770] Build status: STARTED
[05:00:39.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:39:0) after 3m55s
[05:04:34.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:39:0)
[05:04:34.941] Build status: STARTED
[05:04:34.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:40:0) after 2m42s
[05:07:16.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:40:0)
[05:07:16.983] Build status: STARTED
[05:07:16.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:41:0) after 8m35s
[05:15:52.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:41:0)
[05:15:52.180] Build status: STARTED
[05:15:52.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:42:0) after 3m28s
[05:19:20.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:42:0)
[05:19:20.209] Build status: STARTED
[05:19:20.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:43:0) after 8m35s
[05:27:55.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:43:0)
[05:27:55.359] Build status: STARTED
[05:27:55.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:44:0) after 8m22s
[05:36:17.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:44:0)
[05:36:17.498] Build status: STARTED
[05:36:17.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:45:0) after 4m26s
[05:40:43.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:45:0)
[05:40:43.512] Build status: STARTED
[05:40:43.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:46:0) after 1m2s
[05:41:45.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:46:0)
[05:41:45.553] Build status: STARTED
[05:41:45.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:47:0) after 1m52s
[05:43:37.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:47:0)
[05:43:37.604] Build status: STARTED
[05:43:37.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:48:0) after 1m54s
[05:45:31.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:48:0)
[05:45:31.647] Build status: STARTED
[05:45:31.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:49:0) after 1m3s
[05:46:34.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:49:0)
[05:46:34.781] Build status: STARTED
[05:46:34.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:50:0) after 3m9s
[05:49:43.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:50:0)
[05:49:43.818] Build status: STARTED
[05:49:43.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:51:0) after 8m50s
[05:58:33.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:51:0)
[05:58:33.856] Build status: STARTED
[05:58:33.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:52:0) after 9m21s
[06:07:55.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:52:0)
[06:07:55.050] Build status: STARTED
[06:07:55.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:53:0) after 3m47s
[06:11:42.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:53:0)
[06:11:42.102] Build status: STARTED
[06:11:42.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:54:0) after 6m18s
[06:18:00.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:54:0)
[06:18:00.319] Build status: STARTED
[06:18:00.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:55:0) after 3m40s
[06:21:40.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:55:0)
[06:21:40.456] Build status: STARTED
[06:21:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:56:0) after 4m29s
[06:26:09.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:56:0)
[06:26:09.650] Build status: STARTED
[06:26:09.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:57:0) after 5m8s
[06:31:17.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:57:0)
[06:31:17.799] Build status: STARTED
[06:31:17.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:58:0) after 4m52s
[06:36:10.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:58:0)
[06:36:10.074] Build status: STARTED
[06:36:10.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:59:0) after 1m13s
[06:37:23.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:59:0)
[06:37:23.113] Build status: STARTED
[06:37:23.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:60:0) after 9m28s
[06:46:51.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:60:0)
[06:46:51.146] Build status: STARTED
[06:46:51.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:61:0) after 2m27s
[06:49:18.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:61:0)
[06:49:18.182] Build status: STARTED
[06:49:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:62:0) after 1m28s
[06:50:46.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:62:0)
[06:50:46.340] Build status: STARTED
[06:50:46.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:63:0) after 3m33s
[06:54:19.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:63:0)
[06:54:19.435] Build status: STARTED
[06:54:19.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:64:0) after 1m49s
[06:56:08.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:64:0)
[06:56:08.575] Build status: STARTED
[06:56:08.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:65:0) after 2m35s
[06:58:43.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:65:0)
[06:58:43.748] Build status: STARTED
[06:58:43.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:66:0) after 7m16s
[07:05:59.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:66:0)
[07:05:59.766] Build status: STARTED
[07:05:59.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:67:0) after 5m38s
[07:11:37.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:67:0)
[07:11:37.921] Build status: STARTED
[07:11:37.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:68:0) after 4m14s
[07:15:51.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:68:0)
[07:15:51.990] Build status: STARTED
[07:15:51.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:69:0) after 2m18s
[07:18:10.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:69:0)
[07:18:10.137] Build status: STARTED
[07:18:10.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:70:0) after 9m47s
[07:27:57.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:70:0)
[07:27:57.224] Build status: STARTED
[07:27:57.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:71:0) after 9m12s
[07:37:09.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:71:0)
[07:37:09.340] Build status: STARTED
[07:37:09.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:72:0) after 1m8s
[07:38:17.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:72:0)
[07:38:17.476] Build status: STARTED
[07:38:17.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:73:0) after 1m9s
[07:39:26.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:73:0)
[07:39:26.662] Build status: STARTED
[07:39:26.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:74:0) after 7m8s
[07:46:34.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:74:0)
[07:46:34.694] Build status: STARTED
[07:46:34.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:75:0) after 5m27s
[07:52:01.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:75:0)
[07:52:01.785] Build status: STARTED
[07:52:01.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:76:0) after 7m50s
[07:59:52.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:76:0)
[07:59:52.043] Build status: STARTED
[07:59:52.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:77:0) after 7m2s
[08:06:54.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:77:0)
[08:06:54.083] Build status: STARTED
[08:06:54.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:78:0) after 1m0s
[08:07:54.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:78:0)
[08:07:54.115] Build status: STARTED
[08:07:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:79:0) after 3m32s
[08:11:26.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:79:0)
[08:11:26.178] Build status: STARTED
[08:11:26.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:80:0) after 6m4s
[08:17:30.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:80:0)
[08:17:30.333] Build status: STARTED
[08:17:30.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:81:0) after 7m22s
[08:24:52.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:81:0)
[08:24:52.417] Build status: STARTED
[08:24:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:82:0) after 3m9s
[08:28:01.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:82:0)
[08:28:01.925] Build status: STARTED
[08:28:01.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:83:0) after 4m13s
[08:32:15.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:83:0)
[08:32:15.201] Build status: STARTED
[08:32:15.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:84:0) after 7m12s
[08:39:27.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:84:0)
[08:39:27.313] Build status: STARTED
[08:39:27.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:85:0) after 7m57s
[08:47:24.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:85:0)
[08:47:24.485] Build status: STARTED
[08:47:24.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:86:0) after 9m20s
[08:56:44.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:86:0)
[08:56:44.593] Build status: STARTED
[08:56:44.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:87:0) after 1m46s
[08:58:30.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:87:0)
[08:58:30.599] Build status: STARTED
[08:58:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:88:0) after 3m27s
[09:01:57.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:88:0)
[09:01:57.696] Build status: STARTED
[09:01:57.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:89:0) after 8m58s
[09:10:55.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:89:0)
[09:10:55.694] Build status: STARTED
[09:10:55.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:90:0) after 1m40s
[09:12:35.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:90:0)
[09:12:35.747] Build status: STARTED
[09:12:35.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:91:0) after 2m17s
[09:14:52.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:91:0)
[09:14:52.787] Build status: STARTED
[09:14:52.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:92:0) after 1m42s
[09:16:34.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:92:0)
[09:16:34.829] Build status: STARTED
[09:16:34.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:93:0) after 3m41s
[09:20:15.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:93:0)
[09:20:15.873] Build status: STARTED
[09:20:15.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:94:0) after 7m39s
[09:27:54.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:94:0)
[09:27:54.954] Build status: STARTED
[09:27:54.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:95:0) after 1m19s
[09:29:13.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:95:0)
[09:29:13.990] Build status: STARTED
[09:29:13.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:96:0) after 5m7s
[09:34:21.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:96:0)
[09:34:21.030] Build status: STARTED
[09:34:21.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:97:0) after 8m39s
[09:43:00.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:97:0)
[09:43:00.176] Build status: STARTED
[09:43:00.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:98:0) after 8m47s
[09:51:47.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:98:0)
[09:51:47.231] Build status: STARTED
[09:51:47.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:99:0) after 7m32s
[09:59:19.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:99:0)
[09:59:19.272] Build status: STARTED
[09:59:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:100:0) after 2m58s
[10:02:17.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:100:0)
[10:02:17.313] Build status: STARTED
[10:02:17.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:101:0) after 7m44s
[10:10:01.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:101:0)
[10:10:01.512] Build status: STARTED
[10:10:01.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:102:0) after 4m33s
[10:14:34.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:102:0)
[10:14:34.564] Build status: STARTED
[10:14:34.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:103:0) after 5m33s
[10:20:07.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:103:0)
[10:20:07.762] Build status: STARTED
[10:20:07.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:104:0) after 7m38s
[10:27:45.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:104:0)
[10:27:45.835] Build status: STARTED
[10:27:45.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:105:0) after 9m33s
[10:37:18.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:105:0)
[10:37:19.048] Build status: STARTED
[10:37:19.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:106:0) after 1m34s
[10:38:53.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:106:0)
[10:38:53.162] Build status: STARTED
[10:38:53.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:107:0) after 8m21s
[10:47:14.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:107:0)
[10:47:14.363] Build status: STARTED
[10:47:14.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:108:0) after 1m32s
[10:48:46.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:108:0)
[10:48:46.466] Build status: STARTED
[10:48:46.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:109:0) after 7m59s
[10:56:45.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:109:0)
[10:56:45.503] Build status: STARTED
[10:56:45.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:110:0) after 9m19s
[11:06:05.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:110:0)
[11:06:05.065] Build status: STARTED
[11:06:05.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:111:0) after 8m40s
[11:14:45.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:111:0)
[11:14:45.252] Build status: STARTED
[11:14:45.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:112:0) after 3m51s
[11:18:36.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:112:0)
[11:18:36.305] Build status: STARTED
[11:18:36.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:113:0) after 1m20s
[11:19:56.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:113:0)
[11:19:56.347] Build status: STARTED
[11:19:56.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:114:0) after 8m12s
[11:28:08.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:114:0)
[11:28:08.749] Build status: STARTED
[11:28:08.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:115:0) after 3m23s
[11:31:32.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:115:0)
[11:31:32.045] Build status: STARTED
[11:31:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946591995829279424:116:0) after 8m42s
[11:37:16.853] Received PubSub notification, asking Buildbucket for the build status
[11:37:16.899] Build:
{
"id": "8781161933802748977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 21525,
"createdBy": "project:chromium",
"createTime": "2023-05-14T01:40:17.736612295Z",
"startTime": "2023-05-14T02:12:34.740219Z",
"endTime": "2023-05-14T11:37:16.487053941Z",
"updateTime": "2023-05-14T11:37:16.487053941Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b3f1c3d65b5cc61bd0966515eb75e43e8d0a7961",
"ref": "refs/heads/main"
}
}
}
[11:37:16.899] Invocation finished in 9h57m0.480163756s with status SUCCEEDED