[09:11:26.523] New invocation is queued and will start shortly
[09:11:27.701] Starting the invocation (attempt 1)
[09:11:27.731] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eeda2bee31a503deb8d89fb00fa87696c1d9c6a7"
[09:11:27.732] Popped gitiles commit info from properties and tags
[09:11:27.732] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:11:27.732] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:11:27.732] Buildbucket request:
{
"requestId": "8891480655212016496",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "eeda2bee31a503deb8d89fb00fa87696c1d9c6a7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8891480655212016496"
},
{
"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"
}
}
[09:11:28.240] Scheduled build:
{
"id": "8726050593221808353",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 11111,
"createdBy": "project:chromium",
"createTime": "2025-01-11T09:11:27.790120569Z",
"updateTime": "2025-01-11T09:11:27.790120569Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "eeda2bee31a503deb8d89fb00fa87696c1d9c6a7",
"ref": "refs/heads/main"
}
}
}
[09:11:28.240] Task URL: https://cr-buildbucket.appspot.com/build/8726050593221808353
[09:11:28.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:2:0) after 1m9s
[09:11:29.239] Received PubSub notification, asking Buildbucket for the build status
[09:11:29.362] Build status: SCHEDULED
[09:12:37.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:2:0)
[09:12:37.382] Build status: SCHEDULED
[09:12:37.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:4:0) after 5m3s
[09:17:40.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:4:0)
[09:17:40.733] Build status: SCHEDULED
[09:17:40.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:5:0) after 6m30s
[09:24:10.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:5:0)
[09:24:10.876] Build status: SCHEDULED
[09:24:10.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:6:0) after 5m32s
[09:29:42.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:6:0)
[09:29:43.090] Build status: SCHEDULED
[09:29:43.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:7:0) after 4m51s
[09:34:34.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:7:0)
[09:34:34.149] Build status: SCHEDULED
[09:34:34.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:8:0) after 8m30s
[09:43:04.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:8:0)
[09:43:04.218] Build status: SCHEDULED
[09:43:04.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:9:0) after 6m51s
[09:49:55.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:9:0)
[09:49:55.360] Build status: SCHEDULED
[09:49:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:10:0) after 3m28s
[09:53:23.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:10:0)
[09:53:23.770] Build status: SCHEDULED
[09:53:23.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:11:0) after 3m58s
[09:57:21.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:11:0)
[09:57:21.816] Build status: SCHEDULED
[09:57:21.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:12:0) after 8m30s
[10:05:51.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:12:0)
[10:05:52.007] Build status: SCHEDULED
[10:05:52.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:13:0) after 8m39s
[10:14:31.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:13:0)
[10:14:31.055] Build status: SCHEDULED
[10:14:31.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:14:0) after 4m49s
[10:19:20.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:14:0)
[10:19:20.142] Build status: SCHEDULED
[10:19:20.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:15:0) after 4m52s
[10:24:12.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:15:0)
[10:24:12.465] Build status: SCHEDULED
[10:24:12.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:16:0) after 7m47s
[10:31:59.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:16:0)
[10:31:59.522] Build status: SCHEDULED
[10:31:59.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:17:0) after 2m22s
[10:34:21.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:17:0)
[10:34:21.577] Build status: SCHEDULED
[10:34:21.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:18:0) after 9m39s
[10:44:00.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:18:0)
[10:44:00.657] Build status: SCHEDULED
[10:44:00.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:19:0) after 2m34s
[10:46:34.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:19:0)
[10:46:34.735] Build status: SCHEDULED
[10:46:34.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:20:0) after 3m51s
[10:50:28.094] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:20:0)
[10:50:28.110] Build status: SCHEDULED
[10:50:28.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:21:0) after 3m43s
[10:54:11.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:21:0)
[10:54:11.166] Build status: SCHEDULED
[10:54:11.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:22:0) after 7m33s
[11:01:44.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:22:0)
[11:01:44.248] Build status: SCHEDULED
[11:01:44.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:23:0) after 4m11s
[11:03:00.833] Received PubSub notification, asking Buildbucket for the build status
[11:03:00.853] Build status: STARTED
[11:05:55.464] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:23:0)
[11:05:55.488] Build status: STARTED
[11:05:55.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:25:0) after 4m38s
[11:10:33.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:25:0)
[11:10:33.705] Build status: STARTED
[11:10:33.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:26:0) after 1m11s
[11:11:44.789] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:26:0)
[11:11:44.809] Build status: STARTED
[11:11:44.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:27:0) after 5m54s
[11:17:39.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:27:0)
[11:17:39.059] Build status: STARTED
[11:17:39.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:28:0) after 7m10s
[11:24:49.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:28:0)
[11:24:49.364] Build status: STARTED
[11:24:49.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:29:0) after 2m25s
[11:27:14.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:29:0)
[11:27:14.581] Build status: STARTED
[11:27:14.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:30:0) after 3m14s
[11:30:28.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:30:0)
[11:30:28.627] Build status: STARTED
[11:30:28.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:31:0) after 6m16s
[11:36:44.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:31:0)
[11:36:44.756] Build status: STARTED
[11:36:44.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:32:0) after 4m22s
[11:41:06.890] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:32:0)
[11:41:06.911] Build status: STARTED
[11:41:06.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:33:0) after 1m8s
[11:42:14.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:33:0)
[11:42:15.011] Build status: STARTED
[11:42:15.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:34:0) after 3m18s
[11:45:33.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:34:0)
[11:45:33.148] Build status: STARTED
[11:45:33.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:35:0) after 7m19s
[11:52:52.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:35:0)
[11:52:52.744] Build status: STARTED
[11:52:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:36:0) after 1m16s
[11:54:08.835] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:36:0)
[11:54:08.894] Build status: STARTED
[11:54:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:37:0) after 7m5s
[12:01:13.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:37:0)
[12:01:14.089] Build status: STARTED
[12:01:14.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:38:0) after 9m49s
[12:11:03.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:38:0)
[12:11:03.152] Build status: STARTED
[12:11:03.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:39:0) after 5m31s
[12:16:34.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:39:0)
[12:16:34.827] Build status: STARTED
[12:16:34.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:40:0) after 3m50s
[12:20:24.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:40:0)
[12:20:24.869] Build status: STARTED
[12:20:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:41:0) after 7m46s
[12:28:10.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:41:0)
[12:28:10.916] Build status: STARTED
[12:28:10.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:42:0) after 6m48s
[12:34:59.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:42:0)
[12:34:59.049] Build status: STARTED
[12:34:59.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:43:0) after 6m44s
[12:41:43.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:43:0)
[12:41:43.095] Build status: STARTED
[12:41:43.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:44:0) after 6m54s
[12:48:37.204] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:44:0)
[12:48:37.221] Build status: STARTED
[12:48:37.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:45:0) after 8m54s
[12:57:31.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:45:0)
[12:57:31.312] Build status: STARTED
[12:57:31.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:46:0) after 9m19s
[13:06:50.744] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:46:0)
[13:06:50.760] Build status: STARTED
[13:06:50.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:47:0) after 8m53s
[13:15:43.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:47:0)
[13:15:43.815] Build status: STARTED
[13:15:43.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:48:0) after 2m14s
[13:17:58.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:48:0)
[13:17:58.092] Build status: STARTED
[13:17:58.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:49:0) after 5m4s
[13:23:02.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:49:0)
[13:23:02.157] Build status: STARTED
[13:23:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:50:0) after 3m28s
[13:26:30.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:50:0)
[13:26:30.261] Build status: STARTED
[13:26:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:51:0) after 4m38s
[13:31:08.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:51:0)
[13:31:08.371] Build status: STARTED
[13:31:08.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:52:0) after 2m8s
[13:33:16.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:52:0)
[13:33:16.642] Build status: STARTED
[13:33:16.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:53:0) after 1m30s
[13:34:46.770] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:53:0)
[13:34:46.789] Build status: STARTED
[13:34:46.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:54:0) after 8m13s
[13:43:00.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:54:0)
[13:43:00.157] Build status: STARTED
[13:43:00.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:55:0) after 4m22s
[13:47:22.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:55:0)
[13:47:22.228] Build status: STARTED
[13:47:22.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:56:0) after 7m27s
[13:54:49.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:56:0)
[13:54:49.371] Build status: STARTED
[13:54:49.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:57:0) after 2m48s
[13:57:37.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:57:0)
[13:57:37.571] Build status: STARTED
[13:57:37.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:58:0) after 7m14s
[14:04:51.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:58:0)
[14:04:51.617] Build status: STARTED
[14:04:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:59:0) after 4m40s
[14:09:31.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:59:0)
[14:09:31.676] Build status: STARTED
[14:09:31.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:60:0) after 9m39s
[14:19:10.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:60:0)
[14:19:10.982] Build status: STARTED
[14:19:10.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:61:0) after 1m48s
[14:20:59.012] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:61:0)
[14:20:59.036] Build status: STARTED
[14:20:59.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:62:0) after 2m10s
[14:23:09.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:62:0)
[14:23:09.087] Build status: STARTED
[14:23:09.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:63:0) after 5m55s
[14:29:04.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:63:0)
[14:29:04.137] Build status: STARTED
[14:29:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:64:0) after 6m3s
[14:35:07.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:64:0)
[14:35:07.240] Build status: STARTED
[14:35:07.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:65:0) after 1m3s
[14:36:10.391] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:65:0)
[14:36:10.408] Build status: STARTED
[14:36:10.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:66:0) after 7m0s
[14:43:10.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:66:0)
[14:43:10.513] Build status: STARTED
[14:43:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:67:0) after 5m0s
[14:48:10.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:67:0)
[14:48:10.767] Build status: STARTED
[14:48:10.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:68:0) after 7m11s
[14:55:21.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:68:0)
[14:55:22.058] Build status: STARTED
[14:55:22.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:69:0) after 2m12s
[14:57:34.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:69:0)
[14:57:34.236] Build status: STARTED
[14:57:34.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:70:0) after 6m59s
[15:04:33.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:70:0)
[15:04:33.623] Build status: STARTED
[15:04:33.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:71:0) after 5m42s
[15:10:15.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:71:0)
[15:10:15.678] Build status: STARTED
[15:10:15.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:72:0) after 3m12s
[15:13:27.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:72:0)
[15:13:27.831] Build status: STARTED
[15:13:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:73:0) after 1m21s
[15:14:48.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:73:0)
[15:14:48.944] Build status: STARTED
[15:14:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:74:0) after 8m14s
[15:23:02.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:74:0)
[15:23:02.990] Build status: STARTED
[15:23:02.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:75:0) after 8m21s
[15:31:24.060] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:75:0)
[15:31:24.076] Build status: STARTED
[15:31:24.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:76:0) after 7m39s
[15:39:03.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:76:0)
[15:39:03.288] Build status: STARTED
[15:39:03.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:77:0) after 4m40s
[15:43:43.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:77:0)
[15:43:43.475] Build status: STARTED
[15:43:43.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:78:0) after 2m49s
[15:46:32.513] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:78:0)
[15:46:32.530] Build status: STARTED
[15:46:32.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:79:0) after 3m53s
[15:50:25.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:79:0)
[15:50:25.725] Build status: STARTED
[15:50:25.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:80:0) after 5m58s
[15:56:23.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:80:0)
[15:56:23.988] Build status: STARTED
[15:56:23.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:81:0) after 7m35s
[16:03:59.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:81:0)
[16:03:59.108] Build status: STARTED
[16:03:59.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:82:0) after 5m17s
[16:09:16.254] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:82:0)
[16:09:16.270] Build status: STARTED
[16:09:16.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:83:0) after 5m18s
[16:14:34.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:83:0)
[16:14:34.407] Build status: STARTED
[16:14:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:84:0) after 4m1s
[16:18:35.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:84:0)
[16:18:35.455] Build status: STARTED
[16:18:35.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:85:0) after 3m14s
[16:21:49.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:85:0)
[16:21:49.672] Build status: STARTED
[16:21:49.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:86:0) after 7m28s
[16:29:17.801] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:86:0)
[16:29:17.823] Build status: STARTED
[16:29:17.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:87:0) after 9m6s
[16:38:23.942] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:87:0)
[16:38:23.959] Build status: STARTED
[16:38:23.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:88:0) after 5m29s
[16:43:53.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:88:0)
[16:43:53.067] Build status: STARTED
[16:43:53.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:89:0) after 7m46s
[16:51:39.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:89:0)
[16:51:39.279] Build status: STARTED
[16:51:39.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:90:0) after 7m56s
[16:59:35.306] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:90:0)
[16:59:35.324] Build status: STARTED
[16:59:35.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:91:0) after 5m13s
[17:04:48.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:91:0)
[17:04:48.365] Build status: STARTED
[17:04:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:92:0) after 7m24s
[17:12:12.506] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:92:0)
[17:12:12.570] Build status: STARTED
[17:12:12.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:93:0) after 2m6s
[17:14:18.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:93:0)
[17:14:18.617] Build status: STARTED
[17:14:18.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:94:0) after 8m32s
[17:22:50.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:94:0)
[17:22:50.759] Build status: STARTED
[17:22:50.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:95:0) after 2m47s
[17:25:37.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:95:0)
[17:25:37.936] Build status: STARTED
[17:25:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:96:0) after 5m53s
[17:31:30.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:96:0)
[17:31:31.025] Build status: STARTED
[17:31:31.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:97:0) after 2m22s
[17:33:53.055] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:97:0)
[17:33:53.072] Build status: STARTED
[17:33:53.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:98:0) after 3m8s
[17:37:01.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:98:0)
[17:37:01.251] Build status: STARTED
[17:37:01.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:99:0) after 9m10s
[17:46:11.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:99:0)
[17:46:11.441] Build status: STARTED
[17:46:11.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:100:0) after 5m0s
[17:51:11.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:100:0)
[17:51:11.736] Build status: STARTED
[17:51:11.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:101:0) after 4m41s
[17:55:52.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:101:0)
[17:55:52.779] Build status: STARTED
[17:55:52.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:102:0) after 7m6s
[18:02:58.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:102:0)
[18:02:58.911] Build status: STARTED
[18:02:58.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:103:0) after 1m24s
[18:04:22.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:103:0)
[18:04:22.963] Build status: STARTED
[18:04:22.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:104:0) after 9m17s
[18:13:40.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:104:0)
[18:13:40.074] Build status: STARTED
[18:13:40.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:105:0) after 4m4s
[18:17:44.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:105:0)
[18:17:44.167] Build status: STARTED
[18:17:44.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:106:0) after 1m1s
[18:18:45.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:106:0)
[18:18:45.220] Build status: STARTED
[18:18:45.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:107:0) after 8m12s
[18:26:57.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:107:0)
[18:26:57.406] Build status: STARTED
[18:26:57.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:108:0) after 5m58s
[18:32:55.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:108:0)
[18:32:55.494] Build status: STARTED
[18:32:55.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:109:0) after 2m16s
[18:35:11.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:109:0)
[18:35:11.576] Build status: STARTED
[18:35:11.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:110:0) after 1m54s
[18:37:05.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:110:0)
[18:37:05.625] Build status: STARTED
[18:37:05.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:111:0) after 3m46s
[18:40:51.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:111:0)
[18:40:51.753] Build status: STARTED
[18:40:51.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:112:0) after 6m25s
[18:47:16.782] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:112:0)
[18:47:16.847] Build status: STARTED
[18:47:16.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:113:0) after 2m50s
[18:50:06.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:113:0)
[18:50:06.892] Build status: STARTED
[18:50:06.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:114:0) after 6m33s
[18:56:40.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:114:0)
[18:56:40.179] Build status: STARTED
[18:56:40.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:115:0) after 2m8s
[18:58:48.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:115:0)
[18:58:48.414] Build status: STARTED
[18:58:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:116:0) after 7m21s
[19:06:09.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:116:0)
[19:06:09.966] Build status: STARTED
[19:06:09.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:117:0) after 7m58s
[19:14:08.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:117:0)
[19:14:08.078] Build status: STARTED
[19:14:08.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:118:0) after 5m43s
[19:19:51.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:118:0)
[19:19:51.292] Build status: STARTED
[19:19:51.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:119:0) after 5m27s
[19:25:18.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:119:0)
[19:25:18.343] Build status: STARTED
[19:25:18.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:120:0) after 9m54s
[19:35:12.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:120:0)
[19:35:12.390] Build status: STARTED
[19:35:12.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:121:0) after 9m57s
[19:45:09.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:121:0)
[19:45:09.513] Build status: STARTED
[19:45:09.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:122:0) after 2m22s
[19:47:31.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:122:0)
[19:47:31.656] Build status: STARTED
[19:47:31.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:123:0) after 7m27s
[19:54:58.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:123:0)
[19:54:58.701] Build status: STARTED
[19:54:58.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:124:0) after 4m43s
[19:59:41.730] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:124:0)
[19:59:41.745] Build status: STARTED
[19:59:41.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:125:0) after 2m9s
[20:01:50.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:125:0)
[20:01:50.841] Build status: STARTED
[20:01:50.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:126:0) after 9m32s
[20:11:22.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:126:0)
[20:11:22.883] Build status: STARTED
[20:11:22.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:127:0) after 2m26s
[20:13:48.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:127:0)
[20:13:48.997] Build status: STARTED
[20:13:48.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:128:0) after 3m16s
[20:17:05.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:128:0)
[20:17:05.078] Build status: STARTED
[20:17:05.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:129:0) after 6m38s
[20:23:43.214] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:129:0)
[20:23:43.235] Build status: STARTED
[20:23:43.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:130:0) after 2m1s
[20:25:44.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:130:0)
[20:25:44.384] Build status: STARTED
[20:25:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:131:0) after 3m23s
[20:29:07.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:131:0)
[20:29:07.609] Build status: STARTED
[20:29:07.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:132:0) after 6m24s
[20:35:31.770] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:132:0)
[20:35:31.786] Build status: STARTED
[20:35:31.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:133:0) after 1m44s
[20:37:15.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:133:0)
[20:37:15.904] Build status: STARTED
[20:37:15.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:134:0) after 1m45s
[20:39:00.955] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:134:0)
[20:39:00.973] Build status: STARTED
[20:39:00.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:135:0) after 8m58s
[20:47:59.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:135:0)
[20:47:59.045] Build status: STARTED
[20:47:59.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:136:0) after 1m2s
[20:49:01.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:136:0)
[20:49:01.285] Build status: STARTED
[20:49:01.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:137:0) after 8m23s
[20:57:24.306] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:137:0)
[20:57:24.351] Build status: STARTED
[20:57:24.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8891480655212016496:138:0) after 3m42s
[20:59:47.221] Received PubSub notification, asking Buildbucket for the build status
[20:59:47.266] Build:
{
"id": "8726050593221808353",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 11111,
"createdBy": "project:chromium",
"createTime": "2025-01-11T09:11:27.790120569Z",
"startTime": "2025-01-11T11:03:00.668208812Z",
"endTime": "2025-01-11T20:59:46.698515011Z",
"updateTime": "2025-01-11T20:59:46.698515011Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "eeda2bee31a503deb8d89fb00fa87696c1d9c6a7",
"ref": "refs/heads/main"
}
}
}
[20:59:47.266] Invocation finished in 11h48m20.757128774s with status SUCCEEDED