[14:40:54.855] New invocation is queued and will start shortly
[14:40:55.927] Starting the invocation (attempt 1)
[14:40:55.993] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd55a51fc7847e42ad3d05b0ad3d49d4e815dd73"
[14:40:55.993] Popped gitiles commit info from properties and tags
[14:40:55.993] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:40:55.993] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:40:55.993] Buildbucket request:
{
"requestId": "8995102856175538784",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cd55a51fc7847e42ad3d05b0ad3d49d4e815dd73",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8995102856175538784"
},
{
"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"
}
}
[14:40:56.510] Scheduled build:
{
"id": "8829672794251706193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1775,
"createdBy": "project:chromium",
"createTime": "2021-11-24T14:40:56.059853049Z",
"updateTime": "2021-11-24T14:40:56.059853049Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cd55a51fc7847e42ad3d05b0ad3d49d4e815dd73",
"ref": "refs/heads/main"
}
}
}
[14:40:56.510] Task URL: https://cr-buildbucket.appspot.com/build/8829672794251706193
[14:40:56.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:2:0) after 5m10s
[14:46:06.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:2:0)
[14:46:06.779] Build status: SCHEDULED
[14:46:06.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:3:0) after 6m38s
[14:52:44.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:3:0)
[14:52:44.877] Build status: SCHEDULED
[14:52:44.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:4:0) after 9m0s
[15:01:45.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:4:0)
[15:01:45.038] Build status: SCHEDULED
[15:01:45.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:5:0) after 3m24s
[15:05:09.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:5:0)
[15:05:09.275] Build status: SCHEDULED
[15:05:09.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:6:0) after 1m36s
[15:06:45.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:6:0)
[15:06:45.335] Build status: SCHEDULED
[15:06:45.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:7:0) after 3m55s
[15:10:40.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:7:0)
[15:10:40.469] Build status: SCHEDULED
[15:10:40.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:8:0) after 7m5s
[15:17:45.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:8:0)
[15:17:45.530] Build status: SCHEDULED
[15:17:45.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:9:0) after 5m26s
[15:20:51.258] Received PubSub notification, asking Buildbucket for the build status
[15:20:51.291] Build status: STARTED
[15:23:11.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:9:0)
[15:23:11.812] Build status: STARTED
[15:23:11.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:11:0) after 5m40s
[15:28:51.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:11:0)
[15:28:51.943] Build status: STARTED
[15:28:51.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:12:0) after 2m56s
[15:31:48.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:12:0)
[15:31:48.085] Build status: STARTED
[15:31:48.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:13:0) after 6m2s
[15:37:50.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:13:0)
[15:37:50.161] Build status: STARTED
[15:37:50.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:14:0) after 3m55s
[15:41:45.190] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:14:0)
[15:41:45.248] Build status: STARTED
[15:41:45.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:15:0) after 2m36s
[15:44:21.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:15:0)
[15:44:21.560] Build status: STARTED
[15:44:21.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:16:0) after 3m29s
[15:47:50.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:16:0)
[15:47:50.737] Build status: STARTED
[15:47:50.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:17:0) after 1m52s
[15:49:42.846] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:17:0)
[15:49:42.916] Build status: STARTED
[15:49:42.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:18:0) after 1m35s
[15:51:18.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:18:0)
[15:51:18.089] Build status: STARTED
[15:51:18.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:19:0) after 7m37s
[15:58:55.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:19:0)
[15:58:55.149] Build status: STARTED
[15:58:55.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:20:0) after 1m18s
[16:00:13.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:20:0)
[16:00:13.216] Build status: STARTED
[16:00:13.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:21:0) after 7m14s
[16:07:27.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:21:0)
[16:07:27.349] Build status: STARTED
[16:07:27.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:22:0) after 1m44s
[16:09:11.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:22:0)
[16:09:11.462] Build status: STARTED
[16:09:11.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:23:0) after 4m5s
[16:13:16.511] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:23:0)
[16:13:16.581] Build status: STARTED
[16:13:16.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:24:0) after 7m24s
[16:20:40.675] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:24:0)
[16:20:40.708] Build status: STARTED
[16:20:40.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:25:0) after 9m58s
[16:30:39.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:25:0)
[16:30:39.058] Build status: STARTED
[16:30:39.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:26:0) after 5m24s
[16:36:03.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:26:0)
[16:36:03.243] Build status: STARTED
[16:36:03.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:27:0) after 6m15s
[16:42:18.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:27:0)
[16:42:18.319] Build status: STARTED
[16:42:18.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:28:0) after 9m37s
[16:51:55.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:28:0)
[16:51:55.501] Build status: STARTED
[16:51:55.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:29:0) after 3m50s
[16:55:45.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:29:0)
[16:55:45.671] Build status: STARTED
[16:55:45.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:30:0) after 4m43s
[17:00:28.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:30:0)
[17:00:28.791] Build status: STARTED
[17:00:28.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:31:0) after 2m51s
[17:03:19.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:31:0)
[17:03:19.916] Build status: STARTED
[17:03:19.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:32:0) after 3m26s
[17:06:46.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:32:0)
[17:06:46.080] Build status: STARTED
[17:06:46.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:33:0) after 6m39s
[17:13:25.301] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:33:0)
[17:13:25.334] Build status: STARTED
[17:13:25.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:34:0) after 3m49s
[17:17:14.568] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:34:0)
[17:17:14.656] Build status: STARTED
[17:17:14.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:35:0) after 5m45s
[17:22:59.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:35:0)
[17:22:59.924] Build status: STARTED
[17:22:59.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:36:0) after 1m13s
[17:24:13.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:36:0)
[17:24:13.129] Build status: STARTED
[17:24:13.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:37:0) after 9m22s
[17:33:35.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:37:0)
[17:33:35.181] Build status: STARTED
[17:33:35.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:38:0) after 2m36s
[17:36:11.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:38:0)
[17:36:11.337] Build status: STARTED
[17:36:11.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:39:0) after 8m37s
[17:44:48.440] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:39:0)
[17:44:48.540] Build status: STARTED
[17:44:48.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:40:0) after 4m31s
[17:49:19.686] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:40:0)
[17:49:19.715] Build status: STARTED
[17:49:19.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:41:0) after 4m22s
[17:53:41.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:41:0)
[17:53:41.791] Build status: STARTED
[17:53:41.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:42:0) after 1m24s
[17:55:05.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:42:0)
[17:55:05.941] Build status: STARTED
[17:55:05.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:43:0) after 1m40s
[17:56:46.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:43:0)
[17:56:46.083] Build status: STARTED
[17:56:46.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:44:0) after 2m10s
[17:58:56.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:44:0)
[17:58:56.196] Build status: STARTED
[17:58:56.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:45:0) after 7m56s
[18:06:52.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:45:0)
[18:06:52.332] Build status: STARTED
[18:06:52.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:46:0) after 8m44s
[18:15:36.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:46:0)
[18:15:36.567] Build status: STARTED
[18:15:36.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:47:0) after 9m35s
[18:25:11.599] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:47:0)
[18:25:11.628] Build status: STARTED
[18:25:11.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:48:0) after 6m20s
[18:31:31.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:48:0)
[18:31:31.789] Build status: STARTED
[18:31:31.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:49:0) after 4m42s
[18:36:13.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:49:0)
[18:36:13.853] Build status: STARTED
[18:36:13.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:50:0) after 5m46s
[18:41:59.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:50:0)
[18:41:59.910] Build status: STARTED
[18:41:59.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:51:0) after 5m33s
[18:47:32.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:51:0)
[18:47:32.972] Build status: STARTED
[18:47:32.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:52:0) after 5m53s
[18:53:26.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:52:0)
[18:53:26.129] Build status: STARTED
[18:53:26.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:53:0) after 2m36s
[18:56:02.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:53:0)
[18:56:02.273] Build status: STARTED
[18:56:02.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:54:0) after 4m0s
[19:00:02.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:54:0)
[19:00:02.698] Build status: STARTED
[19:00:02.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:55:0) after 7m44s
[19:07:46.737] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:55:0)
[19:07:46.772] Build status: STARTED
[19:07:46.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:56:0) after 1m17s
[19:09:04.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:56:0)
[19:09:04.119] Build status: STARTED
[19:09:04.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:57:0) after 7m26s
[19:16:30.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:57:0)
[19:16:30.457] Build status: STARTED
[19:16:30.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:58:0) after 7m25s
[19:23:55.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:58:0)
[19:23:55.578] Build status: STARTED
[19:23:55.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:59:0) after 6m14s
[19:30:09.770] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:59:0)
[19:30:09.804] Build status: STARTED
[19:30:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:60:0) after 3m39s
[19:33:48.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:60:0)
[19:33:48.878] Build status: STARTED
[19:33:48.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:61:0) after 5m1s
[19:38:49.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:61:0)
[19:38:49.947] Build status: STARTED
[19:38:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:62:0) after 9m32s
[19:48:21.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:62:0)
[19:48:22.010] Build status: STARTED
[19:48:22.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:63:0) after 3m41s
[19:52:03.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:63:0)
[19:52:03.075] Build status: STARTED
[19:52:03.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:64:0) after 7m28s
[19:59:31.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:64:0)
[19:59:31.152] Build status: STARTED
[19:59:31.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:65:0) after 9m4s
[20:08:35.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:65:0)
[20:08:35.268] Build status: STARTED
[20:08:35.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:66:0) after 9m43s
[20:18:18.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:66:0)
[20:18:18.792] Build status: STARTED
[20:18:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:67:0) after 8m17s
[20:26:36.038] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:67:0)
[20:26:36.072] Build status: STARTED
[20:26:36.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:68:0) after 1m39s
[20:28:15.199] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:68:0)
[20:28:15.229] Build status: STARTED
[20:28:15.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:69:0) after 1m33s
[20:29:48.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:69:0)
[20:29:48.766] Build status: STARTED
[20:29:48.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:70:0) after 3m33s
[20:33:21.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:70:0)
[20:33:21.905] Build status: STARTED
[20:33:21.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:71:0) after 4m57s
[20:38:18.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:71:0)
[20:38:18.972] Build status: STARTED
[20:38:18.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:72:0) after 6m59s
[20:45:18.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:72:0)
[20:45:18.135] Build status: STARTED
[20:45:18.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:73:0) after 4m38s
[20:49:56.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:73:0)
[20:49:56.189] Build status: STARTED
[20:49:56.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:74:0) after 9m35s
[20:59:32.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:74:0)
[20:59:32.141] Build status: STARTED
[20:59:32.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:75:0) after 4m37s
[21:04:09.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:75:0)
[21:04:09.425] Build status: STARTED
[21:04:09.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:76:0) after 4m32s
[21:08:41.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:76:0)
[21:08:41.700] Build status: STARTED
[21:08:41.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:77:0) after 7m13s
[21:15:54.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:77:0)
[21:15:54.778] Build status: STARTED
[21:15:54.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:78:0) after 4m59s
[21:20:53.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:78:0)
[21:20:53.847] Build status: STARTED
[21:20:53.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:79:0) after 5m5s
[21:25:58.966] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:79:0)
[21:25:59.000] Build status: STARTED
[21:25:59.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:80:0) after 9m43s
[21:35:42.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:80:0)
[21:35:42.156] Build status: STARTED
[21:35:42.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:81:0) after 3m11s
[21:38:53.327] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:81:0)
[21:38:53.380] Build status: STARTED
[21:38:53.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:82:0) after 8m28s
[21:47:21.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:82:0)
[21:47:21.444] Build status: STARTED
[21:47:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:83:0) after 2m45s
[21:50:06.472] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:83:0)
[21:50:06.507] Build status: STARTED
[21:50:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:84:0) after 7m59s
[21:58:05.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:84:0)
[21:58:05.631] Build status: STARTED
[21:58:05.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:85:0) after 9m33s
[22:07:38.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:85:0)
[22:07:38.811] Build status: STARTED
[22:07:38.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:86:0) after 1m24s
[22:09:02.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:86:0)
[22:09:02.912] Build status: STARTED
[22:09:02.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:87:0) after 3m12s
[22:12:14.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:87:0)
[22:12:15.015] Build status: STARTED
[22:12:15.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:88:0) after 9m33s
[22:21:48.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:88:0)
[22:21:48.192] Build status: STARTED
[22:21:48.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:89:0) after 2m36s
[22:24:24.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:89:0)
[22:24:24.233] Build status: STARTED
[22:24:24.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:90:0) after 2m59s
[22:27:23.256] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:90:0)
[22:27:23.289] Build status: STARTED
[22:27:23.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:91:0) after 7m57s
[22:35:20.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:91:0)
[22:35:20.345] Build status: STARTED
[22:35:20.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:92:0) after 4m24s
[22:39:44.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:92:0)
[22:39:44.469] Build status: STARTED
[22:39:44.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:93:0) after 6m28s
[22:46:12.519] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:93:0)
[22:46:12.557] Build status: STARTED
[22:46:12.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:94:0) after 6m42s
[22:52:54.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:94:0)
[22:52:54.622] Build status: STARTED
[22:52:54.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:95:0) after 4m51s
[22:57:45.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:95:0)
[22:57:45.927] Build status: STARTED
[22:57:45.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:96:0) after 7m52s
[23:05:38.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:96:0)
[23:05:38.437] Build status: STARTED
[23:05:38.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:97:0) after 8m1s
[23:13:39.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:97:0)
[23:13:39.490] Build status: STARTED
[23:13:39.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:98:0) after 3m26s
[23:17:05.515] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:98:0)
[23:17:05.545] Build status: STARTED
[23:17:05.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:99:0) after 9m20s
[23:26:25.693] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:99:0)
[23:26:25.744] Build status: STARTED
[23:26:25.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:100:0) after 1m33s
[23:27:58.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:100:0)
[23:27:58.798] Build status: STARTED
[23:27:58.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8995102856175538784:101:0) after 2m32s
[23:30:10.893] Received PubSub notification, asking Buildbucket for the build status
[23:30:10.941] Build:
{
"id": "8829672794251706193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1775,
"createdBy": "project:chromium",
"createTime": "2021-11-24T14:40:56.059853049Z",
"startTime": "2021-11-24T15:20:50.666123Z",
"endTime": "2021-11-24T23:30:10.568506519Z",
"updateTime": "2021-11-24T23:30:10.568506519Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cd55a51fc7847e42ad3d05b0ad3d49d4e815dd73",
"ref": "refs/heads/main"
}
}
}
[23:30:10.941] Invocation finished in 8h49m16.101542715s with status FAILED