[01:05:00.459] New invocation is queued and will start shortly
[01:05:01.672] Starting the invocation (attempt 1)
[01:05:01.699] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3b18f78bb52af3913b6997a00caccce16f2cc6e"
[01:05:01.699] Popped gitiles commit info from properties and tags
[01:05:01.699] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:05:01.700] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:05:01.700] Buildbucket request:
{
"requestId": "8944601081325645312",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e3b18f78bb52af3913b6997a00caccce16f2cc6e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8944601081325645312"
},
{
"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"
}
}
[01:05:02.126] Scheduled build:
{
"id": "8779171019295089633",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5543,
"createdBy": "project:chromium",
"createTime": "2023-06-05T01:05:01.768785179Z",
"updateTime": "2023-06-05T01:05:01.768785179Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e3b18f78bb52af3913b6997a00caccce16f2cc6e",
"ref": "refs/heads/main"
}
}
}
[01:05:02.126] Task URL: https://cr-buildbucket.appspot.com/build/8779171019295089633
[01:05:02.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:2:0) after 2m34s
[01:05:26.226] Received PubSub notification, asking Buildbucket for the build status
[01:05:26.247] Build status: STARTED
[01:07:36.163] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:2:0)
[01:07:36.185] Build status: STARTED
[01:07:36.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:4:0) after 3m48s
[01:11:24.200] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:4:0)
[01:11:24.220] Build status: STARTED
[01:11:24.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:5:0) after 3m14s
[01:14:38.272] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:5:0)
[01:14:38.318] Build status: STARTED
[01:14:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:6:0) after 2m39s
[01:17:17.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:6:0)
[01:17:17.307] Build status: STARTED
[01:17:17.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:7:0) after 1m31s
[01:18:48.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:7:0)
[01:18:48.459] Build status: STARTED
[01:18:48.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:8:0) after 7m0s
[01:25:48.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:8:0)
[01:25:48.504] Build status: STARTED
[01:25:48.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:9:0) after 5m57s
[01:31:45.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:9:0)
[01:31:45.515] Build status: STARTED
[01:31:45.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:10:0) after 7m16s
[01:39:01.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:10:0)
[01:39:01.520] Build status: STARTED
[01:39:01.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:11:0) after 5m37s
[01:44:38.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:11:0)
[01:44:38.680] Build status: STARTED
[01:44:38.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:12:0) after 8m54s
[01:53:32.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:12:0)
[01:53:32.711] Build status: STARTED
[01:53:32.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:13:0) after 5m53s
[01:59:25.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:13:0)
[01:59:25.841] Build status: STARTED
[01:59:25.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:14:0) after 2m1s
[02:01:26.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:14:0)
[02:01:26.897] Build status: STARTED
[02:01:26.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:15:0) after 3m44s
[02:05:10.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:15:0)
[02:05:10.954] Build status: STARTED
[02:05:10.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:16:0) after 4m46s
[02:09:56.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:16:0)
[02:09:56.993] Build status: STARTED
[02:09:56.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:17:0) after 7m58s
[02:17:55.054] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:17:0)
[02:17:55.071] Build status: STARTED
[02:17:55.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:18:0) after 7m0s
[02:24:55.140] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:18:0)
[02:24:55.162] Build status: STARTED
[02:24:55.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:19:0) after 1m58s
[02:26:53.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:19:0)
[02:26:53.299] Build status: STARTED
[02:26:53.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:20:0) after 7m45s
[02:34:38.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:20:0)
[02:34:38.385] Build status: STARTED
[02:34:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:21:0) after 6m56s
[02:41:34.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:21:0)
[02:41:34.398] Build status: STARTED
[02:41:34.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:22:0) after 3m44s
[02:45:18.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:22:0)
[02:45:18.537] Build status: STARTED
[02:45:18.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:23:0) after 6m22s
[02:51:40.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:23:0)
[02:51:40.575] Build status: STARTED
[02:51:40.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:24:0) after 6m2s
[02:57:42.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:24:0)
[02:57:42.629] Build status: STARTED
[02:57:42.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:25:0) after 9m43s
[03:07:25.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:25:0)
[03:07:25.847] Build status: STARTED
[03:07:25.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:26:0) after 9m17s
[03:16:42.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:26:0)
[03:16:42.880] Build status: STARTED
[03:16:42.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:27:0) after 8m48s
[03:25:31.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:27:0)
[03:25:31.335] Build status: STARTED
[03:25:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:28:0) after 6m1s
[03:31:32.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:28:0)
[03:31:32.376] Build status: STARTED
[03:31:32.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:29:0) after 9m15s
[03:40:47.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:29:0)
[03:40:47.446] Build status: STARTED
[03:40:47.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:30:0) after 9m29s
[03:50:16.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:30:0)
[03:50:16.590] Build status: STARTED
[03:50:16.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:31:0) after 8m16s
[03:58:32.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:31:0)
[03:58:32.881] Build status: STARTED
[03:58:32.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:32:0) after 1m31s
[04:00:03.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:32:0)
[04:00:03.924] Build status: STARTED
[04:00:03.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:33:0) after 2m28s
[04:02:31.942] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:33:0)
[04:02:31.965] Build status: STARTED
[04:02:31.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:34:0) after 1m31s
[04:04:03.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:34:0)
[04:04:03.462] Build status: STARTED
[04:04:03.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:35:0) after 3m8s
[04:07:11.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:35:0)
[04:07:11.696] Build status: STARTED
[04:07:11.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:36:0) after 1m15s
[04:08:26.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:36:0)
[04:08:26.757] Build status: STARTED
[04:08:26.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:37:0) after 7m54s
[04:16:20.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:37:0)
[04:16:20.887] Build status: STARTED
[04:16:20.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:38:0) after 4m49s
[04:21:09.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:38:0)
[04:21:09.995] Build status: STARTED
[04:21:09.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:39:0) after 6m51s
[04:28:01.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:39:0)
[04:28:01.262] Build status: STARTED
[04:28:01.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:40:0) after 1m9s
[04:29:10.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:40:0)
[04:29:10.307] Build status: STARTED
[04:29:10.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:41:0) after 5m26s
[04:34:36.473] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:41:0)
[04:34:36.738] Build status: STARTED
[04:34:36.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:42:0) after 4m34s
[04:39:10.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:42:0)
[04:39:10.776] Build status: STARTED
[04:39:10.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:43:0) after 4m14s
[04:43:24.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:43:0)
[04:43:24.814] Build status: STARTED
[04:43:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:44:0) after 1m55s
[04:45:19.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:44:0)
[04:45:19.854] Build status: STARTED
[04:45:19.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:45:0) after 1m22s
[04:46:42.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:45:0)
[04:46:42.189] Build status: STARTED
[04:46:42.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:46:0) after 3m32s
[04:50:14.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:46:0)
[04:50:14.476] Build status: STARTED
[04:50:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:47:0) after 3m36s
[04:53:50.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:47:0)
[04:53:50.518] Build status: STARTED
[04:53:50.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:48:0) after 8m8s
[05:01:58.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:48:0)
[05:01:58.635] Build status: STARTED
[05:01:58.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:49:0) after 7m2s
[05:09:00.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:49:0)
[05:09:00.676] Build status: STARTED
[05:09:00.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:50:0) after 8m4s
[05:17:04.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:50:0)
[05:17:04.755] Build status: STARTED
[05:17:04.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:51:0) after 5m59s
[05:23:04.060] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:51:0)
[05:23:04.084] Build status: STARTED
[05:23:04.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:52:0) after 8m14s
[05:31:18.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:52:0)
[05:31:18.128] Build status: STARTED
[05:31:18.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:53:0) after 8m2s
[05:39:20.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:53:0)
[05:39:20.164] Build status: STARTED
[05:39:20.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:54:0) after 8m31s
[05:47:51.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:54:0)
[05:47:51.308] Build status: STARTED
[05:47:51.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:55:0) after 2m28s
[05:50:19.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:55:0)
[05:50:19.345] Build status: STARTED
[05:50:19.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:56:0) after 7m12s
[05:57:31.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:56:0)
[05:57:31.603] Build status: STARTED
[05:57:31.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:57:0) after 8m8s
[06:05:39.579] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:57:0)
[06:05:39.655] Build status: STARTED
[06:05:39.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:58:0) after 7m22s
[06:13:01.676] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:58:0)
[06:13:01.698] Build status: STARTED
[06:13:01.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:59:0) after 8m51s
[06:21:52.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:59:0)
[06:21:52.752] Build status: STARTED
[06:21:52.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:60:0) after 8m10s
[06:30:02.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:60:0)
[06:30:02.803] Build status: STARTED
[06:30:02.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:61:0) after 2m18s
[06:32:20.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:61:0)
[06:32:20.831] Build status: STARTED
[06:32:20.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:62:0) after 1m8s
[06:33:28.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:62:0)
[06:33:29.000] Build status: STARTED
[06:33:29.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:63:0) after 7m35s
[06:41:04.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:63:0)
[06:41:04.141] Build status: STARTED
[06:41:04.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:64:0) after 8m4s
[06:49:08.178] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:64:0)
[06:49:08.194] Build status: STARTED
[06:49:08.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:65:0) after 4m26s
[06:53:34.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:65:0)
[06:53:34.235] Build status: STARTED
[06:53:34.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:66:0) after 4m48s
[06:58:22.258] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:66:0)
[06:58:22.275] Build status: STARTED
[06:58:22.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:67:0) after 4m37s
[07:02:59.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:67:0)
[07:02:59.327] Build status: STARTED
[07:02:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:68:0) after 8m32s
[07:11:31.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:68:0)
[07:11:31.635] Build status: STARTED
[07:11:31.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:69:0) after 6m43s
[07:18:14.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:69:0)
[07:18:14.752] Build status: STARTED
[07:18:14.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:70:0) after 5m4s
[07:23:18.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:70:0)
[07:23:18.805] Build status: STARTED
[07:23:18.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:71:0) after 1m7s
[07:24:25.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:71:0)
[07:24:25.843] Build status: STARTED
[07:24:25.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:72:0) after 6m13s
[07:30:39.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:72:0)
[07:30:39.109] Build status: STARTED
[07:30:39.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:73:0) after 5m9s
[07:35:48.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:73:0)
[07:35:48.253] Build status: STARTED
[07:35:48.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:74:0) after 4m21s
[07:40:09.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:74:0)
[07:40:09.414] Build status: STARTED
[07:40:09.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:75:0) after 2m24s
[07:42:33.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:75:0)
[07:42:33.466] Build status: STARTED
[07:42:33.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:76:0) after 8m19s
[07:50:52.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:76:0)
[07:50:52.604] Build status: STARTED
[07:50:52.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:77:0) after 2m24s
[07:53:16.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:77:0)
[07:53:16.943] Build status: STARTED
[07:53:16.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:78:0) after 9m34s
[08:02:50.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:78:0)
[08:02:51.002] Build status: STARTED
[08:02:51.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:79:0) after 2m29s
[08:05:20.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:79:0)
[08:05:20.171] Build status: STARTED
[08:05:20.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:80:0) after 2m46s
[08:08:06.237] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:80:0)
[08:08:06.258] Build status: STARTED
[08:08:06.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:81:0) after 3m41s
[08:11:47.389] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:81:0)
[08:11:47.412] Build status: STARTED
[08:11:47.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:82:0) after 5m55s
[08:17:42.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:82:0)
[08:17:42.461] Build status: STARTED
[08:17:42.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:83:0) after 7m29s
[08:25:11.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:83:0)
[08:25:11.497] Build status: STARTED
[08:25:11.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:84:0) after 8m8s
[08:33:19.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:84:0)
[08:33:19.532] Build status: STARTED
[08:33:19.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:85:0) after 9m50s
[08:43:09.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:85:0)
[08:43:09.572] Build status: STARTED
[08:43:09.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:86:0) after 9m39s
[08:52:48.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:86:0)
[08:52:48.644] Build status: STARTED
[08:52:48.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:87:0) after 4m40s
[08:57:28.730] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:87:0)
[08:57:28.751] Build status: STARTED
[08:57:28.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:88:0) after 2m30s
[08:59:58.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:88:0)
[08:59:58.850] Build status: STARTED
[08:59:58.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:89:0) after 6m6s
[09:06:05.276] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:89:0)
[09:06:05.296] Build status: STARTED
[09:06:05.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:90:0) after 1m57s
[09:08:02.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:90:0)
[09:08:02.339] Build status: STARTED
[09:08:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:91:0) after 9m2s
[09:17:04.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:91:0)
[09:17:04.450] Build status: STARTED
[09:17:04.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:92:0) after 9m20s
[09:26:24.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:92:0)
[09:26:24.563] Build status: STARTED
[09:26:24.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:93:0) after 3m52s
[09:30:16.849] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:93:0)
[09:30:16.875] Build status: STARTED
[09:30:16.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:94:0) after 8m30s
[09:38:46.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:94:0)
[09:38:46.921] Build status: STARTED
[09:38:46.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:95:0) after 3m37s
[09:42:24.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:95:0)
[09:42:24.113] Build status: STARTED
[09:42:24.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:96:0) after 1m35s
[09:43:59.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:96:0)
[09:43:59.287] Build status: STARTED
[09:43:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:97:0) after 6m26s
[09:50:25.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:97:0)
[09:50:25.352] Build status: STARTED
[09:50:25.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:98:0) after 5m49s
[09:56:14.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:98:0)
[09:56:14.389] Build status: STARTED
[09:56:14.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:99:0) after 6m13s
[10:02:27.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:99:0)
[10:02:27.442] Build status: STARTED
[10:02:27.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:100:0) after 3m35s
[10:06:02.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:100:0)
[10:06:02.673] Build status: STARTED
[10:06:02.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:101:0) after 2m16s
[10:08:19.170] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:101:0)
[10:08:19.223] Build status: STARTED
[10:08:19.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:102:0) after 5m6s
[10:13:25.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:102:0)
[10:13:25.368] Build status: STARTED
[10:13:25.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:103:0) after 4m23s
[10:17:48.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:103:0)
[10:17:48.789] Build status: STARTED
[10:17:48.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:104:0) after 4m29s
[10:22:17.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:104:0)
[10:22:17.857] Build status: STARTED
[10:22:17.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:105:0) after 7m34s
[10:29:51.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:105:0)
[10:29:51.858] Build status: STARTED
[10:29:51.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:106:0) after 4m14s
[10:34:06.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:106:0)
[10:34:06.052] Build status: STARTED
[10:34:06.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:107:0) after 6m0s
[10:40:06.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:107:0)
[10:40:06.572] Build status: STARTED
[10:40:06.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:108:0) after 9m14s
[10:49:20.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:108:0)
[10:49:20.611] Build status: STARTED
[10:49:20.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:109:0) after 8m37s
[10:57:57.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:109:0)
[10:57:57.752] Build status: STARTED
[10:57:57.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:110:0) after 6m16s
[11:04:14.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:110:0)
[11:04:14.106] Build status: STARTED
[11:04:14.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:111:0) after 8m18s
[11:12:32.296] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:111:0)
[11:12:32.312] Build status: STARTED
[11:12:32.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:112:0) after 7m34s
[11:20:06.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:112:0)
[11:20:06.448] Build status: STARTED
[11:20:06.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:113:0) after 4m35s
[11:24:41.473] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:113:0)
[11:24:41.495] Build status: STARTED
[11:24:41.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:114:0) after 7m34s
[11:32:15.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:114:0)
[11:32:15.543] Build status: STARTED
[11:32:15.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:115:0) after 9m54s
[11:42:09.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:115:0)
[11:42:09.829] Build status: STARTED
[11:42:09.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:116:0) after 6m57s
[11:49:06.905] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:116:0)
[11:49:06.925] Build status: STARTED
[11:49:06.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:117:0) after 7m27s
[11:56:33.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:117:0)
[11:56:33.963] Build status: STARTED
[11:56:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:118:0) after 7m22s
[12:03:56.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:118:0)
[12:03:56.112] Build status: STARTED
[12:03:56.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:119:0) after 6m15s
[12:10:11.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:119:0)
[12:10:11.115] Build status: STARTED
[12:10:11.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:120:0) after 9m15s
[12:19:26.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:120:0)
[12:19:26.195] Build status: STARTED
[12:19:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:121:0) after 2m3s
[12:21:29.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:121:0)
[12:21:29.497] Build status: STARTED
[12:21:29.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:122:0) after 9m37s
[12:31:06.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:122:0)
[12:31:06.558] Build status: STARTED
[12:31:06.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8944601081325645312:123:0) after 4m28s
[12:32:43.149] Received PubSub notification, asking Buildbucket for the build status
[12:32:43.177] Build:
{
"id": "8779171019295089633",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 5543,
"createdBy": "project:chromium",
"createTime": "2023-06-05T01:05:01.768785179Z",
"startTime": "2023-06-05T01:05:25.677475Z",
"endTime": "2023-06-05T12:32:42.524892098Z",
"updateTime": "2023-06-05T12:32:42.524892098Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e3b18f78bb52af3913b6997a00caccce16f2cc6e",
"ref": "refs/heads/main"
}
}
}
[12:32:43.177] Invocation finished in 11h27m42.729216495s with status FAILED