[13:17:19.653] New invocation is queued and will start shortly
[13:17:20.859] Starting the invocation (attempt 1)
[13:17:20.892] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99c7b4e31e240c1bc4703c9c175eaf7372c73ee3"
[13:17:20.892] Popped gitiles commit info from properties and tags
[13:17:20.892] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:17:20.892] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:17:20.892] Buildbucket request:
{
"requestId": "8949266049997426560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99c7b4e31e240c1bc4703c9c175eaf7372c73ee3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949266049997426560"
},
{
"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:17:21.369] Scheduled build:
{
"id": "8783835987971701633",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5170,
"createdBy": "project:chromium",
"createTime": "2023-04-14T13:17:20.954872113Z",
"updateTime": "2023-04-14T13:17:20.954872113Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99c7b4e31e240c1bc4703c9c175eaf7372c73ee3",
"ref": "refs/heads/main"
}
}
}
[13:17:21.369] Task URL: https://cr-buildbucket.appspot.com/build/8783835987971701633
[13:17:21.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:2:0) after 5m44s
[13:17:59.354] Received PubSub notification, asking Buildbucket for the build status
[13:17:59.384] Build status: STARTED
[13:23:05.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:2:0)
[13:23:06.000] Build status: STARTED
[13:23:06.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:4:0) after 4m41s
[13:27:47.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:4:0)
[13:27:47.298] Build status: STARTED
[13:27:47.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:5:0) after 6m43s
[13:34:30.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:5:0)
[13:34:30.977] Build status: STARTED
[13:34:30.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:6:0) after 7m16s
[13:41:47.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:6:0)
[13:41:47.324] Build status: STARTED
[13:41:47.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:7:0) after 8m46s
[13:50:33.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:7:0)
[13:50:33.535] Build status: STARTED
[13:50:33.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:8:0) after 3m56s
[13:54:29.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:8:0)
[13:54:29.748] Build status: STARTED
[13:54:29.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:9:0) after 4m37s
[13:59:06.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:9:0)
[13:59:06.786] Build status: STARTED
[13:59:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:10:0) after 3m46s
[14:02:52.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:10:0)
[14:02:52.993] Build status: STARTED
[14:02:52.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:11:0) after 2m25s
[14:05:18.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:11:0)
[14:05:18.243] Build status: STARTED
[14:05:18.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:12:0) after 1m22s
[14:06:40.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:12:0)
[14:06:40.380] Build status: STARTED
[14:06:40.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:13:0) after 4m30s
[14:11:10.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:13:0)
[14:11:10.406] Build status: STARTED
[14:11:10.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:14:0) after 7m47s
[14:18:57.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:14:0)
[14:18:57.640] Build status: STARTED
[14:18:57.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:15:0) after 7m36s
[14:26:33.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:15:0)
[14:26:33.794] Build status: STARTED
[14:26:33.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:16:0) after 2m8s
[14:28:41.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:16:0)
[14:28:41.883] Build status: STARTED
[14:28:41.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:17:0) after 6m19s
[14:35:01.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:17:0)
[14:35:01.081] Build status: STARTED
[14:35:01.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:18:0) after 4m52s
[14:39:53.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:18:0)
[14:39:53.132] Build status: STARTED
[14:39:53.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:19:0) after 4m29s
[14:44:22.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:19:0)
[14:44:22.214] Build status: STARTED
[14:44:22.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:20:0) after 6m38s
[14:51:00.329] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:20:0)
[14:51:00.429] Build status: STARTED
[14:51:00.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:21:0) after 2m56s
[14:53:56.455] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:21:0)
[14:53:56.475] Build status: STARTED
[14:53:56.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:22:0) after 7m54s
[15:01:50.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:22:0)
[15:01:50.716] Build status: STARTED
[15:01:50.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:23:0) after 9m10s
[15:11:00.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:23:0)
[15:11:00.975] Build status: STARTED
[15:11:00.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:24:0) after 5m17s
[15:16:18.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:24:0)
[15:16:18.474] Build status: STARTED
[15:16:18.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:25:0) after 2m45s
[15:19:03.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:25:0)
[15:19:04.015] Build status: STARTED
[15:19:04.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:26:0) after 9m17s
[15:28:21.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:26:0)
[15:28:21.085] Build status: STARTED
[15:28:21.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:27:0) after 8m25s
[15:36:46.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:27:0)
[15:36:46.221] Build status: STARTED
[15:36:46.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:28:0) after 2m10s
[15:38:56.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:28:0)
[15:38:56.297] Build status: STARTED
[15:38:56.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:29:0) after 7m32s
[15:46:28.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:29:0)
[15:46:28.484] Build status: STARTED
[15:46:28.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:30:0) after 9m34s
[15:56:02.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:30:0)
[15:56:02.574] Build status: STARTED
[15:56:02.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:31:0) after 5m17s
[16:01:19.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:31:0)
[16:01:19.654] Build status: STARTED
[16:01:19.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:32:0) after 4m49s
[16:06:08.675] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:32:0)
[16:06:08.694] Build status: STARTED
[16:06:08.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:33:0) after 3m26s
[16:09:35.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:33:0)
[16:09:35.024] Build status: STARTED
[16:09:35.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:34:0) after 6m4s
[16:15:39.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:34:0)
[16:15:39.486] Build status: STARTED
[16:15:39.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:35:0) after 6m46s
[16:22:25.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:35:0)
[16:22:25.783] Build status: STARTED
[16:22:25.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:36:0) after 1m32s
[16:23:57.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:36:0)
[16:23:57.872] Build status: STARTED
[16:23:57.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:37:0) after 5m58s
[16:29:56.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:37:0)
[16:29:56.085] Build status: STARTED
[16:29:56.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:38:0) after 6m13s
[16:36:09.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:38:0)
[16:36:09.571] Build status: STARTED
[16:36:09.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:39:0) after 8m7s
[16:44:16.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:39:0)
[16:44:16.919] Build status: STARTED
[16:44:16.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:40:0) after 2m14s
[16:46:31.068] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:40:0)
[16:46:31.088] Build status: STARTED
[16:46:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:41:0) after 6m21s
[16:52:52.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:41:0)
[16:52:52.506] Build status: STARTED
[16:52:52.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:42:0) after 2m16s
[16:55:08.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:42:0)
[16:55:08.775] Build status: STARTED
[16:55:08.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:43:0) after 9m5s
[17:04:13.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:43:0)
[17:04:13.956] Build status: STARTED
[17:04:13.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:44:0) after 4m49s
[17:09:03.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:44:0)
[17:09:03.233] Build status: STARTED
[17:09:03.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:45:0) after 7m29s
[17:16:32.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:45:0)
[17:16:32.797] Build status: STARTED
[17:16:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:46:0) after 4m46s
[17:21:18.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:46:0)
[17:21:18.896] Build status: STARTED
[17:21:18.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:47:0) after 7m13s
[17:28:32.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:47:0)
[17:28:32.084] Build status: STARTED
[17:28:32.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:48:0) after 2m49s
[17:31:21.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:48:0)
[17:31:21.123] Build status: STARTED
[17:31:21.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:49:0) after 8m32s
[17:39:53.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:49:0)
[17:39:53.300] Build status: STARTED
[17:39:53.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:50:0) after 7m12s
[17:47:05.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:50:0)
[17:47:05.968] Build status: STARTED
[17:47:05.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:51:0) after 2m17s
[17:49:23.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:51:0)
[17:49:23.493] Build status: STARTED
[17:49:23.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:52:0) after 1m44s
[17:51:07.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:52:0)
[17:51:07.640] Build status: STARTED
[17:51:07.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:53:0) after 2m0s
[17:53:07.818] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:53:0)
[17:53:07.840] Build status: STARTED
[17:53:07.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:54:0) after 5m46s
[17:58:53.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:54:0)
[17:58:53.944] Build status: STARTED
[17:58:53.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:55:0) after 3m46s
[18:02:40.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:55:0)
[18:02:40.213] Build status: STARTED
[18:02:40.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:56:0) after 9m33s
[18:12:13.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:56:0)
[18:12:13.262] Build status: STARTED
[18:12:13.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:57:0) after 7m35s
[18:19:48.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:57:0)
[18:19:48.386] Build status: STARTED
[18:19:48.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:58:0) after 4m54s
[18:24:42.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:58:0)
[18:24:42.626] Build status: STARTED
[18:24:42.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:59:0) after 8m18s
[18:33:00.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:59:0)
[18:33:00.695] Build status: STARTED
[18:33:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:60:0) after 4m39s
[18:37:39.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:60:0)
[18:37:39.820] Build status: STARTED
[18:37:39.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:61:0) after 5m32s
[18:43:11.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:61:0)
[18:43:11.864] Build status: STARTED
[18:43:11.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:62:0) after 3m46s
[18:46:57.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:62:0)
[18:46:57.904] Build status: STARTED
[18:46:57.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:63:0) after 6m46s
[18:53:44.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:63:0)
[18:53:44.180] Build status: STARTED
[18:53:44.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:64:0) after 9m21s
[19:03:05.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:64:0)
[19:03:05.205] Build status: STARTED
[19:03:05.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:65:0) after 3m38s
[19:06:43.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:65:0)
[19:06:43.562] Build status: STARTED
[19:06:43.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:66:0) after 3m56s
[19:10:39.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:66:0)
[19:10:39.717] Build status: STARTED
[19:10:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:67:0) after 6m25s
[19:17:05.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:67:0)
[19:17:05.236] Build status: STARTED
[19:17:05.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:68:0) after 5m59s
[19:23:04.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:68:0)
[19:23:04.318] Build status: STARTED
[19:23:04.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:69:0) after 4m28s
[19:27:32.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:69:0)
[19:27:32.357] Build status: STARTED
[19:27:32.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:70:0) after 4m6s
[19:31:38.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:70:0)
[19:31:38.748] Build status: STARTED
[19:31:38.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:71:0) after 4m49s
[19:36:27.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:71:0)
[19:36:27.857] Build status: STARTED
[19:36:27.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:72:0) after 9m51s
[19:46:18.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:72:0)
[19:46:18.993] Build status: STARTED
[19:46:18.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:73:0) after 3m47s
[19:50:06.354] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:73:0)
[19:50:06.374] Build status: STARTED
[19:50:06.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:74:0) after 3m7s
[19:53:13.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:74:0)
[19:53:13.515] Build status: STARTED
[19:53:13.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:75:0) after 2m23s
[19:55:37.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:75:0)
[19:55:37.269] Build status: STARTED
[19:55:37.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:76:0) after 7m43s
[20:03:20.247] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:76:0)
[20:03:20.283] Build status: STARTED
[20:03:20.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:77:0) after 6m52s
[20:10:12.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:77:0)
[20:10:12.514] Build status: STARTED
[20:10:12.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:78:0) after 3m58s
[20:14:10.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:78:0)
[20:14:10.566] Build status: STARTED
[20:14:10.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:79:0) after 8m4s
[20:22:14.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:79:0)
[20:22:14.601] Build status: STARTED
[20:22:14.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:80:0) after 5m39s
[20:27:53.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:80:0)
[20:27:53.749] Build status: STARTED
[20:27:53.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:81:0) after 1m6s
[20:28:59.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:81:0)
[20:28:59.833] Build status: STARTED
[20:28:59.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:82:0) after 1m16s
[20:30:16.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:82:0)
[20:30:16.630] Build status: STARTED
[20:30:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:83:0) after 4m56s
[20:35:12.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:83:0)
[20:35:12.716] Build status: STARTED
[20:35:12.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:84:0) after 9m7s
[20:44:19.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:84:0)
[20:44:19.831] Build status: STARTED
[20:44:19.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:85:0) after 9m26s
[20:53:45.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:85:0)
[20:53:46.004] Build status: STARTED
[20:53:46.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:86:0) after 5m38s
[20:59:24.148] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:86:0)
[20:59:24.168] Build status: STARTED
[20:59:24.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:87:0) after 5m20s
[21:04:44.594] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:87:0)
[21:04:44.613] Build status: STARTED
[21:04:44.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:88:0) after 8m28s
[21:13:12.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:88:0)
[21:13:12.659] Build status: STARTED
[21:13:12.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:89:0) after 7m33s
[21:20:45.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:89:0)
[21:20:45.700] Build status: STARTED
[21:20:45.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:90:0) after 1m47s
[21:22:32.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:90:0)
[21:22:32.786] Build status: STARTED
[21:22:32.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:91:0) after 7m9s
[21:29:42.008] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:91:0)
[21:29:42.038] Build status: STARTED
[21:29:42.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:92:0) after 7m51s
[21:37:33.399] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:92:0)
[21:37:33.420] Build status: STARTED
[21:37:33.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:93:0) after 7m0s
[21:44:33.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:93:0)
[21:44:33.574] Build status: STARTED
[21:44:33.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:94:0) after 8m54s
[21:53:27.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:94:0)
[21:53:27.691] Build status: STARTED
[21:53:27.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:95:0) after 1m45s
[21:55:12.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:95:0)
[21:55:12.833] Build status: STARTED
[21:55:12.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:96:0) after 4m39s
[21:59:51.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:96:0)
[21:59:51.879] Build status: STARTED
[21:59:51.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:97:0) after 9m51s
[22:09:43.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:97:0)
[22:09:43.045] Build status: STARTED
[22:09:43.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:98:0) after 9m54s
[22:19:37.419] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:98:0)
[22:19:37.447] Build status: STARTED
[22:19:37.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:99:0) after 7m26s
[22:27:03.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:99:0)
[22:27:03.449] Build status: STARTED
[22:27:03.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:100:0) after 7m42s
[22:34:45.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:100:0)
[22:34:45.503] Build status: STARTED
[22:34:45.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:101:0) after 3m2s
[22:37:47.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:101:0)
[22:37:47.708] Build status: STARTED
[22:37:47.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:102:0) after 6m59s
[22:44:46.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:102:0)
[22:44:46.914] Build status: STARTED
[22:44:46.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:103:0) after 4m9s
[22:48:56.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:103:0)
[22:48:56.138] Build status: STARTED
[22:48:56.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:104:0) after 9m58s
[22:58:54.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:104:0)
[22:58:54.219] Build status: STARTED
[22:58:54.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:105:0) after 6m57s
[23:05:51.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:105:0)
[23:05:51.327] Build status: STARTED
[23:05:51.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:106:0) after 5m13s
[23:11:04.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:106:0)
[23:11:04.403] Build status: STARTED
[23:11:04.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:107:0) after 8m8s
[23:19:12.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:107:0)
[23:19:12.719] Build status: STARTED
[23:19:12.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:108:0) after 3m33s
[23:22:46.102] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:108:0)
[23:22:46.133] Build status: STARTED
[23:22:46.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:109:0) after 8m5s
[23:30:51.160] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:109:0)
[23:30:51.187] Build status: STARTED
[23:30:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:110:0) after 2m37s
[23:33:28.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:110:0)
[23:33:28.331] Build status: STARTED
[23:33:28.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:111:0) after 5m56s
[23:39:24.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:111:0)
[23:39:24.401] Build status: STARTED
[23:39:24.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:112:0) after 6m9s
[23:45:34.184] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:112:0)
[23:45:34.202] Build status: STARTED
[23:45:34.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:113:0) after 7m8s
[23:52:42.229] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:113:0)
[23:52:42.252] Build status: STARTED
[23:52:42.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:114:0) after 8m35s
[00:01:17.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:114:0)
[00:01:17.506] Build status: STARTED
[00:01:17.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:115:0) after 3m55s
[00:05:12.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:115:0)
[00:05:12.552] Build status: STARTED
[00:05:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8949266049997426560:116:0) after 9m33s
[00:08:19.667] Received PubSub notification, asking Buildbucket for the build status
[00:08:19.690] Build:
{
"id": "8783835987971701633",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5170,
"createdBy": "project:chromium",
"createTime": "2023-04-14T13:17:20.954872113Z",
"startTime": "2023-04-14T13:17:58.868488Z",
"endTime": "2023-04-15T00:08:19.140992120Z",
"updateTime": "2023-04-15T00:08:19.140992120Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99c7b4e31e240c1bc4703c9c175eaf7372c73ee3",
"ref": "refs/heads/main"
}
}
}
[00:08:19.690] Invocation finished in 10h51m0.051085568s with status FAILED