[00:28:28.727] New invocation is queued and will start shortly
[00:28:29.788] Starting the invocation (attempt 1)
[00:28:29.815] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dbbde7ad0bdeab32ba41a49a307486197d2d48eb"
[00:28:29.815] Popped gitiles commit info from properties and tags
[00:28:29.815] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:28:29.815] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:28:29.816] Buildbucket request:
{
"requestId": "8947140094579283920",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dbbde7ad0bdeab32ba41a49a307486197d2d48eb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947140094579283920"
},
{
"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"
}
}
[00:28:30.179] Scheduled build:
{
"id": "8781710032719052321",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5246,
"createdBy": "project:chromium",
"createTime": "2023-05-08T00:28:29.876745509Z",
"updateTime": "2023-05-08T00:28:29.876745509Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dbbde7ad0bdeab32ba41a49a307486197d2d48eb",
"ref": "refs/heads/main"
}
}
}
[00:28:30.179] Task URL: https://cr-buildbucket.appspot.com/build/8781710032719052321
[00:28:30.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:2:0) after 8m21s
[00:28:46.422] Received PubSub notification, asking Buildbucket for the build status
[00:28:46.439] Build status: STARTED
[00:36:51.200] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:2:0)
[00:36:51.216] Build status: STARTED
[00:36:51.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:4:0) after 2m56s
[00:39:47.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:4:0)
[00:39:47.353] Build status: STARTED
[00:39:47.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:5:0) after 3m27s
[00:43:14.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:5:0)
[00:43:14.545] Build status: STARTED
[00:43:14.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:6:0) after 4m28s
[00:47:42.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:6:0)
[00:47:42.634] Build status: STARTED
[00:47:42.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:7:0) after 4m39s
[00:52:21.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:7:0)
[00:52:21.743] Build status: STARTED
[00:52:21.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:8:0) after 8m23s
[01:00:44.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:8:0)
[01:00:44.987] Build status: STARTED
[01:00:44.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:9:0) after 9m50s
[01:10:34.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:9:0)
[01:10:35.011] Build status: STARTED
[01:10:35.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:10:0) after 1m36s
[01:12:11.035] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:10:0)
[01:12:11.060] Build status: STARTED
[01:12:11.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:11:0) after 5m42s
[01:17:53.078] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:11:0)
[01:17:53.099] Build status: STARTED
[01:17:53.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:12:0) after 2m57s
[01:20:50.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:12:0)
[01:20:50.159] Build status: STARTED
[01:20:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:13:0) after 2m40s
[01:23:30.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:13:0)
[01:23:30.195] Build status: STARTED
[01:23:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:14:0) after 1m27s
[01:24:57.254] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:14:0)
[01:24:57.272] Build status: STARTED
[01:24:57.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:15:0) after 1m10s
[01:26:07.391] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:15:0)
[01:26:07.414] Build status: STARTED
[01:26:07.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:16:0) after 1m40s
[01:27:47.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:16:0)
[01:27:47.447] Build status: STARTED
[01:27:47.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:17:0) after 6m32s
[01:34:19.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:17:0)
[01:34:19.503] Build status: STARTED
[01:34:19.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:18:0) after 8m5s
[01:42:24.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:18:0)
[01:42:24.572] Build status: STARTED
[01:42:24.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:19:0) after 1m10s
[01:43:34.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:19:0)
[01:43:34.847] Build status: STARTED
[01:43:34.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:20:0) after 1m7s
[01:44:41.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:20:0)
[01:44:41.881] Build status: STARTED
[01:44:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:21:0) after 6m37s
[01:51:18.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:21:0)
[01:51:18.969] Build status: STARTED
[01:51:18.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:22:0) after 6m55s
[01:58:13.999] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:22:0)
[01:58:14.016] Build status: STARTED
[01:58:14.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:23:0) after 1m53s
[02:00:07.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:23:0)
[02:00:07.052] Build status: STARTED
[02:00:07.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:24:0) after 9m51s
[02:09:58.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:24:0)
[02:09:58.235] Build status: STARTED
[02:09:58.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:25:0) after 4m22s
[02:14:20.306] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:25:0)
[02:14:20.383] Build status: STARTED
[02:14:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:26:0) after 3m50s
[02:18:10.410] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:26:0)
[02:18:10.426] Build status: STARTED
[02:18:10.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:27:0) after 5m33s
[02:23:43.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:27:0)
[02:23:43.655] Build status: STARTED
[02:23:43.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:28:0) after 5m10s
[02:28:53.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:28:0)
[02:28:53.699] Build status: STARTED
[02:28:53.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:29:0) after 3m36s
[02:32:29.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:29:0)
[02:32:29.777] Build status: STARTED
[02:32:29.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:30:0) after 4m34s
[02:37:03.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:30:0)
[02:37:03.899] Build status: STARTED
[02:37:03.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:31:0) after 1m4s
[02:38:07.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:31:0)
[02:38:07.935] Build status: STARTED
[02:38:07.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:32:0) after 8m4s
[02:46:11.958] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:32:0)
[02:46:11.992] Build status: STARTED
[02:46:11.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:33:0) after 1m50s
[02:48:02.145] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:33:0)
[02:48:02.164] Build status: STARTED
[02:48:02.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:34:0) after 3m5s
[02:51:07.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:34:0)
[02:51:07.200] Build status: STARTED
[02:51:07.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:35:0) after 1m44s
[02:52:51.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:35:0)
[02:52:51.316] Build status: STARTED
[02:52:51.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:36:0) after 6m18s
[02:59:09.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:36:0)
[02:59:09.353] Build status: STARTED
[02:59:09.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:37:0) after 9m27s
[03:08:36.369] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:37:0)
[03:08:36.386] Build status: STARTED
[03:08:36.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:38:0) after 7m34s
[03:16:10.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:38:0)
[03:16:10.425] Build status: STARTED
[03:16:10.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:39:0) after 3m57s
[03:20:07.400] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:39:0)
[03:20:07.430] Build status: STARTED
[03:20:07.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:40:0) after 7m2s
[03:27:09.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:40:0)
[03:27:09.636] Build status: STARTED
[03:27:09.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:41:0) after 7m6s
[03:34:15.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:41:0)
[03:34:15.799] Build status: STARTED
[03:34:15.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:42:0) after 4m52s
[03:39:07.958] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:42:0)
[03:39:07.975] Build status: STARTED
[03:39:07.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:43:0) after 3m5s
[03:42:12.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:43:0)
[03:42:13.046] Build status: STARTED
[03:42:13.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:44:0) after 3m50s
[03:46:03.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:44:0)
[03:46:03.184] Build status: STARTED
[03:46:03.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:45:0) after 2m36s
[03:48:39.203] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:45:0)
[03:48:39.377] Build status: STARTED
[03:48:39.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:46:0) after 4m25s
[03:53:04.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:46:0)
[03:53:04.637] Build status: STARTED
[03:53:04.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:47:0) after 2m17s
[03:55:21.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:47:0)
[03:55:21.803] Build status: STARTED
[03:55:21.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:48:0) after 5m46s
[04:01:07.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:48:0)
[04:01:07.848] Build status: STARTED
[04:01:07.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:49:0) after 3m1s
[04:04:08.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:49:0)
[04:04:08.960] Build status: STARTED
[04:04:08.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:50:0) after 2m48s
[04:06:56.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:50:0)
[04:06:57.004] Build status: STARTED
[04:06:57.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:51:0) after 9m25s
[04:16:22.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:51:0)
[04:16:22.083] Build status: STARTED
[04:16:22.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:52:0) after 2m34s
[04:18:56.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:52:0)
[04:18:56.215] Build status: STARTED
[04:18:56.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:53:0) after 2m39s
[04:21:35.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:53:0)
[04:21:35.265] Build status: STARTED
[04:21:35.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:54:0) after 1m43s
[04:23:18.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:54:0)
[04:23:18.365] Build status: STARTED
[04:23:18.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:55:0) after 7m57s
[04:31:15.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:55:0)
[04:31:15.517] Build status: STARTED
[04:31:15.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:56:0) after 2m42s
[04:33:57.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:56:0)
[04:33:57.704] Build status: STARTED
[04:33:57.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:57:0) after 7m9s
[04:41:06.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:57:0)
[04:41:06.760] Build status: STARTED
[04:41:06.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:58:0) after 3m8s
[04:44:14.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:58:0)
[04:44:14.795] Build status: STARTED
[04:44:14.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:59:0) after 9m0s
[04:53:14.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:59:0)
[04:53:14.840] Build status: STARTED
[04:53:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:60:0) after 8m19s
[05:01:33.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:60:0)
[05:01:33.888] Build status: STARTED
[05:01:33.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:61:0) after 1m46s
[05:03:20.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:61:0)
[05:03:20.048] Build status: STARTED
[05:03:20.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:62:0) after 3m41s
[05:07:01.081] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:62:0)
[05:07:01.095] Build status: STARTED
[05:07:01.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:63:0) after 2m43s
[05:09:44.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:63:0)
[05:09:44.144] Build status: STARTED
[05:09:44.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:64:0) after 4m17s
[05:14:01.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:64:0)
[05:14:01.278] Build status: STARTED
[05:14:01.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:65:0) after 6m5s
[05:20:06.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:65:0)
[05:20:06.420] Build status: STARTED
[05:20:06.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:66:0) after 7m6s
[05:27:12.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:66:0)
[05:27:12.459] Build status: STARTED
[05:27:12.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:67:0) after 5m31s
[05:32:43.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:67:0)
[05:32:43.510] Build status: STARTED
[05:32:43.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:68:0) after 7m45s
[05:40:28.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:68:0)
[05:40:28.601] Build status: STARTED
[05:40:28.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:69:0) after 8m31s
[05:48:59.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:69:0)
[05:48:59.637] Build status: STARTED
[05:48:59.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:70:0) after 8m34s
[05:57:33.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:70:0)
[05:57:33.741] Build status: STARTED
[05:57:33.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:71:0) after 4m50s
[06:02:23.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:71:0)
[06:02:23.789] Build status: STARTED
[06:02:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:72:0) after 9m39s
[06:12:02.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:72:0)
[06:12:02.875] Build status: STARTED
[06:12:02.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:73:0) after 6m48s
[06:18:51.012] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:73:0)
[06:18:51.034] Build status: STARTED
[06:18:51.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:74:0) after 9m7s
[06:27:58.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:74:0)
[06:27:58.077] Build status: STARTED
[06:27:58.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:75:0) after 9m3s
[06:37:01.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:75:0)
[06:37:01.222] Build status: STARTED
[06:37:01.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:76:0) after 4m23s
[06:41:24.305] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:76:0)
[06:41:24.325] Build status: STARTED
[06:41:24.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:77:0) after 8m14s
[06:49:38.343] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:77:0)
[06:49:38.365] Build status: STARTED
[06:49:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:78:0) after 7m39s
[06:57:17.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:78:0)
[06:57:17.420] Build status: STARTED
[06:57:17.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:79:0) after 2m48s
[07:00:05.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:79:0)
[07:00:05.620] Build status: STARTED
[07:00:05.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:80:0) after 2m9s
[07:02:14.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:80:0)
[07:02:14.706] Build status: STARTED
[07:02:14.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:81:0) after 7m42s
[07:09:56.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:81:0)
[07:09:56.742] Build status: STARTED
[07:09:56.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:82:0) after 1m42s
[07:11:38.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:82:0)
[07:11:38.750] Build status: STARTED
[07:11:38.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:83:0) after 3m37s
[07:15:15.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:83:0)
[07:15:15.844] Build status: STARTED
[07:15:15.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:84:0) after 6m55s
[07:22:11.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:84:0)
[07:22:11.142] Build status: STARTED
[07:22:11.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:85:0) after 1m39s
[07:23:50.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:85:0)
[07:23:50.331] Build status: STARTED
[07:23:50.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:86:0) after 9m2s
[07:32:52.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:86:0)
[07:32:52.379] Build status: STARTED
[07:32:52.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:87:0) after 4m48s
[07:37:40.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:87:0)
[07:37:40.619] Build status: STARTED
[07:37:40.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:88:0) after 9m26s
[07:47:06.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:88:0)
[07:47:06.730] Build status: STARTED
[07:47:06.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:89:0) after 6m8s
[07:53:14.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:89:0)
[07:53:14.836] Build status: STARTED
[07:53:14.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:90:0) after 2m48s
[07:56:02.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:90:0)
[07:56:02.968] Build status: STARTED
[07:56:02.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:91:0) after 4m7s
[08:00:10.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:91:0)
[08:00:10.060] Build status: STARTED
[08:00:10.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:92:0) after 6m52s
[08:07:02.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:92:0)
[08:07:02.111] Build status: STARTED
[08:07:02.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:93:0) after 8m48s
[08:15:50.210] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:93:0)
[08:15:50.228] Build status: STARTED
[08:15:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:94:0) after 5m13s
[08:21:03.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:94:0)
[08:21:03.221] Build status: STARTED
[08:21:03.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:95:0) after 4m7s
[08:25:10.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:95:0)
[08:25:10.307] Build status: STARTED
[08:25:10.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:96:0) after 5m56s
[08:31:06.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:96:0)
[08:31:06.400] Build status: STARTED
[08:31:06.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:97:0) after 1m30s
[08:32:36.420] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:97:0)
[08:32:36.442] Build status: STARTED
[08:32:36.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:98:0) after 5m35s
[08:38:11.563] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:98:0)
[08:38:11.583] Build status: STARTED
[08:38:11.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:99:0) after 7m11s
[08:45:22.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:99:0)
[08:45:22.747] Build status: STARTED
[08:45:22.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:100:0) after 5m16s
[08:50:38.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:100:0)
[08:50:38.782] Build status: STARTED
[08:50:38.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:101:0) after 3m31s
[08:54:09.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:101:0)
[08:54:09.828] Build status: STARTED
[08:54:09.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:102:0) after 4m5s
[08:58:14.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:102:0)
[08:58:14.846] Build status: STARTED
[08:58:14.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:103:0) after 3m7s
[09:01:21.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:103:0)
[09:01:21.933] Build status: STARTED
[09:01:21.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:104:0) after 7m49s
[09:09:10.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:104:0)
[09:09:10.976] Build status: STARTED
[09:09:10.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:105:0) after 7m36s
[09:16:47.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:105:0)
[09:16:47.087] Build status: STARTED
[09:16:47.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:106:0) after 8m40s
[09:25:27.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:106:0)
[09:25:27.381] Build status: STARTED
[09:25:27.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:107:0) after 1m58s
[09:27:25.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:107:0)
[09:27:25.623] Build status: STARTED
[09:27:25.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:108:0) after 5m2s
[09:32:27.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:108:0)
[09:32:27.827] Build status: STARTED
[09:32:27.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:109:0) after 8m52s
[09:41:19.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:109:0)
[09:41:19.979] Build status: STARTED
[09:41:19.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:110:0) after 3m28s
[09:44:48.003] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:110:0)
[09:44:48.025] Build status: STARTED
[09:44:48.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:111:0) after 5m43s
[09:50:31.046] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:111:0)
[09:50:31.068] Build status: STARTED
[09:50:31.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:112:0) after 6m39s
[09:57:10.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:112:0)
[09:57:10.243] Build status: STARTED
[09:57:10.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:113:0) after 8m20s
[10:05:30.356] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:113:0)
[10:05:30.379] Build status: STARTED
[10:05:30.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:114:0) after 2m16s
[10:07:46.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:114:0)
[10:07:46.458] Build status: STARTED
[10:07:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:115:0) after 9m29s
[10:17:15.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:115:0)
[10:17:15.508] Build status: STARTED
[10:17:15.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:116:0) after 6m43s
[10:23:59.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:116:0)
[10:23:59.083] Build status: STARTED
[10:23:59.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:117:0) after 4m26s
[10:28:25.131] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:117:0)
[10:28:25.148] Build status: STARTED
[10:28:25.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:118:0) after 1m2s
[10:29:27.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:118:0)
[10:29:27.445] Build status: STARTED
[10:29:27.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:119:0) after 7m59s
[10:37:26.588] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:119:0)
[10:37:26.606] Build status: STARTED
[10:37:26.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:120:0) after 8m32s
[10:45:58.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:120:0)
[10:45:58.605] Build status: STARTED
[10:45:58.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:121:0) after 5m11s
[10:51:09.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:121:0)
[10:51:09.704] Build status: STARTED
[10:51:09.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:122:0) after 6m13s
[10:57:22.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:122:0)
[10:57:22.738] Build status: STARTED
[10:57:22.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:123:0) after 2m34s
[10:59:56.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:123:0)
[10:59:57.016] Build status: STARTED
[10:59:57.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:124:0) after 4m5s
[11:04:02.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:124:0)
[11:04:02.085] Build status: STARTED
[11:04:02.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:125:0) after 4m0s
[11:08:02.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:125:0)
[11:08:02.297] Build status: STARTED
[11:08:02.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8947140094579283920:126:0) after 6m40s
[11:14:42.079] Received PubSub notification, asking Buildbucket for the build status
[11:14:42.101] Build:
{
"id": "8781710032719052321",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5246,
"createdBy": "project:chromium",
"createTime": "2023-05-08T00:28:29.876745509Z",
"startTime": "2023-05-08T00:28:45.861434Z",
"endTime": "2023-05-08T11:14:35.081116161Z",
"updateTime": "2023-05-08T11:14:35.081116161Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dbbde7ad0bdeab32ba41a49a307486197d2d48eb",
"ref": "refs/heads/main"
}
}
}
[11:14:42.101] Invocation finished in 10h46m13.382784562s with status FAILED