[11:53:20.663] New invocation is queued and will start shortly
[11:53:22.212] Starting the invocation (attempt 1)
[11:53:22.244] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c3d1ee431199dc74407d874f03c9c640d39f9ce5"
[11:53:22.244] Popped gitiles commit info from properties and tags
[11:53:22.244] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:53:22.244] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:53:22.244] Buildbucket request:
{
"requestId": "8961954909057379600",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c3d1ee431199dc74407d874f03c9c640d39f9ce5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8961954909057379600"
},
{
"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"
}
}
[11:53:22.834] Scheduled build:
{
"id": "8796524846647581553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 4244,
"createdBy": "project:chromium",
"createTime": "2022-11-25T11:53:22.330746649Z",
"updateTime": "2022-11-25T11:53:22.330746649Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c3d1ee431199dc74407d874f03c9c640d39f9ce5",
"ref": "refs/heads/main"
}
}
}
[11:53:22.834] Task URL: https://cr-buildbucket.appspot.com/build/8796524846647581553
[11:53:22.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:2:0) after 4m20s
[11:53:24.854] Received PubSub notification, asking Buildbucket for the build status
[11:53:24.877] Build status: STARTED
[11:57:42.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:2:0)
[11:57:42.929] Build status: STARTED
[11:57:42.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:4:0) after 8m35s
[12:06:17.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:4:0)
[12:06:17.985] Build status: STARTED
[12:06:17.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:5:0) after 8m37s
[12:14:55.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:5:0)
[12:14:55.032] Build status: STARTED
[12:14:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:6:0) after 1m50s
[12:16:45.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:6:0)
[12:16:45.144] Build status: STARTED
[12:16:45.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:7:0) after 4m23s
[12:21:08.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:7:0)
[12:21:08.209] Build status: STARTED
[12:21:08.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:8:0) after 2m56s
[12:24:04.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:8:0)
[12:24:04.725] Build status: STARTED
[12:24:04.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:9:0) after 9m16s
[12:33:20.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:9:0)
[12:33:20.808] Build status: STARTED
[12:33:20.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:10:0) after 9m39s
[12:42:59.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:10:0)
[12:42:59.994] Build status: STARTED
[12:42:59.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:11:0) after 6m22s
[12:49:22.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:11:0)
[12:49:22.194] Build status: STARTED
[12:49:22.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:12:0) after 5m46s
[12:55:08.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:12:0)
[12:55:08.345] Build status: STARTED
[12:55:08.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:13:0) after 9m3s
[13:04:11.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:13:0)
[13:04:11.393] Build status: STARTED
[13:04:11.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:14:0) after 3m57s
[13:08:08.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:14:0)
[13:08:08.554] Build status: STARTED
[13:08:08.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:15:0) after 4m35s
[13:12:43.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:15:0)
[13:12:43.619] Build status: STARTED
[13:12:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:16:0) after 5m13s
[13:17:56.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:16:0)
[13:17:56.664] Build status: STARTED
[13:17:56.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:17:0) after 2m58s
[13:20:54.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:17:0)
[13:20:54.708] Build status: STARTED
[13:20:54.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:18:0) after 6m24s
[13:27:18.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:18:0)
[13:27:18.803] Build status: STARTED
[13:27:18.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:19:0) after 7m33s
[13:34:51.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:19:0)
[13:34:51.853] Build status: STARTED
[13:34:51.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:20:0) after 1m49s
[13:36:40.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:20:0)
[13:36:41.008] Build status: STARTED
[13:36:41.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:21:0) after 8m54s
[13:45:35.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:21:0)
[13:45:35.216] Build status: STARTED
[13:45:35.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:22:0) after 4m22s
[13:49:57.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:22:0)
[13:49:57.606] Build status: STARTED
[13:49:57.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:23:0) after 2m35s
[13:52:32.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:23:0)
[13:52:32.901] Build status: STARTED
[13:52:32.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:24:0) after 4m25s
[13:56:57.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:24:0)
[13:56:57.957] Build status: STARTED
[13:56:57.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:25:0) after 9m23s
[14:06:20.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:25:0)
[14:06:21.012] Build status: STARTED
[14:06:21.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:26:0) after 3m47s
[14:10:08.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:26:0)
[14:10:08.106] Build status: STARTED
[14:10:08.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:27:0) after 6m48s
[14:16:56.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:27:0)
[14:16:56.153] Build status: STARTED
[14:16:56.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:28:0) after 7m30s
[14:24:26.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:28:0)
[14:24:26.323] Build status: STARTED
[14:24:26.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:29:0) after 7m13s
[14:31:39.373] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:29:0)
[14:31:39.408] Build status: STARTED
[14:31:39.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:30:0) after 8m0s
[14:39:39.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:30:0)
[14:39:39.455] Build status: STARTED
[14:39:39.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:31:0) after 9m27s
[14:49:06.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:31:0)
[14:49:06.517] Build status: STARTED
[14:49:06.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:32:0) after 7m25s
[14:56:31.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:32:0)
[14:56:31.676] Build status: STARTED
[14:56:31.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:33:0) after 5m13s
[15:01:44.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:33:0)
[15:01:44.953] Build status: STARTED
[15:01:44.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:34:0) after 2m1s
[15:03:46.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:34:0)
[15:03:46.119] Build status: STARTED
[15:03:46.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:35:0) after 2m21s
[15:06:07.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:35:0)
[15:06:07.220] Build status: STARTED
[15:06:07.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:36:0) after 4m40s
[15:10:47.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:36:0)
[15:10:47.595] Build status: STARTED
[15:10:47.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:37:0) after 6m16s
[15:17:03.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:37:0)
[15:17:03.646] Build status: STARTED
[15:17:03.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:38:0) after 2m12s
[15:19:15.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:38:0)
[15:19:15.689] Build status: STARTED
[15:19:15.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:39:0) after 1m31s
[15:20:46.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:39:0)
[15:20:46.823] Build status: STARTED
[15:20:46.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:40:0) after 7m11s
[15:27:57.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:40:0)
[15:27:57.977] Build status: STARTED
[15:27:57.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:41:0) after 7m14s
[15:35:12.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:41:0)
[15:35:12.042] Build status: STARTED
[15:35:12.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:42:0) after 4m1s
[15:39:13.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:42:0)
[15:39:13.145] Build status: STARTED
[15:39:13.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:43:0) after 5m4s
[15:44:17.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:43:0)
[15:44:17.216] Build status: STARTED
[15:44:17.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:44:0) after 3m37s
[15:47:54.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:44:0)
[15:47:54.290] Build status: STARTED
[15:47:54.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:45:0) after 4m40s
[15:52:34.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:45:0)
[15:52:34.333] Build status: STARTED
[15:52:34.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:46:0) after 9m16s
[16:01:50.322] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:46:0)
[16:01:50.349] Build status: STARTED
[16:01:50.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:47:0) after 3m27s
[16:05:17.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:47:0)
[16:05:17.421] Build status: STARTED
[16:05:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:48:0) after 9m40s
[16:14:57.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:48:0)
[16:14:57.716] Build status: STARTED
[16:14:57.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:49:0) after 1m54s
[16:16:51.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:49:0)
[16:16:51.732] Build status: STARTED
[16:16:51.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:50:0) after 8m55s
[16:25:46.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:50:0)
[16:25:46.917] Build status: STARTED
[16:25:46.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:51:0) after 6m24s
[16:32:11.077] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:51:0)
[16:32:11.100] Build status: STARTED
[16:32:11.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:52:0) after 9m3s
[16:41:14.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:52:0)
[16:41:14.193] Build status: STARTED
[16:41:14.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:53:0) after 5m46s
[16:47:00.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:53:0)
[16:47:00.260] Build status: STARTED
[16:47:00.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:54:0) after 3m56s
[16:50:56.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:54:0)
[16:50:56.428] Build status: STARTED
[16:50:56.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:55:0) after 5m54s
[16:56:50.467] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:55:0)
[16:56:50.492] Build status: STARTED
[16:56:50.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:56:0) after 4m9s
[17:00:59.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:56:0)
[17:00:59.531] Build status: STARTED
[17:00:59.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:57:0) after 6m6s
[17:07:05.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:57:0)
[17:07:05.995] Build status: STARTED
[17:07:05.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:58:0) after 8m34s
[17:15:40.065] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:58:0)
[17:15:40.093] Build status: STARTED
[17:15:40.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:59:0) after 9m59s
[17:25:39.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:59:0)
[17:25:39.386] Build status: STARTED
[17:25:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:60:0) after 8m8s
[17:33:47.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:60:0)
[17:33:47.453] Build status: STARTED
[17:33:47.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:61:0) after 7m35s
[17:41:22.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:61:0)
[17:41:22.499] Build status: STARTED
[17:41:22.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:62:0) after 4m19s
[17:45:41.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:62:0)
[17:45:41.632] Build status: STARTED
[17:45:41.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:63:0) after 6m17s
[17:51:58.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:63:0)
[17:51:58.670] Build status: STARTED
[17:51:58.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:64:0) after 9m26s
[18:01:24.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:64:0)
[18:01:24.780] Build status: STARTED
[18:01:24.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:65:0) after 9m44s
[18:11:08.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:65:0)
[18:11:08.861] Build status: STARTED
[18:11:08.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:66:0) after 6m56s
[18:18:04.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:66:0)
[18:18:04.908] Build status: STARTED
[18:18:04.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:67:0) after 9m36s
[18:27:40.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:67:0)
[18:27:40.956] Build status: STARTED
[18:27:40.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:68:0) after 1m46s
[18:29:27.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:68:0)
[18:29:27.042] Build status: STARTED
[18:29:27.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:69:0) after 9m4s
[18:38:31.169] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:69:0)
[18:38:31.212] Build status: STARTED
[18:38:31.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:70:0) after 1m54s
[18:40:25.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:70:0)
[18:40:25.559] Build status: STARTED
[18:40:25.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:71:0) after 3m51s
[18:44:16.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:71:0)
[18:44:16.738] Build status: STARTED
[18:44:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:72:0) after 1m21s
[18:45:37.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:72:0)
[18:45:37.887] Build status: STARTED
[18:45:37.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:73:0) after 1m37s
[18:47:15.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:73:0)
[18:47:15.076] Build status: STARTED
[18:47:15.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:74:0) after 2m38s
[18:49:53.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:74:0)
[18:49:53.407] Build status: STARTED
[18:49:53.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:75:0) after 4m53s
[18:54:46.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:75:0)
[18:54:46.578] Build status: STARTED
[18:54:46.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:76:0) after 3m18s
[18:58:04.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:76:0)
[18:58:04.617] Build status: STARTED
[18:58:04.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:77:0) after 6m51s
[19:04:55.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:77:0)
[19:04:55.736] Build status: STARTED
[19:04:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:78:0) after 2m51s
[19:07:46.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:78:0)
[19:07:46.886] Build status: STARTED
[19:07:46.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:79:0) after 3m47s
[19:11:34.219] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:79:0)
[19:11:34.241] Build status: STARTED
[19:11:34.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:80:0) after 7m13s
[19:18:47.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:80:0)
[19:18:47.291] Build status: STARTED
[19:18:47.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:81:0) after 9m43s
[19:28:30.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:81:0)
[19:28:30.581] Build status: STARTED
[19:28:30.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:82:0) after 9m10s
[19:37:40.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:82:0)
[19:37:40.638] Build status: STARTED
[19:37:40.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:83:0) after 7m13s
[19:44:53.781] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:83:0)
[19:44:53.810] Build status: STARTED
[19:44:53.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:84:0) after 1m4s
[19:45:57.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:84:0)
[19:45:57.966] Build status: STARTED
[19:45:57.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:85:0) after 7m53s
[19:53:50.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:85:0)
[19:53:51.028] Build status: STARTED
[19:53:51.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:86:0) after 9m1s
[20:02:52.148] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:86:0)
[20:02:52.172] Build status: STARTED
[20:02:52.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:87:0) after 9m17s
[20:12:09.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:87:0)
[20:12:09.320] Build status: STARTED
[20:12:09.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:88:0) after 9m43s
[20:21:52.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:88:0)
[20:21:52.374] Build status: STARTED
[20:21:52.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:89:0) after 7m37s
[20:29:29.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:89:0)
[20:29:29.396] Build status: STARTED
[20:29:29.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:90:0) after 3m44s
[20:33:13.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:90:0)
[20:33:13.453] Build status: STARTED
[20:33:13.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:91:0) after 9m8s
[20:42:21.491] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:91:0)
[20:42:21.514] Build status: STARTED
[20:42:21.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:92:0) after 3m28s
[20:45:49.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:92:0)
[20:45:49.677] Build status: STARTED
[20:45:49.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:93:0) after 4m11s
[20:50:00.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:93:0)
[20:50:00.721] Build status: STARTED
[20:50:00.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:94:0) after 2m30s
[20:52:30.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:94:0)
[20:52:30.783] Build status: STARTED
[20:52:30.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:95:0) after 3m53s
[20:56:23.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:95:0)
[20:56:23.835] Build status: STARTED
[20:56:23.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:96:0) after 5m29s
[21:01:52.959] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:96:0)
[21:01:52.983] Build status: STARTED
[21:01:52.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:97:0) after 5m33s
[21:07:26.006] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:97:0)
[21:07:26.030] Build status: STARTED
[21:07:26.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:98:0) after 3m43s
[21:11:09.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:98:0)
[21:11:09.078] Build status: STARTED
[21:11:09.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8961954909057379600:99:0) after 1m22s
[21:11:17.479] Received PubSub notification, asking Buildbucket for the build status
[21:11:17.510] Build:
{
"id": "8796524846647581553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 4244,
"createdBy": "project:chromium",
"createTime": "2022-11-25T11:53:22.330746649Z",
"startTime": "2022-11-25T11:53:24.117509Z",
"endTime": "2022-11-25T21:11:17.269812058Z",
"updateTime": "2022-11-25T21:11:17.269812058Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c3d1ee431199dc74407d874f03c9c640d39f9ce5",
"ref": "refs/heads/main"
}
}
}
[21:11:17.511] Invocation finished in 9h17m56.861708499s with status FAILED