[00:10:05.190] New invocation is queued and will start shortly
[00:10:06.837] Starting the invocation (attempt 1)
[00:10:06.873] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa4790f909674e51a085c33b7c1d6f9717cf1795"
[00:10:06.873] Popped gitiles commit info from properties and tags
[00:10:06.873] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:10:06.873] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:10:06.873] Buildbucket request:
{
"requestId": "8937175585421400560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa4790f909674e51a085c33b7c1d6f9717cf1795",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937175585421400560"
},
{
"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:10:07.499] Scheduled build:
{
"id": "8771745522936824033",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 6111,
"createdBy": "project:chromium",
"createTime": "2023-08-26T00:10:06.931033179Z",
"updateTime": "2023-08-26T00:10:06.931033179Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa4790f909674e51a085c33b7c1d6f9717cf1795",
"ref": "refs/heads/main"
}
}
}
[00:10:07.499] Task URL: https://cr-buildbucket.appspot.com/build/8771745522936824033
[00:10:07.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:2:0) after 1m16s
[00:10:07.758] Received PubSub notification, asking Buildbucket for the build status
[00:10:07.781] Build status: SCHEDULED
[00:10:15.276] Received PubSub notification, asking Buildbucket for the build status
[00:10:15.372] Build status: STARTED
[00:11:23.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:2:0)
[00:11:23.675] Build status: STARTED
[00:11:23.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:5:0) after 7m30s
[00:18:53.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:5:0)
[00:18:53.980] Build status: STARTED
[00:18:53.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:6:0) after 4m30s
[00:23:24.464] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:6:0)
[00:23:24.482] Build status: STARTED
[00:23:24.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:7:0) after 2m25s
[00:25:49.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:7:0)
[00:25:49.586] Build status: STARTED
[00:25:49.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:8:0) after 8m7s
[00:33:56.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:8:0)
[00:33:56.590] Build status: STARTED
[00:33:56.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:9:0) after 7m29s
[00:41:25.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:9:0)
[00:41:25.682] Build status: STARTED
[00:41:25.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:10:0) after 9m59s
[00:51:24.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:10:0)
[00:51:24.739] Build status: STARTED
[00:51:24.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:11:0) after 8m55s
[01:00:20.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:11:0)
[01:00:20.024] Build status: STARTED
[01:00:20.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:12:0) after 4m12s
[01:04:32.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:12:0)
[01:04:32.432] Build status: STARTED
[01:04:32.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:13:0) after 1m3s
[01:05:35.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:13:0)
[01:05:35.560] Build status: STARTED
[01:05:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:14:0) after 5m49s
[01:11:24.926] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:14:0)
[01:11:24.952] Build status: STARTED
[01:11:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:15:0) after 1m39s
[01:13:03.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:15:0)
[01:13:03.995] Build status: STARTED
[01:13:03.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:16:0) after 2m34s
[01:15:38.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:16:0)
[01:15:38.043] Build status: STARTED
[01:15:38.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:17:0) after 8m57s
[01:24:35.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:17:0)
[01:24:35.469] Build status: STARTED
[01:24:35.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:18:0) after 2m9s
[01:26:44.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:18:0)
[01:26:44.510] Build status: STARTED
[01:26:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:19:0) after 4m7s
[01:30:51.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:19:0)
[01:30:51.554] Build status: STARTED
[01:30:51.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:20:0) after 5m14s
[01:36:05.594] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:20:0)
[01:36:05.615] Build status: STARTED
[01:36:05.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:21:0) after 1m29s
[01:37:34.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:21:0)
[01:37:34.757] Build status: STARTED
[01:37:34.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:22:0) after 8m44s
[01:46:19.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:22:0)
[01:46:19.029] Build status: STARTED
[01:46:19.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:23:0) after 9m26s
[01:55:45.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:23:0)
[01:55:45.366] Build status: STARTED
[01:55:45.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:24:0) after 8m53s
[02:04:38.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:24:0)
[02:04:38.509] Build status: STARTED
[02:04:38.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:25:0) after 6m30s
[02:11:08.634] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:25:0)
[02:11:08.717] Build status: STARTED
[02:11:08.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:26:0) after 2m15s
[02:13:23.835] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:26:0)
[02:13:23.930] Build status: STARTED
[02:13:23.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:27:0) after 3m52s
[02:17:16.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:27:0)
[02:17:16.135] Build status: STARTED
[02:17:16.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:28:0) after 8m38s
[02:25:54.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:28:0)
[02:25:54.193] Build status: STARTED
[02:25:54.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:29:0) after 6m53s
[02:32:47.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:29:0)
[02:32:47.410] Build status: STARTED
[02:32:47.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:30:0) after 1m22s
[02:34:09.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:30:0)
[02:34:09.708] Build status: STARTED
[02:34:09.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:31:0) after 6m59s
[02:41:08.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:31:0)
[02:41:08.839] Build status: STARTED
[02:41:08.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:32:0) after 2m51s
[02:43:59.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:32:0)
[02:43:59.911] Build status: STARTED
[02:43:59.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:33:0) after 1m20s
[02:45:20.222] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:33:0)
[02:45:20.252] Build status: STARTED
[02:45:20.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:34:0) after 1m38s
[02:46:58.272] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:34:0)
[02:46:58.358] Build status: STARTED
[02:46:58.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:35:0) after 4m29s
[02:51:27.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:35:0)
[02:51:27.521] Build status: STARTED
[02:51:27.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:36:0) after 7m57s
[02:59:24.559] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:36:0)
[02:59:24.580] Build status: STARTED
[02:59:24.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:37:0) after 3m37s
[03:03:01.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:37:0)
[03:03:01.709] Build status: STARTED
[03:03:01.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:38:0) after 5m9s
[03:08:10.902] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:38:0)
[03:08:10.925] Build status: STARTED
[03:08:10.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:39:0) after 8m58s
[03:17:08.926] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:39:0)
[03:17:08.988] Build status: STARTED
[03:17:08.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:40:0) after 8m33s
[03:25:42.268] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:40:0)
[03:25:42.302] Build status: STARTED
[03:25:42.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:41:0) after 3m52s
[03:29:34.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:41:0)
[03:29:34.369] Build status: STARTED
[03:29:34.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:42:0) after 9m45s
[03:39:19.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:42:0)
[03:39:19.504] Build status: STARTED
[03:39:19.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:43:0) after 5m36s
[03:44:55.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:43:0)
[03:44:55.578] Build status: STARTED
[03:44:55.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:44:0) after 8m25s
[03:53:20.737] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:44:0)
[03:53:20.755] Build status: STARTED
[03:53:20.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:45:0) after 9m26s
[04:02:47.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:45:0)
[04:02:47.164] Build status: STARTED
[04:02:47.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:46:0) after 7m3s
[04:09:50.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:46:0)
[04:09:50.260] Build status: STARTED
[04:09:50.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:47:0) after 7m19s
[04:17:09.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:47:0)
[04:17:09.420] Build status: STARTED
[04:17:09.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:48:0) after 3m50s
[04:20:59.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:48:0)
[04:20:59.513] Build status: STARTED
[04:20:59.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:49:0) after 7m26s
[04:28:25.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:49:0)
[04:28:25.571] Build status: STARTED
[04:28:25.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:50:0) after 2m23s
[04:30:48.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:50:0)
[04:30:48.625] Build status: STARTED
[04:30:48.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:51:0) after 2m34s
[04:33:22.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:51:0)
[04:33:22.780] Build status: STARTED
[04:33:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:52:0) after 3m53s
[04:37:15.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:52:0)
[04:37:15.965] Build status: STARTED
[04:37:15.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:53:0) after 4m56s
[04:42:11.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:53:0)
[04:42:12.022] Build status: STARTED
[04:42:12.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:54:0) after 2m31s
[04:44:43.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:54:0)
[04:44:43.068] Build status: STARTED
[04:44:43.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:55:0) after 3m37s
[04:48:20.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:55:0)
[04:48:20.222] Build status: STARTED
[04:48:20.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:56:0) after 5m37s
[04:53:57.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:56:0)
[04:53:57.281] Build status: STARTED
[04:53:57.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:57:0) after 2m50s
[04:56:47.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:57:0)
[04:56:47.334] Build status: STARTED
[04:56:47.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:58:0) after 4m4s
[05:00:51.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:58:0)
[05:00:51.590] Build status: STARTED
[05:00:51.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:59:0) after 2m31s
[05:03:22.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:59:0)
[05:03:22.641] Build status: STARTED
[05:03:22.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:60:0) after 2m22s
[05:05:44.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:60:0)
[05:05:44.720] Build status: STARTED
[05:05:44.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:61:0) after 3m12s
[05:08:56.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:61:0)
[05:08:56.816] Build status: STARTED
[05:08:56.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:62:0) after 8m42s
[05:17:39.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:62:0)
[05:17:39.061] Build status: STARTED
[05:17:39.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:63:0) after 8m37s
[05:26:16.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:63:0)
[05:26:16.185] Build status: STARTED
[05:26:16.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:64:0) after 7m2s
[05:33:18.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:64:0)
[05:33:18.251] Build status: STARTED
[05:33:18.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:65:0) after 1m47s
[05:35:05.287] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:65:0)
[05:35:05.305] Build status: STARTED
[05:35:05.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:66:0) after 3m27s
[05:38:32.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:66:0)
[05:38:32.354] Build status: STARTED
[05:38:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:67:0) after 5m25s
[05:43:57.383] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:67:0)
[05:43:57.406] Build status: STARTED
[05:43:57.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:68:0) after 3m12s
[05:47:09.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:68:0)
[05:47:09.538] Build status: STARTED
[05:47:09.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:69:0) after 4m43s
[05:51:52.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:69:0)
[05:51:52.563] Build status: STARTED
[05:51:52.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:70:0) after 3m20s
[05:55:12.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:70:0)
[05:55:12.722] Build status: STARTED
[05:55:12.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:71:0) after 5m32s
[06:00:44.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:71:0)
[06:00:44.847] Build status: STARTED
[06:00:44.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:72:0) after 8m9s
[06:08:54.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:72:0)
[06:08:54.130] Build status: STARTED
[06:08:54.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:73:0) after 8m28s
[06:17:22.163] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:73:0)
[06:17:22.181] Build status: STARTED
[06:17:22.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:74:0) after 4m35s
[06:21:57.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:74:0)
[06:21:57.210] Build status: STARTED
[06:21:57.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:75:0) after 5m39s
[06:27:36.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:75:0)
[06:27:36.257] Build status: STARTED
[06:27:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:76:0) after 7m59s
[06:35:35.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:76:0)
[06:35:35.765] Build status: STARTED
[06:35:35.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:77:0) after 3m18s
[06:38:53.927] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:77:0)
[06:38:53.958] Build status: STARTED
[06:38:53.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:78:0) after 9m35s
[06:48:29.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:78:0)
[06:48:29.222] Build status: STARTED
[06:48:29.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:79:0) after 9m27s
[06:57:56.248] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:79:0)
[06:57:56.274] Build status: STARTED
[06:57:56.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:80:0) after 6m57s
[07:04:53.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:80:0)
[07:04:53.389] Build status: STARTED
[07:04:53.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:81:0) after 3m14s
[07:08:07.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:81:0)
[07:08:07.574] Build status: STARTED
[07:08:07.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:82:0) after 5m6s
[07:13:13.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:82:0)
[07:13:13.827] Build status: STARTED
[07:13:13.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:83:0) after 5m59s
[07:19:12.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:83:0)
[07:19:12.874] Build status: STARTED
[07:19:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:84:0) after 8m40s
[07:27:52.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:84:0)
[07:27:53.087] Build status: STARTED
[07:27:53.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:85:0) after 7m48s
[07:35:41.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:85:0)
[07:35:41.281] Build status: STARTED
[07:35:41.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:86:0) after 3m42s
[07:39:23.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:86:0)
[07:39:23.967] Build status: STARTED
[07:39:23.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:87:0) after 1m39s
[07:41:03.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:87:0)
[07:41:03.128] Build status: STARTED
[07:41:03.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:88:0) after 7m46s
[07:48:49.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:88:0)
[07:48:49.214] Build status: STARTED
[07:48:49.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:89:0) after 1m3s
[07:49:52.241] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:89:0)
[07:49:52.386] Build status: STARTED
[07:49:52.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:90:0) after 3m45s
[07:53:37.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:90:0)
[07:53:37.455] Build status: STARTED
[07:53:37.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:91:0) after 5m22s
[07:58:59.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:91:0)
[07:58:59.501] Build status: STARTED
[07:58:59.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:92:0) after 3m43s
[08:02:42.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:92:0)
[08:02:42.831] Build status: STARTED
[08:02:42.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:93:0) after 4m13s
[08:06:55.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:93:0)
[08:06:55.892] Build status: STARTED
[08:06:55.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:94:0) after 1m10s
[08:08:05.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:94:0)
[08:08:05.956] Build status: STARTED
[08:08:05.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:95:0) after 3m39s
[08:11:45.082] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:95:0)
[08:11:45.104] Build status: STARTED
[08:11:45.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:96:0) after 2m51s
[08:14:36.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:96:0)
[08:14:36.170] Build status: STARTED
[08:14:36.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:97:0) after 5m28s
[08:20:04.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:97:0)
[08:20:04.299] Build status: STARTED
[08:20:04.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:98:0) after 3m2s
[08:23:06.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:98:0)
[08:23:06.387] Build status: STARTED
[08:23:06.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:99:0) after 8m28s
[08:31:34.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:99:0)
[08:31:34.572] Build status: STARTED
[08:31:34.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:100:0) after 9m17s
[08:40:51.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:100:0)
[08:40:51.718] Build status: STARTED
[08:40:51.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:101:0) after 6m8s
[08:46:59.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:101:0)
[08:46:59.800] Build status: STARTED
[08:46:59.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:102:0) after 5m31s
[08:52:30.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:102:0)
[08:52:30.936] Build status: STARTED
[08:52:30.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:103:0) after 1m4s
[08:53:35.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:103:0)
[08:53:35.061] Build status: STARTED
[08:53:35.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:104:0) after 9m9s
[09:02:44.081] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:104:0)
[09:02:44.107] Build status: STARTED
[09:02:44.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:105:0) after 3m30s
[09:06:14.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:105:0)
[09:06:14.217] Build status: STARTED
[09:06:14.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:106:0) after 8m47s
[09:15:01.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:106:0)
[09:15:01.371] Build status: STARTED
[09:15:01.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:107:0) after 9m15s
[09:24:16.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:107:0)
[09:24:16.425] Build status: STARTED
[09:24:16.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:108:0) after 6m35s
[09:30:51.568] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:108:0)
[09:30:51.595] Build status: STARTED
[09:30:51.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:109:0) after 4m25s
[09:35:16.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:109:0)
[09:35:16.636] Build status: STARTED
[09:35:16.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:110:0) after 5m35s
[09:40:51.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:110:0)
[09:40:51.818] Build status: STARTED
[09:40:51.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:111:0) after 4m0s
[09:44:51.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:111:0)
[09:44:51.931] Build status: STARTED
[09:44:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:112:0) after 6m29s
[09:51:21.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:112:0)
[09:51:21.045] Build status: STARTED
[09:51:21.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:113:0) after 5m57s
[09:57:18.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:113:0)
[09:57:18.280] Build status: STARTED
[09:57:18.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:114:0) after 4m43s
[10:02:01.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:114:0)
[10:02:01.303] Build status: STARTED
[10:02:01.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:115:0) after 2m6s
[10:04:07.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:115:0)
[10:04:07.488] Build status: STARTED
[10:04:07.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:116:0) after 1m35s
[10:05:42.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:116:0)
[10:05:42.597] Build status: STARTED
[10:05:42.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:117:0) after 1m36s
[10:07:18.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:117:0)
[10:07:18.642] Build status: STARTED
[10:07:18.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:118:0) after 5m13s
[10:12:31.674] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:118:0)
[10:12:31.705] Build status: STARTED
[10:12:31.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:119:0) after 3m14s
[10:15:45.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:119:0)
[10:15:45.768] Build status: STARTED
[10:15:45.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:120:0) after 9m55s
[10:25:40.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:120:0)
[10:25:40.845] Build status: STARTED
[10:25:40.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:121:0) after 4m21s
[10:30:01.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:121:0)
[10:30:01.926] Build status: STARTED
[10:30:01.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:122:0) after 6m59s
[10:37:00.927] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:122:0)
[10:37:00.951] Build status: STARTED
[10:37:00.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:123:0) after 1m49s
[10:38:50.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:123:0)
[10:38:50.022] Build status: STARTED
[10:38:50.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:124:0) after 8m14s
[10:47:04.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:124:0)
[10:47:04.381] Build status: STARTED
[10:47:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:125:0) after 8m44s
[10:55:48.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:125:0)
[10:55:48.549] Build status: STARTED
[10:55:48.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:126:0) after 3m23s
[10:59:11.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:126:0)
[10:59:11.572] Build status: STARTED
[10:59:11.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:127:0) after 4m52s
[11:04:03.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:127:0)
[11:04:03.639] Build status: STARTED
[11:04:03.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:128:0) after 3m32s
[11:07:35.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:128:0)
[11:07:35.751] Build status: STARTED
[11:07:35.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:129:0) after 5m43s
[11:13:18.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:129:0)
[11:13:18.816] Build status: STARTED
[11:13:18.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:130:0) after 9m11s
[11:22:29.849] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:130:0)
[11:22:29.926] Build status: STARTED
[11:22:29.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:131:0) after 3m31s
[11:26:01.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:131:0)
[11:26:01.220] Build status: STARTED
[11:26:01.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:132:0) after 6m3s
[11:32:04.440] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:132:0)
[11:32:04.459] Build status: STARTED
[11:32:04.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:133:0) after 7m12s
[11:39:16.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:133:0)
[11:39:16.624] Build status: STARTED
[11:39:16.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:134:0) after 3m38s
[11:42:54.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:134:0)
[11:42:54.667] Build status: STARTED
[11:42:54.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:135:0) after 9m58s
[11:52:52.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:135:0)
[11:52:52.863] Build status: STARTED
[11:52:52.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:136:0) after 5m14s
[11:58:06.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:136:0)
[11:58:06.986] Build status: STARTED
[11:58:06.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:137:0) after 9m20s
[12:07:27.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:137:0)
[12:07:27.047] Build status: STARTED
[12:07:27.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:138:0) after 2m29s
[12:09:56.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:138:0)
[12:09:56.094] Build status: STARTED
[12:09:56.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:139:0) after 4m0s
[12:13:56.394] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:139:0)
[12:13:56.420] Build status: STARTED
[12:13:56.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:140:0) after 5m30s
[12:19:26.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:140:0)
[12:19:26.944] Build status: STARTED
[12:19:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:141:0) after 3m52s
[12:23:19.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:141:0)
[12:23:19.955] Build status: STARTED
[12:23:19.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:142:0) after 6m35s
[12:29:55.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:142:0)
[12:29:55.748] Build status: STARTED
[12:29:55.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8937175585421400560:143:0) after 8m56s
[12:33:57.499] Received PubSub notification, asking Buildbucket for the build status
[12:33:57.518] Build:
{
"id": "8771745522936824033",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 6111,
"createdBy": "project:chromium",
"createTime": "2023-08-26T00:10:06.931033179Z",
"startTime": "2023-08-26T00:10:14.522411Z",
"endTime": "2023-08-26T12:33:57.133663443Z",
"updateTime": "2023-08-26T12:33:57.133663443Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa4790f909674e51a085c33b7c1d6f9717cf1795",
"ref": "refs/heads/main"
}
}
}
[12:33:57.518] Invocation finished in 12h23m52.340455765s with status SUCCEEDED