[08:16:18.372] New invocation is queued and will start shortly
[08:16:19.531] Starting the invocation (attempt 1)
[08:16:19.584] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bff5a934f4e8491aad9f798c82ee9d35c13b0b3"
[08:16:19.584] Popped gitiles commit info from properties and tags
[08:16:19.584] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:16:19.584] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:16:19.584] Buildbucket request:
{
"requestId": "8982262284393883904",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0bff5a934f4e8491aad9f798c82ee9d35c13b0b3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8982262284393883904"
},
{
"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"
}
}
[08:16:20.280] Scheduled build:
{
"id": "8816832222372230225",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2384,
"createdBy": "project:chromium",
"createTime": "2022-04-15T08:16:19.668856180Z",
"updateTime": "2022-04-15T08:16:19.668856180Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0bff5a934f4e8491aad9f798c82ee9d35c13b0b3",
"ref": "refs/heads/main"
}
}
}
[08:16:20.280] Task URL: https://cr-buildbucket.appspot.com/build/8816832222372230225
[08:16:20.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:2:0) after 6m27s
[08:19:58.366] Received PubSub notification, asking Buildbucket for the build status
[08:19:58.405] Build status: STARTED
[08:22:47.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:2:0)
[08:22:47.293] Build status: STARTED
[08:22:47.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:4:0) after 9m31s
[08:32:18.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:4:0)
[08:32:18.446] Build status: STARTED
[08:32:18.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:5:0) after 5m4s
[08:37:22.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:5:0)
[08:37:22.491] Build status: STARTED
[08:37:22.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:6:0) after 9m49s
[08:47:11.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:6:0)
[08:47:11.670] Build status: STARTED
[08:47:11.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:7:0) after 4m16s
[08:51:27.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:7:0)
[08:51:27.867] Build status: STARTED
[08:51:27.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:8:0) after 9m56s
[09:01:23.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:8:0)
[09:01:23.982] Build status: STARTED
[09:01:23.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:9:0) after 5m0s
[09:06:24.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:9:0)
[09:06:24.139] Build status: STARTED
[09:06:24.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:10:0) after 7m57s
[09:14:21.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:10:0)
[09:14:21.321] Build status: STARTED
[09:14:21.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:11:0) after 6m17s
[09:20:38.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:11:0)
[09:20:38.474] Build status: STARTED
[09:20:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:12:0) after 1m4s
[09:21:42.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:12:0)
[09:21:42.534] Build status: STARTED
[09:21:42.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:13:0) after 2m35s
[09:24:17.555] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:13:0)
[09:24:17.585] Build status: STARTED
[09:24:17.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:14:0) after 7m35s
[09:31:52.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:14:0)
[09:31:52.628] Build status: STARTED
[09:31:52.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:15:0) after 5m5s
[09:36:57.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:15:0)
[09:36:57.680] Build status: STARTED
[09:36:57.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:16:0) after 4m25s
[09:41:22.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:16:0)
[09:41:22.729] Build status: STARTED
[09:41:22.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:17:0) after 5m52s
[09:47:14.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:17:0)
[09:47:14.782] Build status: STARTED
[09:47:14.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:18:0) after 4m16s
[09:51:30.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:18:0)
[09:51:30.827] Build status: STARTED
[09:51:30.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:19:0) after 3m2s
[09:54:32.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:19:0)
[09:54:32.889] Build status: STARTED
[09:54:32.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:20:0) after 7m48s
[10:02:20.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:20:0)
[10:02:20.941] Build status: STARTED
[10:02:20.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:21:0) after 2m54s
[10:05:15.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:21:0)
[10:05:15.133] Build status: STARTED
[10:05:15.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:22:0) after 5m12s
[10:10:27.154] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:22:0)
[10:10:27.200] Build status: STARTED
[10:10:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:23:0) after 7m42s
[10:18:09.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:23:0)
[10:18:09.406] Build status: STARTED
[10:18:09.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:24:0) after 4m23s
[10:22:32.614] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:24:0)
[10:22:32.644] Build status: STARTED
[10:22:32.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:25:0) after 5m16s
[10:27:48.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:25:0)
[10:27:48.700] Build status: STARTED
[10:27:48.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:26:0) after 1m18s
[10:29:06.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:26:0)
[10:29:06.771] Build status: STARTED
[10:29:06.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:27:0) after 2m11s
[10:31:18.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:27:0)
[10:31:18.078] Build status: STARTED
[10:31:18.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:28:0) after 9m50s
[10:41:08.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:28:0)
[10:41:08.177] Build status: STARTED
[10:41:08.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:29:0) after 9m32s
[10:50:40.283] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:29:0)
[10:50:40.324] Build status: STARTED
[10:50:40.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:30:0) after 1m33s
[10:52:13.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:30:0)
[10:52:13.515] Build status: STARTED
[10:52:13.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:31:0) after 3m12s
[10:55:25.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:31:0)
[10:55:25.573] Build status: STARTED
[10:55:25.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:32:0) after 7m0s
[11:02:25.693] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:32:0)
[11:02:25.723] Build status: STARTED
[11:02:25.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:33:0) after 4m54s
[11:07:19.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:33:0)
[11:07:19.780] Build status: STARTED
[11:07:19.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:34:0) after 5m6s
[11:12:25.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:34:0)
[11:12:25.789] Build status: STARTED
[11:12:25.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:35:0) after 9m13s
[11:21:38.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:35:0)
[11:21:38.887] Build status: STARTED
[11:21:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:36:0) after 9m48s
[11:31:26.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:36:0)
[11:31:26.971] Build status: STARTED
[11:31:26.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:37:0) after 7m19s
[11:38:45.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:37:0)
[11:38:46.029] Build status: STARTED
[11:38:46.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:38:0) after 2m54s
[11:41:40.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:38:0)
[11:41:40.090] Build status: STARTED
[11:41:40.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:39:0) after 9m35s
[11:51:15.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:39:0)
[11:51:15.160] Build status: STARTED
[11:51:15.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:40:0) after 6m54s
[11:58:09.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:40:0)
[11:58:09.468] Build status: STARTED
[11:58:09.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:41:0) after 2m25s
[12:00:34.503] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:41:0)
[12:00:34.529] Build status: STARTED
[12:00:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:42:0) after 7m46s
[12:08:20.568] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:42:0)
[12:08:20.594] Build status: STARTED
[12:08:20.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:43:0) after 7m26s
[12:15:46.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:43:0)
[12:15:46.670] Build status: STARTED
[12:15:46.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:44:0) after 6m25s
[12:22:11.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:44:0)
[12:22:11.961] Build status: STARTED
[12:22:11.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:45:0) after 3m48s
[12:25:59.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:45:0)
[12:26:00.007] Build status: STARTED
[12:26:00.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:46:0) after 8m38s
[12:34:38.046] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:46:0)
[12:34:38.080] Build status: STARTED
[12:34:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:47:0) after 1m3s
[12:35:41.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:47:0)
[12:35:41.202] Build status: STARTED
[12:35:41.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:48:0) after 5m35s
[12:41:16.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:48:0)
[12:41:16.358] Build status: STARTED
[12:41:16.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:49:0) after 8m29s
[12:49:45.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:49:0)
[12:49:45.469] Build status: STARTED
[12:49:45.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:50:0) after 5m25s
[12:55:10.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:50:0)
[12:55:10.527] Build status: STARTED
[12:55:10.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:51:0) after 7m51s
[13:03:01.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:51:0)
[13:03:01.632] Build status: STARTED
[13:03:01.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:52:0) after 5m16s
[13:08:17.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:52:0)
[13:08:17.700] Build status: STARTED
[13:08:17.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:53:0) after 1m36s
[13:09:53.846] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:53:0)
[13:09:53.881] Build status: STARTED
[13:09:53.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:54:0) after 6m12s
[13:16:05.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:54:0)
[13:16:05.908] Build status: STARTED
[13:16:05.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:55:0) after 3m33s
[13:19:39.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:55:0)
[13:19:39.138] Build status: STARTED
[13:19:39.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:56:0) after 4m54s
[13:24:33.214] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:56:0)
[13:24:33.238] Build status: STARTED
[13:24:33.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:57:0) after 8m31s
[13:33:04.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:57:0)
[13:33:04.296] Build status: STARTED
[13:33:04.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:58:0) after 1m45s
[13:34:49.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:58:0)
[13:34:49.364] Build status: STARTED
[13:34:49.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:59:0) after 6m53s
[13:41:42.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:59:0)
[13:41:42.536] Build status: STARTED
[13:41:42.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:60:0) after 9m40s
[13:51:22.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:60:0)
[13:51:22.601] Build status: STARTED
[13:51:22.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:61:0) after 9m56s
[14:01:18.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:61:0)
[14:01:18.809] Build status: STARTED
[14:01:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:62:0) after 7m2s
[14:08:20.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:62:0)
[14:08:20.942] Build status: STARTED
[14:08:20.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:63:0) after 5m25s
[14:13:45.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:63:0)
[14:13:45.992] Build status: STARTED
[14:13:45.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:64:0) after 4m54s
[14:18:40.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:64:0)
[14:18:40.071] Build status: STARTED
[14:18:40.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:65:0) after 1m32s
[14:20:12.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:65:0)
[14:20:12.179] Build status: STARTED
[14:20:12.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:66:0) after 6m13s
[14:26:25.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:66:0)
[14:26:25.374] Build status: STARTED
[14:26:25.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:67:0) after 5m24s
[14:31:49.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:67:0)
[14:31:49.418] Build status: STARTED
[14:31:49.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:68:0) after 9m34s
[14:41:23.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:68:0)
[14:41:23.459] Build status: STARTED
[14:41:23.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:69:0) after 3m5s
[14:44:28.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:69:0)
[14:44:28.473] Build status: STARTED
[14:44:28.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:70:0) after 5m20s
[14:49:48.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:70:0)
[14:49:48.561] Build status: STARTED
[14:49:48.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:71:0) after 1m19s
[14:51:07.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:71:0)
[14:51:07.611] Build status: STARTED
[14:51:07.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:72:0) after 4m41s
[14:55:48.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:72:0)
[14:55:48.656] Build status: STARTED
[14:55:48.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:73:0) after 3m52s
[14:59:40.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:73:0)
[14:59:40.715] Build status: STARTED
[14:59:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:74:0) after 2m21s
[15:02:01.735] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:74:0)
[15:02:01.758] Build status: STARTED
[15:02:01.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:75:0) after 8m5s
[15:10:06.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:75:0)
[15:10:07.078] Build status: STARTED
[15:10:07.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:76:0) after 5m24s
[15:15:31.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:76:0)
[15:15:31.127] Build status: STARTED
[15:15:31.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:77:0) after 2m35s
[15:18:06.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:77:0)
[15:18:06.473] Build status: STARTED
[15:18:06.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:78:0) after 6m23s
[15:24:29.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:78:0)
[15:24:29.681] Build status: STARTED
[15:24:29.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:79:0) after 7m36s
[15:32:05.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:79:0)
[15:32:05.712] Build status: STARTED
[15:32:05.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:80:0) after 5m11s
[15:37:16.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:80:0)
[15:37:16.791] Build status: STARTED
[15:37:16.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:81:0) after 2m59s
[15:40:15.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:81:0)
[15:40:15.885] Build status: STARTED
[15:40:15.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:82:0) after 4m51s
[15:45:07.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:82:0)
[15:45:07.107] Build status: STARTED
[15:45:07.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:83:0) after 6m3s
[15:51:10.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:83:0)
[15:51:10.175] Build status: STARTED
[15:51:10.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:84:0) after 9m8s
[16:00:18.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:84:0)
[16:00:18.259] Build status: STARTED
[16:00:18.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:85:0) after 2m24s
[16:02:42.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:85:0)
[16:02:42.322] Build status: STARTED
[16:02:42.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:86:0) after 5m49s
[16:08:31.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:86:0)
[16:08:31.413] Build status: STARTED
[16:08:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:87:0) after 3m32s
[16:12:03.535] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:87:0)
[16:12:03.568] Build status: STARTED
[16:12:03.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:88:0) after 5m22s
[16:17:25.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:88:0)
[16:17:25.665] Build status: STARTED
[16:17:25.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:89:0) after 1m36s
[16:19:02.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:89:0)
[16:19:02.471] Build status: STARTED
[16:19:02.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:90:0) after 9m25s
[16:28:27.702] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:90:0)
[16:28:27.851] Build status: STARTED
[16:28:27.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:91:0) after 1m53s
[16:30:20.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:91:0)
[16:30:20.954] Build status: STARTED
[16:30:20.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:92:0) after 3m33s
[16:33:54.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:92:0)
[16:33:54.185] Build status: STARTED
[16:33:54.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:93:0) after 9m13s
[16:43:07.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:93:0)
[16:43:07.358] Build status: STARTED
[16:43:07.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:94:0) after 4m57s
[16:48:04.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:94:0)
[16:48:04.515] Build status: STARTED
[16:48:04.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:95:0) after 4m48s
[16:52:52.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:95:0)
[16:52:52.714] Build status: STARTED
[16:52:52.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:96:0) after 8m48s
[17:01:40.737] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:96:0)
[17:01:40.770] Build status: STARTED
[17:01:40.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:97:0) after 9m34s
[17:11:14.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:97:0)
[17:11:14.834] Build status: STARTED
[17:11:14.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:98:0) after 1m31s
[17:12:45.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:98:0)
[17:12:45.890] Build status: STARTED
[17:12:45.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8982262284393883904:99:0) after 9m5s
[17:21:30.454] Received PubSub notification, asking Buildbucket for the build status
[17:21:30.485] Build:
{
"id": "8816832222372230225",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2384,
"createdBy": "project:chromium",
"createTime": "2022-04-15T08:16:19.668856180Z",
"startTime": "2022-04-15T08:19:52.782019Z",
"endTime": "2022-04-15T17:21:29.935808788Z",
"updateTime": "2022-04-15T17:21:29.935808788Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0bff5a934f4e8491aad9f798c82ee9d35c13b0b3",
"ref": "refs/heads/main"
}
}
}
[17:21:30.485] Invocation finished in 9h5m12.127576741s with status FAILED