[10:32:08.287] New invocation is queued and will start shortly
[10:32:09.402] Starting the invocation (attempt 1)
[10:32:09.445] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf640af13ac823d0e5d88c8f59d4c3b5d8a02120"
[10:32:09.445] Popped gitiles commit info from properties and tags
[10:32:09.445] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:32:09.445] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:32:09.445] Buildbucket request:
{
"requestId": "9007439695245743824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bf640af13ac823d0e5d88c8f59d4c3b5d8a02120",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9007439695245743824"
},
{
"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"
}
}
[10:32:11.495] Scheduled build:
{
"id": "8842009633253931824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1072,
"createdBy": "project:chromium",
"createTime": "2021-07-11T10:32:09.557846Z",
"updateTime": "2021-07-11T10:32:11.348984Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bf640af13ac823d0e5d88c8f59d4c3b5d8a02120",
"ref": "refs/heads/main"
}
}
}
[10:32:11.495] Task URL: https://cr-buildbucket.appspot.com/build/8842009633253931824
[10:32:11.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:2:0) after 9m25s
[10:41:36.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:2:0)
[10:41:36.737] Build status: SCHEDULED
[10:41:36.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:3:0) after 8m59s
[10:50:35.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:3:0)
[10:50:35.788] Build status: SCHEDULED
[10:50:35.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:4:0) after 6m24s
[10:56:59.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:4:0)
[10:56:59.837] Build status: SCHEDULED
[10:56:59.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:5:0) after 7m9s
[11:04:08.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:5:0)
[11:04:08.962] Build status: SCHEDULED
[11:04:08.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:6:0) after 2m36s
[11:06:45.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:6:0)
[11:06:45.507] Build status: SCHEDULED
[11:06:45.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:7:0) after 4m58s
[11:11:43.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:7:0)
[11:11:43.574] Build status: SCHEDULED
[11:11:43.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:8:0) after 4m31s
[11:16:15.272] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:8:0)
[11:16:15.324] Build status: SCHEDULED
[11:16:15.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:9:0) after 6m17s
[11:22:32.359] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:9:0)
[11:22:32.484] Build status: SCHEDULED
[11:22:32.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:10:0) after 8m8s
[11:30:40.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:10:0)
[11:30:40.536] Build status: SCHEDULED
[11:30:40.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:11:0) after 5m45s
[11:36:25.744] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:11:0)
[11:36:25.778] Build status: SCHEDULED
[11:36:25.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:12:0) after 7m23s
[11:43:49.355] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:12:0)
[11:43:49.384] Build status: SCHEDULED
[11:43:49.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:13:0) after 7m59s
[11:51:48.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:13:0)
[11:51:48.446] Build status: SCHEDULED
[11:51:48.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:14:0) after 7m44s
[11:53:49.783] Received PubSub notification, asking Buildbucket for the build status
[11:53:49.810] Build status: STARTED
[11:59:32.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:14:0)
[11:59:32.673] Build status: STARTED
[11:59:32.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:16:0) after 7m53s
[12:07:25.735] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:16:0)
[12:07:25.815] Build status: STARTED
[12:07:25.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:17:0) after 2m35s
[12:10:00.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:17:0)
[12:10:01.005] Build status: STARTED
[12:10:01.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:18:0) after 7m58s
[12:17:59.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:18:0)
[12:17:59.085] Build status: STARTED
[12:17:59.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:19:0) after 2m3s
[12:20:02.305] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:19:0)
[12:20:02.331] Build status: STARTED
[12:20:02.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:20:0) after 1m44s
[12:21:46.415] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:20:0)
[12:21:46.439] Build status: STARTED
[12:21:46.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:21:0) after 7m28s
[12:29:14.466] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:21:0)
[12:29:14.500] Build status: STARTED
[12:29:14.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:22:0) after 6m16s
[12:35:30.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:22:0)
[12:35:30.551] Build status: STARTED
[12:35:30.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:23:0) after 7m32s
[12:43:02.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:23:0)
[12:43:02.733] Build status: STARTED
[12:43:02.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:24:0) after 1m55s
[12:44:57.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:24:0)
[12:44:57.904] Build status: STARTED
[12:44:57.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:25:0) after 7m31s
[12:52:28.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:25:0)
[12:52:28.956] Build status: STARTED
[12:52:28.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:26:0) after 3m23s
[12:55:51.978] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:26:0)
[12:55:52.008] Build status: STARTED
[12:55:52.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:27:0) after 7m26s
[13:03:18.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:27:0)
[13:03:18.097] Build status: STARTED
[13:03:18.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:28:0) after 9m23s
[13:12:41.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:28:0)
[13:12:41.184] Build status: STARTED
[13:12:41.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:29:0) after 9m27s
[13:22:09.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:29:0)
[13:22:09.512] Build status: STARTED
[13:22:09.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:30:0) after 9m52s
[13:32:02.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:30:0)
[13:32:02.330] Build status: STARTED
[13:32:02.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:31:0) after 4m41s
[13:36:43.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:31:0)
[13:36:43.381] Build status: STARTED
[13:36:43.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:32:0) after 7m51s
[13:44:34.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:32:0)
[13:44:34.495] Build status: STARTED
[13:44:34.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:33:0) after 6m35s
[13:51:09.692] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:33:0)
[13:51:09.720] Build status: STARTED
[13:51:09.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:34:0) after 9m42s
[14:00:51.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:34:0)
[14:00:51.927] Build status: STARTED
[14:00:51.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:35:0) after 7m41s
[14:08:33.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:35:0)
[14:08:33.046] Build status: STARTED
[14:08:33.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:36:0) after 6m34s
[14:15:07.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:36:0)
[14:15:07.158] Build status: STARTED
[14:15:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:37:0) after 6m4s
[14:21:11.184] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:37:0)
[14:21:11.213] Build status: STARTED
[14:21:11.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:38:0) after 9m22s
[14:30:33.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:38:0)
[14:30:33.425] Build status: STARTED
[14:30:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:39:0) after 3m24s
[14:33:57.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:39:0)
[14:33:57.626] Build status: STARTED
[14:33:57.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:40:0) after 1m47s
[14:35:44.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:40:0)
[14:35:44.675] Build status: STARTED
[14:35:44.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:41:0) after 9m8s
[14:44:52.756] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:41:0)
[14:44:52.804] Build status: STARTED
[14:44:52.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:42:0) after 7m52s
[14:52:44.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:42:0)
[14:52:44.856] Build status: STARTED
[14:52:44.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:43:0) after 6m22s
[14:59:06.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:43:0)
[14:59:07.000] Build status: STARTED
[14:59:07.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:44:0) after 3m25s
[15:02:32.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:44:0)
[15:02:32.527] Build status: STARTED
[15:02:32.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:45:0) after 5m28s
[15:08:00.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:45:0)
[15:08:00.742] Build status: STARTED
[15:08:00.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:46:0) after 5m20s
[15:13:20.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:46:0)
[15:13:20.811] Build status: STARTED
[15:13:20.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:47:0) after 5m14s
[15:18:34.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:47:0)
[15:18:34.872] Build status: STARTED
[15:18:34.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:48:0) after 2m21s
[15:20:55.902] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:48:0)
[15:20:55.969] Build status: STARTED
[15:20:55.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:49:0) after 1m57s
[15:22:53.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:49:0)
[15:22:53.092] Build status: STARTED
[15:22:53.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:50:0) after 3m40s
[15:26:33.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:50:0)
[15:26:33.223] Build status: STARTED
[15:26:33.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:51:0) after 5m43s
[15:32:16.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:51:0)
[15:32:16.613] Build status: STARTED
[15:32:16.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:52:0) after 1m23s
[15:33:39.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:52:0)
[15:33:39.755] Build status: STARTED
[15:33:39.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:53:0) after 1m10s
[15:34:49.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:53:0)
[15:34:49.893] Build status: STARTED
[15:34:49.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:54:0) after 8m14s
[15:43:04.473] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:54:0)
[15:43:04.513] Build status: STARTED
[15:43:04.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:55:0) after 9m31s
[15:52:35.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:55:0)
[15:52:35.657] Build status: STARTED
[15:52:35.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:56:0) after 2m52s
[15:55:27.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:56:0)
[15:55:27.839] Build status: STARTED
[15:55:27.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:57:0) after 4m33s
[16:00:00.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:57:0)
[16:00:00.959] Build status: STARTED
[16:00:00.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:58:0) after 3m20s
[16:03:21.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:58:0)
[16:03:21.274] Build status: STARTED
[16:03:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:59:0) after 9m27s
[16:12:48.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:59:0)
[16:12:48.326] Build status: STARTED
[16:12:48.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:60:0) after 8m0s
[16:20:48.354] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:60:0)
[16:20:48.387] Build status: STARTED
[16:20:48.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:61:0) after 8m7s
[16:28:55.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:61:0)
[16:28:55.435] Build status: STARTED
[16:28:55.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:62:0) after 2m36s
[16:31:31.643] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:62:0)
[16:31:31.674] Build status: STARTED
[16:31:31.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:63:0) after 2m44s
[16:34:15.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:63:0)
[16:34:15.729] Build status: STARTED
[16:34:15.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:64:0) after 2m55s
[16:37:10.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:64:0)
[16:37:10.819] Build status: STARTED
[16:37:10.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:65:0) after 9m29s
[16:46:39.984] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:65:0)
[16:46:40.016] Build status: STARTED
[16:46:40.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:66:0) after 6m15s
[16:52:55.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:66:0)
[16:52:55.142] Build status: STARTED
[16:52:55.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:67:0) after 7m29s
[17:00:24.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:67:0)
[17:00:24.374] Build status: STARTED
[17:00:24.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:68:0) after 3m5s
[17:03:29.671] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:68:0)
[17:03:29.699] Build status: STARTED
[17:03:29.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:69:0) after 4m57s
[17:08:26.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:69:0)
[17:08:26.793] Build status: STARTED
[17:08:26.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:70:0) after 8m20s
[17:16:46.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:70:0)
[17:16:46.848] Build status: STARTED
[17:16:46.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:71:0) after 8m50s
[17:25:37.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:71:0)
[17:25:37.071] Build status: STARTED
[17:25:37.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:72:0) after 6m49s
[17:32:26.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:72:0)
[17:32:26.273] Build status: STARTED
[17:32:26.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:73:0) after 2m2s
[17:34:28.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:73:0)
[17:34:28.909] Build status: STARTED
[17:34:28.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:74:0) after 3m2s
[17:37:30.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:74:0)
[17:37:30.967] Build status: STARTED
[17:37:30.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:75:0) after 6m18s
[17:43:49.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:75:0)
[17:43:49.229] Build status: STARTED
[17:43:49.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:76:0) after 3m43s
[17:47:32.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:76:0)
[17:47:32.937] Build status: STARTED
[17:47:32.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:77:0) after 6m6s
[17:53:39.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:77:0)
[17:53:39.323] Build status: STARTED
[17:53:39.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:78:0) after 8m17s
[18:01:56.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:78:0)
[18:01:56.506] Build status: STARTED
[18:01:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:79:0) after 9m6s
[18:11:02.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:79:0)
[18:11:02.845] Build status: STARTED
[18:11:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:80:0) after 8m0s
[18:19:02.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:80:0)
[18:19:02.912] Build status: STARTED
[18:19:02.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:81:0) after 1m50s
[18:20:53.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:81:0)
[18:20:53.240] Build status: STARTED
[18:20:53.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:82:0) after 6m25s
[18:27:18.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:82:0)
[18:27:18.256] Build status: STARTED
[18:27:18.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:83:0) after 1m23s
[18:28:41.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:83:0)
[18:28:41.307] Build status: STARTED
[18:28:41.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:84:0) after 3m14s
[18:31:55.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:84:0)
[18:31:55.781] Build status: STARTED
[18:31:55.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:85:0) after 7m26s
[18:39:21.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:85:0)
[18:39:21.859] Build status: STARTED
[18:39:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:86:0) after 1m28s
[18:40:49.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:86:0)
[18:40:50.187] Build status: STARTED
[18:40:50.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:87:0) after 5m19s
[18:46:09.208] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:87:0)
[18:46:09.240] Build status: STARTED
[18:46:09.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:88:0) after 7m47s
[18:53:56.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:88:0)
[18:53:56.292] Build status: STARTED
[18:53:56.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:89:0) after 4m22s
[18:58:18.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:89:0)
[18:58:18.519] Build status: STARTED
[18:58:18.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:90:0) after 6m40s
[19:04:58.793] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:90:0)
[19:04:58.827] Build status: STARTED
[19:04:58.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:91:0) after 6m53s
[19:11:51.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:91:0)
[19:11:51.919] Build status: STARTED
[19:11:51.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:92:0) after 6m44s
[19:18:35.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:92:0)
[19:18:35.978] Build status: STARTED
[19:18:35.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:93:0) after 7m35s
[19:26:11.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:93:0)
[19:26:11.036] Build status: STARTED
[19:26:11.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:94:0) after 2m19s
[19:28:30.102] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:94:0)
[19:28:30.131] Build status: STARTED
[19:28:30.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:95:0) after 5m32s
[19:34:02.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:95:0)
[19:34:02.314] Build status: STARTED
[19:34:02.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:96:0) after 4m29s
[19:38:31.400] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:96:0)
[19:38:31.429] Build status: STARTED
[19:38:31.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:97:0) after 7m50s
[19:46:21.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:97:0)
[19:46:21.821] Build status: STARTED
[19:46:21.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:98:0) after 9m13s
[19:55:35.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:98:0)
[19:55:35.723] Build status: STARTED
[19:55:35.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:99:0) after 5m41s
[20:01:16.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:99:0)
[20:01:16.902] Build status: STARTED
[20:01:16.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:100:0) after 7m27s
[20:08:43.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:100:0)
[20:08:43.961] Build status: STARTED
[20:08:43.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:101:0) after 2m32s
[20:11:15.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:101:0)
[20:11:16.021] Build status: STARTED
[20:11:16.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:102:0) after 5m49s
[20:17:05.125] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:102:0)
[20:17:05.151] Build status: STARTED
[20:17:05.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:103:0) after 9m13s
[20:26:18.189] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:103:0)
[20:26:18.217] Build status: STARTED
[20:26:18.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:104:0) after 1m43s
[20:28:01.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:104:0)
[20:28:01.684] Build status: STARTED
[20:28:01.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:105:0) after 6m11s
[20:34:12.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:105:0)
[20:34:12.942] Build status: STARTED
[20:34:12.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:106:0) after 9m31s
[20:43:43.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:106:0)
[20:43:44.012] Build status: STARTED
[20:43:44.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:107:0) after 8m41s
[20:52:26.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:107:0)
[20:52:26.149] Build status: STARTED
[20:52:26.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:108:0) after 4m46s
[20:57:12.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:108:0)
[20:57:12.208] Build status: STARTED
[20:57:12.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:109:0) after 7m31s
[21:04:43.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:109:0)
[21:04:43.481] Build status: STARTED
[21:04:43.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:110:0) after 8m16s
[21:13:00.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:110:0)
[21:13:00.057] Build status: STARTED
[21:13:00.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:111:0) after 3m51s
[21:16:51.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:111:0)
[21:16:51.341] Build status: STARTED
[21:16:51.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:112:0) after 4m12s
[21:21:03.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:112:0)
[21:21:03.522] Build status: STARTED
[21:21:03.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:113:0) after 9m12s
[21:30:15.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:113:0)
[21:30:15.684] Build status: STARTED
[21:30:15.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:114:0) after 9m53s
[21:40:08.970] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:114:0)
[21:40:09.001] Build status: STARTED
[21:40:09.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:115:0) after 9m59s
[21:50:08.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:115:0)
[21:50:08.062] Build status: STARTED
[21:50:08.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9007439695245743824:116:0) after 8m22s
[21:51:08.854] Received PubSub notification, asking Buildbucket for the build status
[21:51:08.882] Build:
{
"id": "8842009633253931824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1072,
"createdBy": "project:chromium",
"createTime": "2021-07-11T10:32:09.557846Z",
"startTime": "2021-07-11T11:53:49.330727Z",
"endTime": "2021-07-11T21:51:08.145514140Z",
"updateTime": "2021-07-11T21:51:08.145962969Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bf640af13ac823d0e5d88c8f59d4c3b5d8a02120",
"ref": "refs/heads/main"
}
}
}
[21:51:08.882] Invocation finished in 11h19m0.608907633s with status FAILED