[11:25:42.748] New invocation is queued and will start shortly
[11:25:43.838] Starting the invocation (attempt 1)
[11:25:43.868] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a0b4a40f7d3a121f450030f49974e597604ed67"
[11:25:43.868] Popped gitiles commit info from properties and tags
[11:25:43.868] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:25:43.868] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:25:43.868] Buildbucket request:
{
"requestId": "8929251142635437664",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a0b4a40f7d3a121f450030f49974e597604ed67",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929251142635437664"
},
{
"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"
}
}
[11:25:44.516] Scheduled build:
{
"id": "8763821080729998593",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 6986,
"createdBy": "project:chromium",
"createTime": "2023-11-21T11:25:43.936737098Z",
"updateTime": "2023-11-21T11:25:43.936737098Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a0b4a40f7d3a121f450030f49974e597604ed67",
"ref": "refs/heads/main"
}
}
}
[11:25:44.516] Task URL: https://cr-buildbucket.appspot.com/build/8763821080729998593
[11:25:44.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:2:0) after 7m2s
[11:25:45.385] Received PubSub notification, asking Buildbucket for the build status
[11:25:45.401] Build status: SCHEDULED
[11:27:31.759] Received PubSub notification, asking Buildbucket for the build status
[11:27:31.791] Build status: STARTED
[11:32:46.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:2:0)
[11:32:46.954] Build status: STARTED
[11:32:46.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:5:0) after 8m26s
[11:41:13.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:5:0)
[11:41:13.101] Build status: STARTED
[11:41:13.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:6:0) after 2m4s
[11:43:17.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:6:0)
[11:43:17.171] Build status: STARTED
[11:43:17.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:7:0) after 5m42s
[11:48:59.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:7:0)
[11:48:59.293] Build status: STARTED
[11:48:59.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:8:0) after 2m5s
[11:51:04.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:8:0)
[11:51:04.336] Build status: STARTED
[11:51:04.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:9:0) after 1m44s
[11:52:48.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:9:0)
[11:52:48.493] Build status: STARTED
[11:52:48.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:10:0) after 8m1s
[12:00:49.643] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:10:0)
[12:00:49.710] Build status: STARTED
[12:00:49.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:11:0) after 8m23s
[12:09:12.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:11:0)
[12:09:12.756] Build status: STARTED
[12:09:12.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:12:0) after 9m45s
[12:18:57.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:12:0)
[12:18:57.939] Build status: STARTED
[12:18:57.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:13:0) after 6m44s
[12:25:42.033] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:13:0)
[12:25:42.051] Build status: STARTED
[12:25:42.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:14:0) after 4m27s
[12:30:09.227] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:14:0)
[12:30:09.270] Build status: STARTED
[12:30:09.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:15:0) after 1m16s
[12:31:25.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:15:0)
[12:31:25.895] Build status: STARTED
[12:31:25.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:16:0) after 9m23s
[12:40:48.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:16:0)
[12:40:48.944] Build status: STARTED
[12:40:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:17:0) after 4m43s
[12:45:32.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:17:0)
[12:45:32.083] Build status: STARTED
[12:45:32.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:18:0) after 2m45s
[12:48:17.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:18:0)
[12:48:17.230] Build status: STARTED
[12:48:17.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:19:0) after 9m15s
[12:57:32.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:19:0)
[12:57:32.335] Build status: STARTED
[12:57:32.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:20:0) after 9m9s
[13:06:41.400] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:20:0)
[13:06:41.424] Build status: STARTED
[13:06:41.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:21:0) after 5m40s
[13:12:21.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:21:0)
[13:12:21.516] Build status: STARTED
[13:12:21.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:22:0) after 1m54s
[13:14:15.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:22:0)
[13:14:15.545] Build status: STARTED
[13:14:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:23:0) after 5m55s
[13:20:10.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:23:0)
[13:20:10.645] Build status: STARTED
[13:20:10.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:24:0) after 2m21s
[13:22:31.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:24:0)
[13:22:31.693] Build status: STARTED
[13:22:31.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:25:0) after 6m31s
[13:29:02.744] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:25:0)
[13:29:02.773] Build status: STARTED
[13:29:02.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:26:0) after 7m26s
[13:36:28.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:26:0)
[13:36:28.792] Build status: STARTED
[13:36:28.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:27:0) after 2m57s
[13:39:25.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:27:0)
[13:39:25.927] Build status: STARTED
[13:39:25.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:28:0) after 7m38s
[13:47:04.608] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:28:0)
[13:47:04.635] Build status: STARTED
[13:47:04.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:29:0) after 1m54s
[13:48:58.708] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:29:0)
[13:48:58.764] Build status: STARTED
[13:48:58.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:30:0) after 7m33s
[13:56:31.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:30:0)
[13:56:31.840] Build status: STARTED
[13:56:31.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:31:0) after 2m19s
[13:58:50.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:31:0)
[13:58:50.879] Build status: STARTED
[13:58:50.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:32:0) after 2m58s
[14:01:48.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:32:0)
[14:01:48.909] Build status: STARTED
[14:01:48.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:33:0) after 2m24s
[14:04:12.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:33:0)
[14:04:12.984] Build status: STARTED
[14:04:12.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:34:0) after 2m58s
[14:07:11.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:34:0)
[14:07:11.087] Build status: STARTED
[14:07:11.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:35:0) after 6m9s
[14:13:20.111] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:35:0)
[14:13:20.313] Build status: STARTED
[14:13:20.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:36:0) after 7m15s
[14:20:35.345] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:36:0)
[14:20:35.377] Build status: STARTED
[14:20:35.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:37:0) after 3m44s
[14:24:19.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:37:0)
[14:24:19.402] Build status: STARTED
[14:24:19.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:38:0) after 4m7s
[14:28:26.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:38:0)
[14:28:26.495] Build status: STARTED
[14:28:26.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:39:0) after 6m58s
[14:35:24.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:39:0)
[14:35:24.767] Build status: STARTED
[14:35:24.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:40:0) after 2m31s
[14:37:55.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:40:0)
[14:37:55.847] Build status: STARTED
[14:37:55.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:41:0) after 6m27s
[14:44:23.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:41:0)
[14:44:23.572] Build status: STARTED
[14:44:23.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:42:0) after 3m9s
[14:47:32.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:42:0)
[14:47:32.756] Build status: STARTED
[14:47:32.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:43:0) after 5m34s
[14:53:06.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:43:0)
[14:53:06.916] Build status: STARTED
[14:53:06.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:44:0) after 8m1s
[15:01:08.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:44:0)
[15:01:08.672] Build status: STARTED
[15:01:08.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:45:0) after 8m19s
[15:09:27.732] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:45:0)
[15:09:27.824] Build status: STARTED
[15:09:27.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:46:0) after 2m20s
[15:11:49.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:46:0)
[15:11:49.460] Build status: STARTED
[15:11:49.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:47:0) after 8m34s
[15:20:23.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:47:0)
[15:20:23.624] Build status: STARTED
[15:20:23.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:48:0) after 8m5s
[15:28:28.644] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:48:0)
[15:28:28.719] Build status: STARTED
[15:28:28.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:49:0) after 1m46s
[15:30:14.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:49:0)
[15:30:14.772] Build status: STARTED
[15:30:14.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:50:0) after 5m20s
[15:35:34.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:50:0)
[15:35:34.927] Build status: STARTED
[15:35:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:51:0) after 9m57s
[15:45:32.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:51:0)
[15:45:32.076] Build status: STARTED
[15:45:32.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:52:0) after 1m12s
[15:46:44.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:52:0)
[15:46:44.278] Build status: STARTED
[15:46:44.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:53:0) after 8m16s
[15:55:00.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:53:0)
[15:55:00.364] Build status: STARTED
[15:55:00.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:54:0) after 3m3s
[15:58:03.420] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:54:0)
[15:58:03.447] Build status: STARTED
[15:58:03.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:55:0) after 1m25s
[15:59:28.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:55:0)
[15:59:28.738] Build status: STARTED
[15:59:28.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:56:0) after 9m9s
[16:08:37.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:56:0)
[16:08:37.808] Build status: STARTED
[16:08:37.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:57:0) after 1m24s
[16:10:02.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:57:0)
[16:10:02.040] Build status: STARTED
[16:10:02.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:58:0) after 9m59s
[16:20:01.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:58:0)
[16:20:01.669] Build status: STARTED
[16:20:01.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:59:0) after 5m3s
[16:25:04.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:59:0)
[16:25:04.790] Build status: STARTED
[16:25:04.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:60:0) after 7m58s
[16:33:03.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:60:0)
[16:33:03.372] Build status: STARTED
[16:33:03.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:61:0) after 7m3s
[16:40:06.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:61:0)
[16:40:06.542] Build status: STARTED
[16:40:06.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:62:0) after 3m54s
[16:44:00.524] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:62:0)
[16:44:00.548] Build status: STARTED
[16:44:00.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:63:0) after 6m51s
[16:50:51.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:63:0)
[16:50:51.678] Build status: STARTED
[16:50:51.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:64:0) after 8m6s
[16:58:57.712] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:64:0)
[16:58:57.735] Build status: STARTED
[16:58:57.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:65:0) after 2m44s
[17:01:41.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:65:0)
[17:01:41.801] Build status: STARTED
[17:01:41.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:66:0) after 2m1s
[17:03:42.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:66:0)
[17:03:42.868] Build status: STARTED
[17:03:42.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:67:0) after 8m59s
[17:12:41.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:67:0)
[17:12:41.990] Build status: STARTED
[17:12:41.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:68:0) after 8m58s
[17:21:40.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:68:0)
[17:21:40.147] Build status: STARTED
[17:21:40.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:69:0) after 6m0s
[17:27:40.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:69:0)
[17:27:40.194] Build status: STARTED
[17:27:40.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:70:0) after 8m25s
[17:36:05.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:70:0)
[17:36:05.288] Build status: STARTED
[17:36:05.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:71:0) after 3m14s
[17:39:19.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:71:0)
[17:39:19.344] Build status: STARTED
[17:39:19.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:72:0) after 1m42s
[17:41:01.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:72:0)
[17:41:01.445] Build status: STARTED
[17:41:01.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:73:0) after 8m50s
[17:49:51.466] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:73:0)
[17:49:51.483] Build status: STARTED
[17:49:51.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:74:0) after 3m48s
[17:53:39.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:74:0)
[17:53:39.528] Build status: STARTED
[17:53:39.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:75:0) after 5m57s
[17:59:36.563] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:75:0)
[17:59:36.583] Build status: STARTED
[17:59:36.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:76:0) after 4m26s
[18:04:02.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:76:0)
[18:04:02.680] Build status: STARTED
[18:04:02.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:77:0) after 4m25s
[18:08:27.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:77:0)
[18:08:27.753] Build status: STARTED
[18:08:27.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:78:0) after 4m18s
[18:12:45.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:78:0)
[18:12:45.872] Build status: STARTED
[18:12:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:79:0) after 8m37s
[18:21:22.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:79:0)
[18:21:22.984] Build status: STARTED
[18:21:22.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:80:0) after 5m0s
[18:26:23.290] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:80:0)
[18:26:23.322] Build status: STARTED
[18:26:23.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:81:0) after 4m7s
[18:30:30.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:81:0)
[18:30:30.758] Build status: STARTED
[18:30:30.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:82:0) after 6m18s
[18:36:48.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:82:0)
[18:36:48.967] Build status: STARTED
[18:36:48.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:83:0) after 4m53s
[18:41:41.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:83:0)
[18:41:42.019] Build status: STARTED
[18:41:42.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:84:0) after 6m6s
[18:47:48.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:84:0)
[18:47:48.257] Build status: STARTED
[18:47:48.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:85:0) after 8m42s
[18:56:30.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:85:0)
[18:56:30.298] Build status: STARTED
[18:56:30.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:86:0) after 8m7s
[19:04:37.339] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:86:0)
[19:04:37.415] Build status: STARTED
[19:04:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:87:0) after 3m43s
[19:08:20.467] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:87:0)
[19:08:20.495] Build status: STARTED
[19:08:20.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:88:0) after 1m52s
[19:10:12.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:88:0)
[19:10:12.580] Build status: STARTED
[19:10:12.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:89:0) after 5m19s
[19:15:31.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:89:0)
[19:15:31.653] Build status: STARTED
[19:15:31.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:90:0) after 6m33s
[19:22:04.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:90:0)
[19:22:04.723] Build status: STARTED
[19:22:04.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:91:0) after 1m23s
[19:23:27.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:91:0)
[19:23:27.763] Build status: STARTED
[19:23:27.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:92:0) after 3m38s
[19:27:05.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:92:0)
[19:27:05.849] Build status: STARTED
[19:27:05.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8929251142635437664:93:0) after 8m36s
[19:27:34.680] Received PubSub notification, asking Buildbucket for the build status
[19:27:34.730] Build:
{
"id": "8763821080729998593",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 6986,
"createdBy": "project:chromium",
"createTime": "2023-11-21T11:25:43.936737098Z",
"startTime": "2023-11-21T11:27:27.334482Z",
"endTime": "2023-11-21T19:27:34.065505Z",
"updateTime": "2023-11-21T19:27:34.065505Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a0b4a40f7d3a121f450030f49974e597604ed67",
"ref": "refs/heads/main"
}
}
}
[19:27:34.730] Invocation finished in 8h1m51.995870476s with status SUCCEEDED