[13:56:47.389] New invocation is queued and will start shortly
[13:56:48.498] Starting the invocation (attempt 1)
[13:56:48.537] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/119766f27d6b233d5507959c7ace0985f03c54dc"
[13:56:48.537] Popped gitiles commit info from properties and tags
[13:56:48.537] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:56:48.537] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:56:48.537] Buildbucket request:
{
"requestId": "8870263012540589424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "119766f27d6b233d5507959c7ace0985f03c54dc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870263012540589424"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64PGO"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:56:49.133] Scheduled build:
{
"id": "8704832950507400721",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 12407,
"createdBy": "project:chromium",
"createTime": "2025-09-02T13:56:48.702310833Z",
"updateTime": "2025-09-02T13:56:48.702310833Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "119766f27d6b233d5507959c7ace0985f03c54dc",
"ref": "refs/heads/main"
}
}
}
[13:56:49.133] Task URL: https://cr-buildbucket.appspot.com/build/8704832950507400721
[13:56:49.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:2:0) after 3m1s
[13:56:49.218] Received PubSub notification, asking Buildbucket for the build status
[13:56:49.243] Build status: SCHEDULED
[13:59:50.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:2:0)
[13:59:50.181] Build status: SCHEDULED
[13:59:50.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:4:0) after 9m48s
[14:09:38.204] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:4:0)
[14:09:38.240] Build status: SCHEDULED
[14:09:38.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:5:0) after 6m17s
[14:15:55.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:5:0)
[14:15:55.277] Build status: SCHEDULED
[14:15:55.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:6:0) after 5m32s
[14:16:18.172] Received PubSub notification, asking Buildbucket for the build status
[14:16:18.193] Build status: STARTED
[14:21:27.299] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:6:0)
[14:21:27.315] Build status: STARTED
[14:21:27.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:8:0) after 6m17s
[14:27:44.341] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:8:0)
[14:27:44.358] Build status: STARTED
[14:27:44.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:9:0) after 8m49s
[14:36:33.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:9:0)
[14:36:33.410] Build status: STARTED
[14:36:33.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:10:0) after 3m54s
[14:40:27.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:10:0)
[14:40:27.496] Build status: STARTED
[14:40:27.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:11:0) after 1m37s
[14:42:04.524] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:11:0)
[14:42:04.596] Build status: STARTED
[14:42:04.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:12:0) after 9m50s
[14:51:54.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:12:0)
[14:51:54.861] Build status: STARTED
[14:51:54.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:13:0) after 5m26s
[14:57:20.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:13:0)
[14:57:20.977] Build status: STARTED
[14:57:20.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:14:0) after 7m32s
[15:04:53.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:14:0)
[15:04:53.081] Build status: STARTED
[15:04:53.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:15:0) after 7m44s
[15:12:37.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:15:0)
[15:12:37.146] Build status: STARTED
[15:12:37.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:16:0) after 7m30s
[15:20:07.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:16:0)
[15:20:07.241] Build status: STARTED
[15:20:07.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:17:0) after 3m6s
[15:23:13.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:17:0)
[15:23:13.283] Build status: STARTED
[15:23:13.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:18:0) after 8m20s
[15:31:33.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:18:0)
[15:31:33.342] Build status: STARTED
[15:31:33.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:19:0) after 2m21s
[15:33:54.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:19:0)
[15:33:54.448] Build status: STARTED
[15:33:54.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:20:0) after 4m12s
[15:38:06.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:20:0)
[15:38:06.533] Build status: STARTED
[15:38:06.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:21:0) after 3m29s
[15:41:35.527] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:21:0)
[15:41:35.542] Build status: STARTED
[15:41:35.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:22:0) after 1m18s
[15:42:53.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:22:0)
[15:42:53.586] Build status: STARTED
[15:42:53.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:23:0) after 4m32s
[15:47:25.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:23:0)
[15:47:25.681] Build status: STARTED
[15:47:25.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:24:0) after 9m40s
[15:57:05.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:24:0)
[15:57:05.767] Build status: STARTED
[15:57:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:25:0) after 4m29s
[16:01:34.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:25:0)
[16:01:34.819] Build status: STARTED
[16:01:34.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:26:0) after 8m30s
[16:10:04.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:26:0)
[16:10:04.946] Build status: STARTED
[16:10:04.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:27:0) after 3m28s
[16:13:33.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:27:0)
[16:13:33.039] Build status: STARTED
[16:13:33.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:28:0) after 8m20s
[16:21:53.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:28:0)
[16:21:53.093] Build status: STARTED
[16:21:53.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:29:0) after 3m21s
[16:25:14.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:29:0)
[16:25:14.146] Build status: STARTED
[16:25:14.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:30:0) after 1m13s
[16:26:27.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:30:0)
[16:26:27.187] Build status: STARTED
[16:26:27.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:31:0) after 2m36s
[16:29:03.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:31:0)
[16:29:03.238] Build status: STARTED
[16:29:03.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:32:0) after 5m57s
[16:35:00.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:32:0)
[16:35:00.272] Build status: STARTED
[16:35:00.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:33:0) after 8m17s
[16:43:17.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:33:0)
[16:43:17.537] Build status: STARTED
[16:43:17.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:34:0) after 3m55s
[16:47:12.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:34:0)
[16:47:12.574] Build status: STARTED
[16:47:12.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:35:0) after 8m17s
[16:55:29.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:35:0)
[16:55:29.657] Build status: STARTED
[16:55:29.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:36:0) after 9m14s
[17:04:43.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:36:0)
[17:04:43.726] Build status: STARTED
[17:04:43.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:37:0) after 6m12s
[17:10:55.756] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:37:0)
[17:10:55.784] Build status: STARTED
[17:10:55.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:38:0) after 8m35s
[17:19:30.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:38:0)
[17:19:30.822] Build status: STARTED
[17:19:30.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:39:0) after 8m55s
[17:28:25.893] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:39:0)
[17:28:25.911] Build status: STARTED
[17:28:25.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:40:0) after 4m59s
[17:33:24.930] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:40:0)
[17:33:24.947] Build status: STARTED
[17:33:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:41:0) after 2m45s
[17:36:09.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:41:0)
[17:36:09.985] Build status: STARTED
[17:36:09.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:42:0) after 1m48s
[17:37:58.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:42:0)
[17:37:58.128] Build status: STARTED
[17:37:58.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:43:0) after 4m25s
[17:42:24.592] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:43:0)
[17:42:24.629] Build status: STARTED
[17:42:24.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:44:0) after 2m40s
[17:45:04.651] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:44:0)
[17:45:04.677] Build status: STARTED
[17:45:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:45:0) after 4m50s
[17:49:54.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:45:0)
[17:49:54.759] Build status: STARTED
[17:49:54.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:46:0) after 6m37s
[17:56:31.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:46:0)
[17:56:31.843] Build status: STARTED
[17:56:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:47:0) after 5m45s
[18:02:16.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:47:0)
[18:02:17.045] Build status: STARTED
[18:02:17.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:48:0) after 5m12s
[18:07:29.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:48:0)
[18:07:29.090] Build status: STARTED
[18:07:29.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:49:0) after 7m52s
[18:15:21.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:49:0)
[18:15:21.131] Build status: STARTED
[18:15:21.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:50:0) after 6m24s
[18:21:45.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:50:0)
[18:21:45.235] Build status: STARTED
[18:21:45.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:51:0) after 6m0s
[18:27:45.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:51:0)
[18:27:45.315] Build status: STARTED
[18:27:45.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:52:0) after 9m48s
[18:37:33.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:52:0)
[18:37:33.403] Build status: STARTED
[18:37:33.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:53:0) after 1m27s
[18:39:00.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:53:0)
[18:39:00.447] Build status: STARTED
[18:39:00.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:54:0) after 5m8s
[18:44:08.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:54:0)
[18:44:08.510] Build status: STARTED
[18:44:08.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:55:0) after 1m32s
[18:45:40.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:55:0)
[18:45:40.635] Build status: STARTED
[18:45:40.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:56:0) after 6m9s
[18:51:49.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:56:0)
[18:51:49.752] Build status: STARTED
[18:51:49.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:57:0) after 9m22s
[19:01:11.787] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:57:0)
[19:01:11.810] Build status: STARTED
[19:01:11.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:58:0) after 8m46s
[19:09:57.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:58:0)
[19:09:57.945] Build status: STARTED
[19:09:57.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:59:0) after 7m11s
[19:17:08.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:59:0)
[19:17:08.986] Build status: STARTED
[19:17:08.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:60:0) after 8m54s
[19:26:03.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:60:0)
[19:26:03.100] Build status: STARTED
[19:26:03.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:61:0) after 6m50s
[19:32:53.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:61:0)
[19:32:53.151] Build status: STARTED
[19:32:53.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:62:0) after 8m22s
[19:41:15.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:62:0)
[19:41:15.247] Build status: STARTED
[19:41:15.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:63:0) after 9m53s
[19:51:08.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:63:0)
[19:51:08.334] Build status: STARTED
[19:51:08.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:64:0) after 7m57s
[19:59:05.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:64:0)
[19:59:05.433] Build status: STARTED
[19:59:05.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:65:0) after 8m33s
[20:07:38.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:65:0)
[20:07:38.511] Build status: STARTED
[20:07:38.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:66:0) after 1m43s
[20:09:21.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:66:0)
[20:09:21.657] Build status: STARTED
[20:09:21.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:67:0) after 3m13s
[20:12:34.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:67:0)
[20:12:34.704] Build status: STARTED
[20:12:34.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:68:0) after 4m27s
[20:17:01.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:68:0)
[20:17:01.776] Build status: STARTED
[20:17:01.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:69:0) after 5m8s
[20:22:09.875] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:69:0)
[20:22:09.904] Build status: STARTED
[20:22:09.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:70:0) after 9m25s
[20:31:34.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:70:0)
[20:31:34.944] Build status: STARTED
[20:31:34.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:71:0) after 8m25s
[20:40:00.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:71:0)
[20:40:00.048] Build status: STARTED
[20:40:00.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:72:0) after 6m38s
[20:46:38.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:72:0)
[20:46:38.050] Build status: STARTED
[20:46:38.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:73:0) after 3m44s
[20:50:22.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:73:0)
[20:50:22.100] Build status: STARTED
[20:50:22.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:74:0) after 1m6s
[20:51:28.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:74:0)
[20:51:28.170] Build status: STARTED
[20:51:28.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:75:0) after 4m22s
[20:55:50.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:75:0)
[20:55:50.208] Build status: STARTED
[20:55:50.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:76:0) after 1m0s
[20:56:50.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:76:0)
[20:56:50.265] Build status: STARTED
[20:56:50.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:77:0) after 4m10s
[21:01:00.284] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:77:0)
[21:01:00.299] Build status: STARTED
[21:01:00.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:78:0) after 8m36s
[21:09:36.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:78:0)
[21:09:36.361] Build status: STARTED
[21:09:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:79:0) after 6m32s
[21:16:08.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:79:0)
[21:16:08.412] Build status: STARTED
[21:16:08.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:80:0) after 7m40s
[21:23:48.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:80:0)
[21:23:48.544] Build status: STARTED
[21:23:48.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:81:0) after 3m22s
[21:27:10.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:81:0)
[21:27:10.585] Build status: STARTED
[21:27:10.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:82:0) after 7m4s
[21:34:14.659] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:82:0)
[21:34:14.691] Build status: STARTED
[21:34:14.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:83:0) after 5m39s
[21:39:53.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:83:0)
[21:39:53.732] Build status: STARTED
[21:39:53.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:84:0) after 8m21s
[21:48:14.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:84:0)
[21:48:14.739] Build status: STARTED
[21:48:14.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:85:0) after 6m37s
[21:54:51.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:85:0)
[21:54:51.781] Build status: STARTED
[21:54:51.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:86:0) after 4m52s
[21:59:43.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:86:0)
[21:59:43.875] Build status: STARTED
[21:59:43.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:87:0) after 7m14s
[22:06:57.899] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:87:0)
[22:06:57.935] Build status: STARTED
[22:06:57.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:88:0) after 5m26s
[22:12:24.006] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:88:0)
[22:12:24.065] Build status: STARTED
[22:12:24.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:89:0) after 8m58s
[22:21:22.104] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:89:0)
[22:21:22.131] Build status: STARTED
[22:21:22.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:90:0) after 9m3s
[22:30:25.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:90:0)
[22:30:25.190] Build status: STARTED
[22:30:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:91:0) after 4m51s
[22:35:16.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:91:0)
[22:35:16.233] Build status: STARTED
[22:35:16.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:92:0) after 9m15s
[22:44:31.256] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:92:0)
[22:44:31.272] Build status: STARTED
[22:44:31.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:93:0) after 2m58s
[22:47:29.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:93:0)
[22:47:29.420] Build status: STARTED
[22:47:29.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:94:0) after 8m29s
[22:55:58.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:94:0)
[22:55:58.673] Build status: STARTED
[22:55:58.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:95:0) after 5m1s
[23:00:59.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:95:0)
[23:00:59.850] Build status: STARTED
[23:00:59.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:96:0) after 1m0s
[23:01:59.883] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:96:0)
[23:01:59.903] Build status: STARTED
[23:01:59.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:97:0) after 5m10s
[23:07:09.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:97:0)
[23:07:09.928] Build status: STARTED
[23:07:09.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:98:0) after 6m35s
[23:13:44.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:98:0)
[23:13:45.062] Build status: STARTED
[23:13:45.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:99:0) after 5m32s
[23:19:17.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:99:0)
[23:19:17.247] Build status: STARTED
[23:19:17.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:100:0) after 8m11s
[23:27:28.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:100:0)
[23:27:28.338] Build status: STARTED
[23:27:28.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:101:0) after 6m22s
[23:33:50.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:101:0)
[23:33:50.509] Build status: STARTED
[23:33:50.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:102:0) after 4m43s
[23:38:33.533] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:102:0)
[23:38:33.547] Build status: STARTED
[23:38:33.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:103:0) after 9m52s
[23:48:25.638] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:103:0)
[23:48:25.667] Build status: STARTED
[23:48:25.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:104:0) after 6m1s
[23:54:26.782] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:104:0)
[23:54:26.918] Build status: STARTED
[23:54:26.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:105:0) after 9m30s
[00:03:56.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:105:0)
[00:03:56.994] Build status: STARTED
[00:03:56.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:106:0) after 1m19s
[00:05:15.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:106:0)
[00:05:16.010] Build status: STARTED
[00:05:16.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:107:0) after 4m25s
[00:09:41.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:107:0)
[00:09:41.144] Build status: STARTED
[00:09:41.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:108:0) after 1m19s
[00:11:00.267] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:108:0)
[00:11:00.287] Build status: STARTED
[00:11:00.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:109:0) after 1m38s
[00:12:38.322] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:109:0)
[00:12:38.341] Build status: STARTED
[00:12:38.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:110:0) after 4m16s
[00:16:54.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:110:0)
[00:16:54.407] Build status: STARTED
[00:16:54.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:111:0) after 1m13s
[00:18:07.471] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:111:0)
[00:18:07.490] Build status: STARTED
[00:18:07.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:112:0) after 6m30s
[00:24:37.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:112:0)
[00:24:37.545] Build status: STARTED
[00:24:37.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:113:0) after 5m59s
[00:30:36.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:113:0)
[00:30:36.592] Build status: STARTED
[00:30:36.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:114:0) after 5m37s
[00:36:13.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:114:0)
[00:36:13.595] Build status: STARTED
[00:36:13.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:115:0) after 7m27s
[00:43:40.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:115:0)
[00:43:40.864] Build status: STARTED
[00:43:40.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:116:0) after 4m14s
[00:47:54.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:116:0)
[00:47:54.858] Build status: STARTED
[00:47:54.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:117:0) after 5m22s
[00:53:16.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:117:0)
[00:53:16.916] Build status: STARTED
[00:53:16.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:118:0) after 8m12s
[01:01:28.977] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:118:0)
[01:01:28.999] Build status: STARTED
[01:01:28.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:119:0) after 1m39s
[01:03:08.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:119:0)
[01:03:08.085] Build status: STARTED
[01:03:08.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:120:0) after 6m3s
[01:09:11.158] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:120:0)
[01:09:11.182] Build status: STARTED
[01:09:11.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:121:0) after 8m39s
[01:17:50.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:121:0)
[01:17:50.340] Build status: STARTED
[01:17:50.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:122:0) after 2m12s
[01:20:02.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:122:0)
[01:20:02.428] Build status: STARTED
[01:20:02.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:123:0) after 1m14s
[01:21:16.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:123:0)
[01:21:16.470] Build status: STARTED
[01:21:16.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:124:0) after 8m55s
[01:30:11.491] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:124:0)
[01:30:11.511] Build status: STARTED
[01:30:11.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:125:0) after 9m43s
[01:39:54.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:125:0)
[01:39:54.571] Build status: STARTED
[01:39:54.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:126:0) after 2m31s
[01:42:25.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:126:0)
[01:42:25.740] Build status: STARTED
[01:42:25.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:127:0) after 9m45s
[01:52:10.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:127:0)
[01:52:10.832] Build status: STARTED
[01:52:10.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:128:0) after 3m50s
[01:56:00.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:128:0)
[01:56:00.988] Build status: STARTED
[01:56:00.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:129:0) after 4m25s
[02:00:26.008] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:129:0)
[02:00:26.115] Build status: STARTED
[02:00:26.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:130:0) after 6m16s
[02:06:42.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:130:0)
[02:06:42.198] Build status: STARTED
[02:06:42.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:131:0) after 1m26s
[02:08:08.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:131:0)
[02:08:08.377] Build status: STARTED
[02:08:08.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:132:0) after 4m23s
[02:12:31.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:132:0)
[02:12:31.458] Build status: STARTED
[02:12:31.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8870263012540589424:133:0) after 5m4s
[02:14:43.933] Received PubSub notification, asking Buildbucket for the build status
[02:14:43.965] Build:
{
"id": "8704832950507400721",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 12407,
"createdBy": "project:chromium",
"createTime": "2025-09-02T13:56:48.702310833Z",
"startTime": "2025-09-02T14:16:17.271633429Z",
"endTime": "2025-09-03T02:14:43.667626700Z",
"updateTime": "2025-09-03T02:14:43.667626700Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "119766f27d6b233d5507959c7ace0985f03c54dc",
"ref": "refs/heads/main"
}
}
}
[02:14:43.965] Invocation finished in 12h17m56.586066394s with status SUCCEEDED