[19:53:59.629] New invocation is queued and will start shortly
[19:54:00.739] Starting the invocation (attempt 1)
[19:54:00.776] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a74faf04aea3f2b67777f3be038450b3abf8e79"
[19:54:00.776] Popped gitiles commit info from properties and tags
[19:54:00.776] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:54:00.776] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:54:00.776] Buildbucket request:
{
"requestId": "8946704378847688240",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a74faf04aea3f2b67777f3be038450b3abf8e79",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946704378847688240"
},
{
"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"
}
}
[19:54:01.170] Scheduled build:
{
"id": "8781274316925956081",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 21522,
"createdBy": "project:chromium",
"createTime": "2023-05-12T19:54:00.837528207Z",
"updateTime": "2023-05-12T19:54:00.837528207Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a74faf04aea3f2b67777f3be038450b3abf8e79",
"ref": "refs/heads/main"
}
}
}
[19:54:01.170] Task URL: https://cr-buildbucket.appspot.com/build/8781274316925956081
[19:54:01.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:2:0) after 2m50s
[19:56:51.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:2:0)
[19:56:51.299] Build status: SCHEDULED
[19:56:51.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:3:0) after 8m56s
[20:05:47.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:3:0)
[20:05:47.370] Build status: SCHEDULED
[20:05:47.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:4:0) after 6m54s
[20:12:41.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:4:0)
[20:12:41.421] Build status: SCHEDULED
[20:12:41.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:5:0) after 4m29s
[20:17:10.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:5:0)
[20:17:10.484] Build status: SCHEDULED
[20:17:10.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:6:0) after 9m56s
[20:21:39.179] Received PubSub notification, asking Buildbucket for the build status
[20:21:39.201] Build status: STARTED
[20:27:06.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:6:0)
[20:27:06.547] Build status: STARTED
[20:27:06.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:8:0) after 6m1s
[20:33:07.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:8:0)
[20:33:07.608] Build status: STARTED
[20:33:07.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:9:0) after 6m45s
[20:39:52.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:9:0)
[20:39:52.678] Build status: STARTED
[20:39:52.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:10:0) after 5m28s
[20:45:20.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:10:0)
[20:45:20.826] Build status: STARTED
[20:45:20.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:11:0) after 2m3s
[20:47:23.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:11:0)
[20:47:23.910] Build status: STARTED
[20:47:23.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:12:0) after 7m44s
[20:55:07.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:12:0)
[20:55:08.018] Build status: STARTED
[20:55:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:13:0) after 7m6s
[21:02:14.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:13:0)
[21:02:14.542] Build status: STARTED
[21:02:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:14:0) after 5m41s
[21:07:55.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:14:0)
[21:07:55.624] Build status: STARTED
[21:07:55.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:15:0) after 3m47s
[21:11:42.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:15:0)
[21:11:42.666] Build status: STARTED
[21:11:42.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:16:0) after 2m37s
[21:14:19.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:16:0)
[21:14:19.945] Build status: STARTED
[21:14:19.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:17:0) after 7m29s
[21:21:49.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:17:0)
[21:21:49.498] Build status: STARTED
[21:21:49.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:18:0) after 9m26s
[21:31:15.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:18:0)
[21:31:15.569] Build status: STARTED
[21:31:15.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:19:0) after 3m41s
[21:34:56.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:19:0)
[21:34:56.660] Build status: STARTED
[21:34:56.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:20:0) after 7m8s
[21:42:04.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:20:0)
[21:42:04.731] Build status: STARTED
[21:42:04.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:21:0) after 6m1s
[21:48:05.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:21:0)
[21:48:05.826] Build status: STARTED
[21:48:05.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:22:0) after 1m27s
[21:49:32.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:22:0)
[21:49:32.952] Build status: STARTED
[21:49:32.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:23:0) after 8m32s
[21:58:04.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:23:0)
[21:58:05.008] Build status: STARTED
[21:58:05.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:24:0) after 6m37s
[22:04:42.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:24:0)
[22:04:42.060] Build status: STARTED
[22:04:42.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:25:0) after 2m20s
[22:07:02.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:25:0)
[22:07:02.571] Build status: STARTED
[22:07:02.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:26:0) after 7m20s
[22:14:22.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:26:0)
[22:14:23.001] Build status: STARTED
[22:14:23.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:27:0) after 8m56s
[22:23:19.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:27:0)
[22:23:19.048] Build status: STARTED
[22:23:19.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:28:0) after 2m20s
[22:25:39.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:28:0)
[22:25:39.194] Build status: STARTED
[22:25:39.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:29:0) after 2m22s
[22:28:01.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:29:0)
[22:28:01.248] Build status: STARTED
[22:28:01.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:30:0) after 2m18s
[22:30:19.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:30:0)
[22:30:19.482] Build status: STARTED
[22:30:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:31:0) after 2m51s
[22:33:11.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:31:0)
[22:33:11.154] Build status: STARTED
[22:33:11.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:32:0) after 9m2s
[22:42:13.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:32:0)
[22:42:13.352] Build status: STARTED
[22:42:13.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:33:0) after 4m13s
[22:46:26.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:33:0)
[22:46:26.406] Build status: STARTED
[22:46:26.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:34:0) after 4m35s
[22:51:01.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:34:0)
[22:51:01.489] Build status: STARTED
[22:51:01.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:35:0) after 4m56s
[22:55:57.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:35:0)
[22:55:57.767] Build status: STARTED
[22:55:57.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:36:0) after 9m28s
[23:05:25.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:36:0)
[23:05:26.013] Build status: STARTED
[23:05:26.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:37:0) after 7m7s
[23:12:33.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:37:0)
[23:12:33.034] Build status: STARTED
[23:12:33.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:38:0) after 4m2s
[23:16:35.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:38:0)
[23:16:35.086] Build status: STARTED
[23:16:35.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:39:0) after 3m21s
[23:19:56.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:39:0)
[23:19:56.208] Build status: STARTED
[23:19:56.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:40:0) after 2m54s
[23:22:50.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:40:0)
[23:22:50.372] Build status: STARTED
[23:22:50.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:41:0) after 2m33s
[23:25:23.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:41:0)
[23:25:23.508] Build status: STARTED
[23:25:23.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:42:0) after 3m24s
[23:28:47.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:42:0)
[23:28:47.734] Build status: STARTED
[23:28:47.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:43:0) after 9m49s
[23:38:36.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:43:0)
[23:38:36.827] Build status: STARTED
[23:38:36.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:44:0) after 1m35s
[23:40:11.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:44:0)
[23:40:11.890] Build status: STARTED
[23:40:11.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:45:0) after 1m26s
[23:41:38.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:45:0)
[23:41:38.424] Build status: STARTED
[23:41:38.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:46:0) after 6m34s
[23:48:12.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:46:0)
[23:48:12.529] Build status: STARTED
[23:48:12.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:47:0) after 8m7s
[23:56:19.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:47:0)
[23:56:19.676] Build status: STARTED
[23:56:19.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:48:0) after 4m53s
[00:01:12.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:48:0)
[00:01:12.929] Build status: STARTED
[00:01:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:49:0) after 1m58s
[00:03:11.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:49:0)
[00:03:11.658] Build status: STARTED
[00:03:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:50:0) after 4m57s
[00:08:08.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:50:0)
[00:08:08.750] Build status: STARTED
[00:08:08.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:51:0) after 6m2s
[00:14:11.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:51:0)
[00:14:11.029] Build status: STARTED
[00:14:11.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:52:0) after 6m15s
[00:20:26.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:52:0)
[00:20:26.108] Build status: STARTED
[00:20:26.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:53:0) after 5m3s
[00:25:29.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:53:0)
[00:25:29.277] Build status: STARTED
[00:25:29.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:54:0) after 5m46s
[00:31:15.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:54:0)
[00:31:15.320] Build status: STARTED
[00:31:15.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:55:0) after 3m34s
[00:34:49.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:55:0)
[00:34:49.797] Build status: STARTED
[00:34:49.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:56:0) after 9m51s
[00:44:41.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:56:0)
[00:44:41.179] Build status: STARTED
[00:44:41.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:57:0) after 9m22s
[00:54:03.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:57:0)
[00:54:03.283] Build status: STARTED
[00:54:03.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:58:0) after 5m37s
[00:59:40.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:58:0)
[00:59:40.349] Build status: STARTED
[00:59:40.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:59:0) after 6m55s
[01:06:35.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:59:0)
[01:06:35.409] Build status: STARTED
[01:06:35.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:60:0) after 5m14s
[01:11:49.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:60:0)
[01:11:49.529] Build status: STARTED
[01:11:49.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:61:0) after 7m3s
[01:18:52.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:61:0)
[01:18:52.554] Build status: STARTED
[01:18:52.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:62:0) after 1m31s
[01:20:23.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:62:0)
[01:20:23.607] Build status: STARTED
[01:20:23.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:63:0) after 7m59s
[01:28:22.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:63:0)
[01:28:22.691] Build status: STARTED
[01:28:22.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:64:0) after 6m5s
[01:34:27.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:64:0)
[01:34:27.691] Build status: STARTED
[01:34:27.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:65:0) after 2m26s
[01:36:53.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:65:0)
[01:36:54.010] Build status: STARTED
[01:36:54.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:66:0) after 7m48s
[01:44:42.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:66:0)
[01:44:42.053] Build status: STARTED
[01:44:42.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:67:0) after 2m10s
[01:46:52.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:67:0)
[01:46:52.103] Build status: STARTED
[01:46:52.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:68:0) after 8m40s
[01:55:32.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:68:0)
[01:55:32.251] Build status: STARTED
[01:55:32.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:69:0) after 9m25s
[02:04:57.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:69:0)
[02:04:57.570] Build status: STARTED
[02:04:57.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:70:0) after 7m25s
[02:12:22.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:70:0)
[02:12:22.625] Build status: STARTED
[02:12:22.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:71:0) after 3m5s
[02:15:27.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:71:0)
[02:15:27.672] Build status: STARTED
[02:15:27.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:72:0) after 3m21s
[02:18:48.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:72:0)
[02:18:48.784] Build status: STARTED
[02:18:48.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:73:0) after 2m33s
[02:21:21.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:73:0)
[02:21:21.835] Build status: STARTED
[02:21:21.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:74:0) after 9m54s
[02:31:16.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:74:0)
[02:31:16.183] Build status: STARTED
[02:31:16.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:75:0) after 3m43s
[02:34:59.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:75:0)
[02:34:59.251] Build status: STARTED
[02:34:59.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:76:0) after 1m59s
[02:36:58.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:76:0)
[02:36:58.321] Build status: STARTED
[02:36:58.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:77:0) after 5m22s
[02:42:20.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:77:0)
[02:42:20.612] Build status: STARTED
[02:42:20.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:78:0) after 4m27s
[02:46:47.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:78:0)
[02:46:47.677] Build status: STARTED
[02:46:47.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:79:0) after 8m33s
[02:55:20.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:79:0)
[02:55:20.731] Build status: STARTED
[02:55:20.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:80:0) after 1m19s
[02:56:39.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:80:0)
[02:56:39.953] Build status: STARTED
[02:56:39.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:81:0) after 7m0s
[03:03:40.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:81:0)
[03:03:40.067] Build status: STARTED
[03:03:40.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:82:0) after 3m6s
[03:06:46.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:82:0)
[03:06:46.905] Build status: STARTED
[03:06:46.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:83:0) after 8m0s
[03:14:47.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:83:0)
[03:14:47.527] Build status: STARTED
[03:14:47.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:84:0) after 7m54s
[03:22:41.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:84:0)
[03:22:41.817] Build status: STARTED
[03:22:41.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:85:0) after 7m46s
[03:30:27.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:85:0)
[03:30:27.937] Build status: STARTED
[03:30:27.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:86:0) after 9m52s
[03:40:20.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:86:0)
[03:40:20.029] Build status: STARTED
[03:40:20.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:87:0) after 3m49s
[03:44:09.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:87:0)
[03:44:09.237] Build status: STARTED
[03:44:09.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:88:0) after 1m16s
[03:45:25.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:88:0)
[03:45:25.384] Build status: STARTED
[03:45:25.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:89:0) after 3m3s
[03:48:28.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:89:0)
[03:48:28.456] Build status: STARTED
[03:48:28.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:90:0) after 8m12s
[03:56:40.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:90:0)
[03:56:40.520] Build status: STARTED
[03:56:40.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:91:0) after 9m53s
[04:06:33.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:91:0)
[04:06:33.606] Build status: STARTED
[04:06:33.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:92:0) after 8m49s
[04:15:22.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:92:0)
[04:15:22.852] Build status: STARTED
[04:15:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:93:0) after 9m13s
[04:24:35.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:93:0)
[04:24:35.927] Build status: STARTED
[04:24:35.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:94:0) after 2m18s
[04:26:53.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:94:0)
[04:26:53.983] Build status: STARTED
[04:26:53.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:95:0) after 3m16s
[04:30:10.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:95:0)
[04:30:10.169] Build status: STARTED
[04:30:10.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:96:0) after 3m29s
[04:33:39.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:96:0)
[04:33:39.249] Build status: STARTED
[04:33:39.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:97:0) after 4m37s
[04:38:16.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:97:0)
[04:38:16.409] Build status: STARTED
[04:38:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:98:0) after 3m49s
[04:42:05.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:98:0)
[04:42:05.473] Build status: STARTED
[04:42:05.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:99:0) after 9m2s
[04:51:07.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:99:0)
[04:51:07.527] Build status: STARTED
[04:51:07.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:100:0) after 4m4s
[04:55:11.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:100:0)
[04:55:11.754] Build status: STARTED
[04:55:11.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:101:0) after 6m22s
[05:01:33.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:101:0)
[05:01:33.808] Build status: STARTED
[05:01:33.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:102:0) after 7m48s
[05:09:21.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:102:0)
[05:09:22.010] Build status: STARTED
[05:09:22.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:103:0) after 4m32s
[05:13:54.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:103:0)
[05:13:54.143] Build status: STARTED
[05:13:54.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:104:0) after 2m1s
[05:15:55.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:104:0)
[05:15:55.346] Build status: STARTED
[05:15:55.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:105:0) after 5m20s
[05:21:15.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:105:0)
[05:21:15.403] Build status: STARTED
[05:21:15.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:106:0) after 5m40s
[05:26:55.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:106:0)
[05:26:55.556] Build status: STARTED
[05:26:55.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:107:0) after 7m24s
[05:34:19.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:107:0)
[05:34:19.617] Build status: STARTED
[05:34:19.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:108:0) after 4m36s
[05:38:55.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:108:0)
[05:38:55.681] Build status: STARTED
[05:38:55.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:109:0) after 6m39s
[05:45:34.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:109:0)
[05:45:34.742] Build status: STARTED
[05:45:34.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:110:0) after 1m3s
[05:46:37.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:110:0)
[05:46:37.803] Build status: STARTED
[05:46:37.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:111:0) after 6m22s
[05:52:59.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:111:0)
[05:52:59.955] Build status: STARTED
[05:52:59.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:8946704378847688240:112:0) after 7m58s
[05:54:18.030] Received PubSub notification, asking Buildbucket for the build status
[05:54:18.050] Build:
{
"id": "8781274316925956081",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Windows deterministic"
},
"number": 21522,
"createdBy": "project:chromium",
"createTime": "2023-05-12T19:54:00.837528207Z",
"startTime": "2023-05-12T20:21:38.629001Z",
"endTime": "2023-05-13T05:54:17.690754227Z",
"updateTime": "2023-05-13T05:54:17.690754227Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a74faf04aea3f2b67777f3be038450b3abf8e79",
"ref": "refs/heads/main"
}
}
}
[05:54:18.050] Invocation finished in 10h0m18.428617776s with status SUCCEEDED