[16:55:58.786] New invocation is queued and will start shortly
[16:56:01.467] Starting the invocation (attempt 1)
[16:56:01.513] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ee883d2006628b38adf97e185568255060af6d91"
[16:56:01.513] Popped gitiles commit info from properties and tags
[16:56:01.513] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:56:01.513] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:56:01.513] Buildbucket request:
{
"requestId": "8977518547116402336",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee883d2006628b38adf97e185568255060af6d91",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977518547116402336"
},
{
"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"
}
}
[16:56:02.097] Scheduled build:
{
"id": "8812088483462087873",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2644,
"createdBy": "project:chromium",
"createTime": "2022-06-06T16:56:01.630726794Z",
"updateTime": "2022-06-06T16:56:01.630726794Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee883d2006628b38adf97e185568255060af6d91",
"ref": "refs/heads/main"
}
}
}
[16:56:02.097] Task URL: https://cr-buildbucket.appspot.com/build/8812088483462087873
[16:56:02.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:2:0) after 8m52s
[17:00:26.489] Received PubSub notification, asking Buildbucket for the build status
[17:00:26.525] Build status: STARTED
[17:04:54.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:2:0)
[17:04:54.152] Build status: STARTED
[17:04:54.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:4:0) after 3m5s
[17:07:59.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:4:0)
[17:07:59.287] Build status: STARTED
[17:07:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:5:0) after 7m44s
[17:15:43.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:5:0)
[17:15:43.382] Build status: STARTED
[17:15:43.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:6:0) after 3m57s
[17:19:40.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:6:0)
[17:19:40.394] Build status: STARTED
[17:19:40.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:7:0) after 3m10s
[17:22:50.541] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:7:0)
[17:22:50.575] Build status: STARTED
[17:22:50.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:8:0) after 4m4s
[17:26:54.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:8:0)
[17:26:54.680] Build status: STARTED
[17:26:54.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:9:0) after 9m53s
[17:36:47.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:9:0)
[17:36:47.828] Build status: STARTED
[17:36:47.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:10:0) after 3m14s
[17:40:02.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:10:0)
[17:40:02.346] Build status: STARTED
[17:40:02.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:11:0) after 6m3s
[17:46:05.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:11:0)
[17:46:05.602] Build status: STARTED
[17:46:05.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:12:0) after 5m39s
[17:51:45.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:12:0)
[17:51:45.636] Build status: STARTED
[17:51:45.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:13:0) after 4m2s
[17:55:47.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:13:0)
[17:55:47.800] Build status: STARTED
[17:55:47.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:14:0) after 1m18s
[17:57:06.329] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:14:0)
[17:57:06.361] Build status: STARTED
[17:57:06.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:15:0) after 2m33s
[17:59:39.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:15:0)
[17:59:39.472] Build status: STARTED
[17:59:39.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:16:0) after 2m0s
[18:01:39.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:16:0)
[18:01:39.571] Build status: STARTED
[18:01:39.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:17:0) after 2m23s
[18:04:02.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:17:0)
[18:04:02.675] Build status: STARTED
[18:04:02.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:18:0) after 6m19s
[18:10:21.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:18:0)
[18:10:21.720] Build status: STARTED
[18:10:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:19:0) after 5m30s
[18:15:51.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:19:0)
[18:15:51.773] Build status: STARTED
[18:15:51.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:20:0) after 8m46s
[18:24:37.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:20:0)
[18:24:37.842] Build status: STARTED
[18:24:37.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:21:0) after 3m35s
[18:28:13.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:21:0)
[18:28:13.092] Build status: STARTED
[18:28:13.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:22:0) after 1m57s
[18:30:10.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:22:0)
[18:30:10.153] Build status: STARTED
[18:30:10.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:23:0) after 3m43s
[18:33:53.155] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:23:0)
[18:33:53.194] Build status: STARTED
[18:33:53.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:24:0) after 6m22s
[18:40:15.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:24:0)
[18:40:15.251] Build status: STARTED
[18:40:15.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:25:0) after 9m24s
[18:49:39.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:25:0)
[18:49:39.531] Build status: STARTED
[18:49:39.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:26:0) after 5m49s
[18:55:28.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:26:0)
[18:55:28.624] Build status: STARTED
[18:55:28.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:27:0) after 1m22s
[18:56:50.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:27:0)
[18:56:50.737] Build status: STARTED
[18:56:50.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:28:0) after 2m45s
[18:59:35.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:28:0)
[18:59:35.940] Build status: STARTED
[18:59:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:29:0) after 7m40s
[19:07:15.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:29:0)
[19:07:16.006] Build status: STARTED
[19:07:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:30:0) after 8m38s
[19:15:54.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:30:0)
[19:15:54.161] Build status: STARTED
[19:15:54.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:31:0) after 2m5s
[19:17:59.190] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:31:0)
[19:17:59.229] Build status: STARTED
[19:17:59.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:32:0) after 1m22s
[19:19:21.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:32:0)
[19:19:21.275] Build status: STARTED
[19:19:21.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:33:0) after 9m25s
[19:28:46.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:33:0)
[19:28:46.419] Build status: STARTED
[19:28:46.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:34:0) after 5m14s
[19:34:00.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:34:0)
[19:34:00.574] Build status: STARTED
[19:34:00.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:35:0) after 8m3s
[19:42:03.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:35:0)
[19:42:03.623] Build status: STARTED
[19:42:03.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:36:0) after 7m58s
[19:50:01.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:36:0)
[19:50:01.678] Build status: STARTED
[19:50:01.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:37:0) after 4m31s
[19:54:32.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:37:0)
[19:54:32.759] Build status: STARTED
[19:54:32.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:38:0) after 4m53s
[19:59:25.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:38:0)
[19:59:25.873] Build status: STARTED
[19:59:25.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:39:0) after 6m29s
[20:05:55.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:39:0)
[20:05:55.086] Build status: STARTED
[20:05:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:40:0) after 8m4s
[20:13:59.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:40:0)
[20:13:59.126] Build status: STARTED
[20:13:59.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:41:0) after 7m2s
[20:21:01.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:41:0)
[20:21:01.395] Build status: STARTED
[20:21:01.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:42:0) after 2m50s
[20:23:51.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:42:0)
[20:23:51.908] Build status: STARTED
[20:23:51.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:43:0) after 6m38s
[20:30:30.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:43:0)
[20:30:30.331] Build status: STARTED
[20:30:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:44:0) after 5m8s
[20:35:38.354] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:44:0)
[20:35:38.377] Build status: STARTED
[20:35:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:45:0) after 4m23s
[20:40:01.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:45:0)
[20:40:01.956] Build status: STARTED
[20:40:01.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:46:0) after 9m19s
[20:49:20.958] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:46:0)
[20:49:21.007] Build status: STARTED
[20:49:21.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:47:0) after 9m34s
[20:58:55.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:47:0)
[20:58:55.407] Build status: STARTED
[20:58:55.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:48:0) after 7m27s
[21:06:22.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:48:0)
[21:06:22.499] Build status: STARTED
[21:06:22.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:49:0) after 9m43s
[21:16:05.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:49:0)
[21:16:05.548] Build status: STARTED
[21:16:05.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:50:0) after 9m38s
[21:25:43.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:50:0)
[21:25:43.763] Build status: STARTED
[21:25:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:51:0) after 9m5s
[21:34:48.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:51:0)
[21:34:48.857] Build status: STARTED
[21:34:48.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:52:0) after 7m39s
[21:42:28.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:52:0)
[21:42:28.023] Build status: STARTED
[21:42:28.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:53:0) after 7m56s
[21:50:24.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:53:0)
[21:50:24.371] Build status: STARTED
[21:50:24.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:54:0) after 4m33s
[21:54:57.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:54:0)
[21:54:57.425] Build status: STARTED
[21:54:57.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:55:0) after 4m10s
[21:59:07.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:55:0)
[21:59:07.476] Build status: STARTED
[21:59:07.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:56:0) after 3m22s
[22:02:29.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:56:0)
[22:02:29.565] Build status: STARTED
[22:02:29.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:57:0) after 5m6s
[22:07:35.702] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:57:0)
[22:07:35.736] Build status: STARTED
[22:07:35.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:58:0) after 4m17s
[22:11:52.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:58:0)
[22:11:52.789] Build status: STARTED
[22:11:52.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:59:0) after 8m6s
[22:19:58.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:59:0)
[22:19:58.851] Build status: STARTED
[22:19:58.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:60:0) after 4m41s
[22:24:39.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:60:0)
[22:24:40.002] Build status: STARTED
[22:24:40.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:61:0) after 5m19s
[22:29:59.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:61:0)
[22:29:59.219] Build status: STARTED
[22:29:59.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:62:0) after 3m18s
[22:33:17.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:62:0)
[22:33:17.719] Build status: STARTED
[22:33:17.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:63:0) after 3m12s
[22:36:30.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:63:0)
[22:36:30.331] Build status: STARTED
[22:36:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:64:0) after 8m52s
[22:45:48.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:64:0)
[22:45:48.643] Build status: STARTED
[22:45:48.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:65:0) after 8m42s
[22:54:30.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:65:0)
[22:54:30.856] Build status: STARTED
[22:54:30.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:66:0) after 3m41s
[22:58:11.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:66:0)
[22:58:11.963] Build status: STARTED
[22:58:11.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:67:0) after 6m58s
[23:05:10.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:67:0)
[23:05:10.182] Build status: STARTED
[23:05:10.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:68:0) after 6m14s
[23:11:24.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:68:0)
[23:11:24.244] Build status: STARTED
[23:11:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:69:0) after 7m11s
[23:18:35.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:69:0)
[23:18:35.451] Build status: STARTED
[23:18:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:70:0) after 8m55s
[23:27:30.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:70:0)
[23:27:30.882] Build status: STARTED
[23:27:30.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:71:0) after 1m31s
[23:29:02.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:71:0)
[23:29:02.123] Build status: STARTED
[23:29:02.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:72:0) after 8m16s
[23:37:18.199] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:72:0)
[23:37:18.220] Build status: STARTED
[23:37:18.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:73:0) after 5m40s
[23:42:58.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:73:0)
[23:42:58.533] Build status: STARTED
[23:42:58.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:74:0) after 8m59s
[23:51:57.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:74:0)
[23:51:57.701] Build status: STARTED
[23:51:57.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:75:0) after 5m53s
[23:57:50.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:75:0)
[23:57:50.834] Build status: STARTED
[23:57:50.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:76:0) after 8m30s
[00:06:20.970] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:76:0)
[00:06:20.996] Build status: STARTED
[00:06:20.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:77:0) after 8m16s
[00:14:37.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:77:0)
[00:14:37.063] Build status: STARTED
[00:14:37.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:78:0) after 3m58s
[00:18:35.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:78:0)
[00:18:35.123] Build status: STARTED
[00:18:35.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:79:0) after 4m1s
[00:22:36.305] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:79:0)
[00:22:36.364] Build status: STARTED
[00:22:36.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:80:0) after 7m45s
[00:30:21.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:80:0)
[00:30:21.645] Build status: STARTED
[00:30:21.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:81:0) after 1m44s
[00:32:05.671] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:81:0)
[00:32:05.708] Build status: STARTED
[00:32:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:82:0) after 6m0s
[00:38:05.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:82:0)
[00:38:05.771] Build status: STARTED
[00:38:05.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:83:0) after 1m8s
[00:39:13.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:83:0)
[00:39:13.813] Build status: STARTED
[00:39:13.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:84:0) after 9m43s
[00:48:57.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:84:0)
[00:48:57.045] Build status: STARTED
[00:48:57.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:85:0) after 2m45s
[00:51:42.222] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:85:0)
[00:51:42.286] Build status: STARTED
[00:51:42.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:86:0) after 3m8s
[00:54:50.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:86:0)
[00:54:50.349] Build status: STARTED
[00:54:50.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:87:0) after 2m29s
[00:57:19.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:87:0)
[00:57:19.513] Build status: STARTED
[00:57:19.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:88:0) after 5m34s
[01:02:53.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:88:0)
[01:02:53.572] Build status: STARTED
[01:02:53.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8977518547116402336:89:0) after 5m6s
[01:05:10.124] Received PubSub notification, asking Buildbucket for the build status
[01:05:10.164] Build:
{
"id": "8812088483462087873",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2644,
"createdBy": "project:chromium",
"createTime": "2022-06-06T16:56:01.630726794Z",
"startTime": "2022-06-06T17:00:25.402351Z",
"endTime": "2022-06-07T01:05:09.697643234Z",
"updateTime": "2022-06-07T01:05:09.697643234Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee883d2006628b38adf97e185568255060af6d91",
"ref": "refs/heads/main"
}
}
}
[01:05:10.164] Invocation finished in 8h9m11.402292442s with status FAILED