[14:09:07.386] New invocation is queued and will start shortly
[14:09:08.472] Starting the invocation (attempt 1)
[14:09:08.498] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed2adcc9b76640e83f6f868fbc92087ef40c49d3"
[14:09:08.498] Popped gitiles commit info from properties and tags
[14:09:08.498] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:09:08.498] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:09:08.498] Buildbucket request:
{
"requestId": "8941562049148879712",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed2adcc9b76640e83f6f868fbc92087ef40c49d3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8941562049148879712"
},
{
"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:09:09.030] Scheduled build:
{
"id": "8776131987257847729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5748,
"createdBy": "project:chromium",
"createTime": "2023-07-08T14:09:08.568467540Z",
"updateTime": "2023-07-08T14:09:08.568467540Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed2adcc9b76640e83f6f868fbc92087ef40c49d3",
"ref": "refs/heads/main"
}
}
}
[14:09:09.030] Task URL: https://cr-buildbucket.appspot.com/build/8776131987257847729
[14:09:09.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:2:0) after 2m6s
[14:11:15.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:2:0)
[14:11:15.090] Build status: SCHEDULED
[14:11:15.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:3:0) after 8m15s
[14:14:34.612] Received PubSub notification, asking Buildbucket for the build status
[14:14:34.628] Build status: STARTED
[14:19:30.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:3:0)
[14:19:30.193] Build status: STARTED
[14:19:30.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:5:0) after 9m34s
[14:29:04.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:5:0)
[14:29:04.288] Build status: STARTED
[14:29:04.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:6:0) after 1m38s
[14:30:42.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:6:0)
[14:30:42.532] Build status: STARTED
[14:30:42.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:7:0) after 2m31s
[14:33:13.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:7:0)
[14:33:13.569] Build status: STARTED
[14:33:13.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:8:0) after 2m28s
[14:35:41.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:8:0)
[14:35:41.573] Build status: STARTED
[14:35:41.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:9:0) after 2m7s
[14:37:48.653] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:9:0)
[14:37:48.669] Build status: STARTED
[14:37:48.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:10:0) after 1m32s
[14:39:20.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:10:0)
[14:39:20.766] Build status: STARTED
[14:39:20.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:11:0) after 4m3s
[14:43:23.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:11:0)
[14:43:23.809] Build status: STARTED
[14:43:23.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:12:0) after 2m2s
[14:45:25.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:12:0)
[14:45:25.858] Build status: STARTED
[14:45:25.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:13:0) after 8m4s
[14:53:29.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:13:0)
[14:53:29.991] Build status: STARTED
[14:53:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:14:0) after 7m26s
[15:00:56.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:14:0)
[15:00:56.076] Build status: STARTED
[15:00:56.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:15:0) after 6m57s
[15:07:53.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:15:0)
[15:07:53.126] Build status: STARTED
[15:07:53.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:16:0) after 3m39s
[15:11:32.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:16:0)
[15:11:32.282] Build status: STARTED
[15:11:32.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:17:0) after 2m56s
[15:14:28.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:17:0)
[15:14:28.340] Build status: STARTED
[15:14:28.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:18:0) after 4m54s
[15:19:22.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:18:0)
[15:19:22.532] Build status: STARTED
[15:19:22.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:19:0) after 7m51s
[15:27:13.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:19:0)
[15:27:13.777] Build status: STARTED
[15:27:13.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:20:0) after 1m40s
[15:28:54.094] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:20:0)
[15:28:54.111] Build status: STARTED
[15:28:54.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:21:0) after 9m0s
[15:37:54.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:21:0)
[15:37:54.369] Build status: STARTED
[15:37:54.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:22:0) after 7m16s
[15:45:10.939] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:22:0)
[15:45:10.962] Build status: STARTED
[15:45:10.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:23:0) after 1m42s
[15:46:52.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:23:0)
[15:46:53.023] Build status: STARTED
[15:46:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:24:0) after 4m35s
[15:51:28.052] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:24:0)
[15:51:28.069] Build status: STARTED
[15:51:28.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:25:0) after 8m59s
[16:00:27.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:25:0)
[16:00:27.683] Build status: STARTED
[16:00:27.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:26:0) after 3m45s
[16:04:12.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:26:0)
[16:04:12.839] Build status: STARTED
[16:04:12.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:27:0) after 6m16s
[16:10:29.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:27:0)
[16:10:29.497] Build status: STARTED
[16:10:29.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:28:0) after 7m32s
[16:18:01.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:28:0)
[16:18:01.654] Build status: STARTED
[16:18:01.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:29:0) after 9m55s
[16:27:56.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:29:0)
[16:27:56.694] Build status: STARTED
[16:27:56.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:30:0) after 5m43s
[16:33:39.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:30:0)
[16:33:39.933] Build status: STARTED
[16:33:39.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:31:0) after 7m50s
[16:41:29.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:31:0)
[16:41:30.044] Build status: STARTED
[16:41:30.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:32:0) after 7m58s
[16:49:28.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:32:0)
[16:49:28.085] Build status: STARTED
[16:49:28.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:33:0) after 2m2s
[16:51:30.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:33:0)
[16:51:30.339] Build status: STARTED
[16:51:30.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:34:0) after 6m1s
[16:57:33.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:34:0)
[16:57:33.111] Build status: STARTED
[16:57:33.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:35:0) after 8m35s
[17:06:08.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:35:0)
[17:06:08.163] Build status: STARTED
[17:06:08.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:36:0) after 4m14s
[17:10:22.190] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:36:0)
[17:10:22.210] Build status: STARTED
[17:10:22.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:37:0) after 2m12s
[17:12:34.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:37:0)
[17:12:34.249] Build status: STARTED
[17:12:34.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:38:0) after 8m54s
[17:21:28.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:38:0)
[17:21:28.321] Build status: STARTED
[17:21:28.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:39:0) after 4m39s
[17:26:07.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:39:0)
[17:26:07.390] Build status: STARTED
[17:26:07.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:40:0) after 2m33s
[17:28:40.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:40:0)
[17:28:40.450] Build status: STARTED
[17:28:40.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:41:0) after 8m8s
[17:36:48.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:41:0)
[17:36:48.642] Build status: STARTED
[17:36:48.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:42:0) after 1m21s
[17:38:09.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:42:0)
[17:38:09.653] Build status: STARTED
[17:38:09.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:43:0) after 7m2s
[17:45:11.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:43:0)
[17:45:11.720] Build status: STARTED
[17:45:11.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:44:0) after 1m30s
[17:46:41.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:44:0)
[17:46:41.752] Build status: STARTED
[17:46:41.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:45:0) after 6m7s
[17:52:48.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:45:0)
[17:52:48.798] Build status: STARTED
[17:52:48.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:46:0) after 4m0s
[17:56:49.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:46:0)
[17:56:49.106] Build status: STARTED
[17:56:49.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:47:0) after 5m36s
[18:02:25.125] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:47:0)
[18:02:25.146] Build status: STARTED
[18:02:25.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:48:0) after 8m28s
[18:10:53.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:48:0)
[18:10:53.680] Build status: STARTED
[18:10:53.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:49:0) after 7m1s
[18:17:54.708] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:49:0)
[18:17:54.762] Build status: STARTED
[18:17:54.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:50:0) after 4m37s
[18:22:31.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:50:0)
[18:22:31.799] Build status: STARTED
[18:22:31.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:51:0) after 6m51s
[18:29:23.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:51:0)
[18:29:23.095] Build status: STARTED
[18:29:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:52:0) after 4m47s
[18:34:10.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:52:0)
[18:34:10.139] Build status: STARTED
[18:34:10.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:53:0) after 7m14s
[18:41:24.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:53:0)
[18:41:24.230] Build status: STARTED
[18:41:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:54:0) after 6m26s
[18:47:50.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:54:0)
[18:47:50.519] Build status: STARTED
[18:47:50.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:55:0) after 2m33s
[18:50:23.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:55:0)
[18:50:23.843] Build status: STARTED
[18:50:23.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:56:0) after 9m58s
[19:00:21.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:56:0)
[19:00:21.903] Build status: STARTED
[19:00:21.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:57:0) after 5m48s
[19:06:10.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:57:0)
[19:06:10.081] Build status: STARTED
[19:06:10.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:58:0) after 5m6s
[19:11:16.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:58:0)
[19:11:16.113] Build status: STARTED
[19:11:16.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:59:0) after 3m42s
[19:14:58.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:59:0)
[19:14:58.169] Build status: STARTED
[19:14:58.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:60:0) after 9m19s
[19:24:17.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:60:0)
[19:24:17.451] Build status: STARTED
[19:24:17.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:61:0) after 9m57s
[19:34:14.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:61:0)
[19:34:14.498] Build status: STARTED
[19:34:14.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:62:0) after 7m3s
[19:41:17.519] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:62:0)
[19:41:17.588] Build status: STARTED
[19:41:17.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:63:0) after 4m58s
[19:46:15.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:63:0)
[19:46:15.905] Build status: STARTED
[19:46:15.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:64:0) after 9m42s
[19:55:58.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:64:0)
[19:55:58.216] Build status: STARTED
[19:55:58.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:65:0) after 8m33s
[20:04:31.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:65:0)
[20:04:31.249] Build status: STARTED
[20:04:31.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:66:0) after 8m21s
[20:12:52.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:66:0)
[20:12:52.365] Build status: STARTED
[20:12:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:67:0) after 9m7s
[20:21:59.383] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:67:0)
[20:21:59.403] Build status: STARTED
[20:21:59.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:68:0) after 4m2s
[20:26:01.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:68:0)
[20:26:01.445] Build status: STARTED
[20:26:01.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:69:0) after 1m38s
[20:27:39.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:69:0)
[20:27:39.481] Build status: STARTED
[20:27:39.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:70:0) after 1m20s
[20:28:59.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:70:0)
[20:28:59.532] Build status: STARTED
[20:28:59.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:71:0) after 4m12s
[20:33:11.547] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:71:0)
[20:33:11.573] Build status: STARTED
[20:33:11.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:72:0) after 2m15s
[20:35:26.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:72:0)
[20:35:26.619] Build status: STARTED
[20:35:26.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:73:0) after 8m50s
[20:44:16.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:73:0)
[20:44:16.665] Build status: STARTED
[20:44:16.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:74:0) after 2m16s
[20:46:32.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:74:0)
[20:46:32.887] Build status: STARTED
[20:46:32.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:75:0) after 7m55s
[20:54:27.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:75:0)
[20:54:27.972] Build status: STARTED
[20:54:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:76:0) after 3m7s
[20:57:36.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:76:0)
[20:57:36.395] Build status: STARTED
[20:57:36.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:77:0) after 4m8s
[21:01:44.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:77:0)
[21:01:44.996] Build status: STARTED
[21:01:44.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:78:0) after 1m9s
[21:02:54.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:78:0)
[21:02:54.027] Build status: STARTED
[21:02:54.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:79:0) after 7m32s
[21:10:26.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:79:0)
[21:10:26.065] Build status: STARTED
[21:10:26.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:80:0) after 8m58s
[21:19:24.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:80:0)
[21:19:24.139] Build status: STARTED
[21:19:24.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:81:0) after 7m38s
[21:27:02.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:81:0)
[21:27:02.238] Build status: STARTED
[21:27:02.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:82:0) after 5m44s
[21:32:46.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:82:0)
[21:32:46.274] Build status: STARTED
[21:32:46.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:83:0) after 6m56s
[21:39:42.294] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:83:0)
[21:39:42.311] Build status: STARTED
[21:39:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:84:0) after 8m45s
[21:48:27.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:84:0)
[21:48:27.344] Build status: STARTED
[21:48:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:85:0) after 9m53s
[21:58:20.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:85:0)
[21:58:20.863] Build status: STARTED
[21:58:20.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:86:0) after 3m36s
[22:01:56.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:86:0)
[22:01:56.978] Build status: STARTED
[22:01:56.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:87:0) after 4m4s
[22:06:01.175] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:87:0)
[22:06:01.193] Build status: STARTED
[22:06:01.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:88:0) after 8m32s
[22:14:33.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:88:0)
[22:14:33.227] Build status: STARTED
[22:14:33.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:89:0) after 4m43s
[22:19:16.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:89:0)
[22:19:16.269] Build status: STARTED
[22:19:16.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:90:0) after 5m5s
[22:24:21.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:90:0)
[22:24:21.665] Build status: STARTED
[22:24:21.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:91:0) after 1m56s
[22:26:17.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:91:0)
[22:26:17.701] Build status: STARTED
[22:26:17.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:92:0) after 7m53s
[22:34:10.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:92:0)
[22:34:10.808] Build status: STARTED
[22:34:10.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:93:0) after 1m19s
[22:35:29.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:93:0)
[22:35:30.010] Build status: STARTED
[22:35:30.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:94:0) after 1m37s
[22:37:07.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:94:0)
[22:37:07.477] Build status: STARTED
[22:37:07.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:95:0) after 9m0s
[22:46:07.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:95:0)
[22:46:07.564] Build status: STARTED
[22:46:07.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:96:0) after 3m40s
[22:49:47.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:96:0)
[22:49:47.629] Build status: STARTED
[22:49:47.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:97:0) after 1m55s
[22:51:42.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:97:0)
[22:51:42.801] Build status: STARTED
[22:51:42.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:98:0) after 6m20s
[22:58:02.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:98:0)
[22:58:02.866] Build status: STARTED
[22:58:02.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:99:0) after 8m21s
[23:06:23.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:99:0)
[23:06:23.933] Build status: STARTED
[23:06:23.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:100:0) after 4m42s
[23:11:05.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:100:0)
[23:11:05.967] Build status: STARTED
[23:11:05.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:101:0) after 2m31s
[23:13:36.991] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:101:0)
[23:13:37.007] Build status: STARTED
[23:13:37.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:102:0) after 9m57s
[23:23:34.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:102:0)
[23:23:34.040] Build status: STARTED
[23:23:34.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:103:0) after 1m43s
[23:25:17.067] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:103:0)
[23:25:17.094] Build status: STARTED
[23:25:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:104:0) after 2m19s
[23:27:36.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:104:0)
[23:27:36.443] Build status: STARTED
[23:27:36.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:105:0) after 8m35s
[23:36:11.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:105:0)
[23:36:11.483] Build status: STARTED
[23:36:11.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:106:0) after 4m45s
[23:40:56.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:106:0)
[23:40:56.517] Build status: STARTED
[23:40:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:107:0) after 8m5s
[23:49:02.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:107:0)
[23:49:02.147] Build status: STARTED
[23:49:02.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:108:0) after 7m55s
[23:56:57.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:108:0)
[23:56:57.197] Build status: STARTED
[23:56:57.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:109:0) after 2m28s
[23:59:26.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:109:0)
[23:59:26.264] Build status: STARTED
[23:59:26.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:110:0) after 5m25s
[00:04:51.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:110:0)
[00:04:51.308] Build status: STARTED
[00:04:51.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:111:0) after 2m31s
[00:07:23.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:111:0)
[00:07:23.122] Build status: STARTED
[00:07:23.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:112:0) after 5m3s
[00:12:26.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:112:0)
[00:12:26.336] Build status: STARTED
[00:12:26.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:113:0) after 2m55s
[00:15:21.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:113:0)
[00:15:21.386] Build status: STARTED
[00:15:21.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:114:0) after 2m44s
[00:18:05.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:114:0)
[00:18:05.431] Build status: STARTED
[00:18:05.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:115:0) after 9m45s
[00:27:50.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:115:0)
[00:27:50.533] Build status: STARTED
[00:27:50.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:116:0) after 8m48s
[00:36:38.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:116:0)
[00:36:38.577] Build status: STARTED
[00:36:38.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:117:0) after 1m51s
[00:38:30.175] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:117:0)
[00:38:30.250] Build status: STARTED
[00:38:30.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:118:0) after 2m45s
[00:41:15.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:118:0)
[00:41:15.420] Build status: STARTED
[00:41:15.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:119:0) after 8m10s
[00:49:25.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:119:0)
[00:49:25.913] Build status: STARTED
[00:49:25.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:120:0) after 5m28s
[00:54:54.614] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:120:0)
[00:54:54.630] Build status: STARTED
[00:54:54.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:121:0) after 7m55s
[01:02:50.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:121:0)
[01:02:50.208] Build status: STARTED
[01:02:50.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:122:0) after 1m40s
[01:04:30.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:122:0)
[01:04:30.905] Build status: STARTED
[01:04:30.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:123:0) after 9m16s
[01:13:47.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:123:0)
[01:13:47.759] Build status: STARTED
[01:13:47.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8941562049148879712:124:0) after 8m52s
[01:22:30.388] Received PubSub notification, asking Buildbucket for the build status
[01:22:30.427] Build:
{
"id": "8776131987257847729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5748,
"createdBy": "project:chromium",
"createTime": "2023-07-08T14:09:08.568467540Z",
"startTime": "2023-07-08T14:14:34.018298Z",
"endTime": "2023-07-09T01:22:30.137053981Z",
"updateTime": "2023-07-09T01:22:30.137053981Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed2adcc9b76640e83f6f868fbc92087ef40c49d3",
"ref": "refs/heads/main"
}
}
}
[01:22:30.427] Invocation finished in 11h13m23.046582007s with status SUCCEEDED