[13:01:56.798] New invocation is queued and will start shortly
[13:01:57.905] Starting the invocation (attempt 1)
[13:01:57.946] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11df2b0a6cbbba569c1d4fcfe9e7507e7410ecdb"
[13:01:57.946] Popped gitiles commit info from properties and tags
[13:01:57.946] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:01:57.946] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:01:57.946] Buildbucket request:
{
"requestId": "8990851025259338192",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "11df2b0a6cbbba569c1d4fcfe9e7507e7410ecdb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8990851025259338192"
},
{
"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"
}
}
[13:01:58.495] Scheduled build:
{
"id": "8825420963268235137",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1967,
"createdBy": "project:chromium",
"createTime": "2022-01-10T13:01:58.065315440Z",
"updateTime": "2022-01-10T13:01:58.065315440Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "11df2b0a6cbbba569c1d4fcfe9e7507e7410ecdb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:01:58.495] Task URL: https://cr-buildbucket.appspot.com/build/8825420963268235137
[13:01:58.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:2:0) after 4m5s
[13:06:03.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:2:0)
[13:06:03.558] Build status: SCHEDULED
[13:06:03.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:3:0) after 3m50s
[13:09:53.676] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:3:0)
[13:09:53.694] Build status: SCHEDULED
[13:09:53.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:4:0) after 2m31s
[13:12:24.714] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:4:0)
[13:12:24.738] Build status: SCHEDULED
[13:12:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:5:0) after 4m29s
[13:16:53.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:5:0)
[13:16:53.808] Build status: SCHEDULED
[13:16:53.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:6:0) after 5m49s
[13:22:42.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:6:0)
[13:22:42.848] Build status: SCHEDULED
[13:22:42.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:7:0) after 3m49s
[13:26:31.867] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:7:0)
[13:26:31.885] Build status: SCHEDULED
[13:26:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:8:0) after 4m14s
[13:30:45.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:8:0)
[13:30:45.944] Build status: SCHEDULED
[13:30:45.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:9:0) after 1m38s
[13:32:23.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:9:0)
[13:32:23.986] Build status: SCHEDULED
[13:32:23.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:10:0) after 6m48s
[13:39:12.243] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:10:0)
[13:39:12.267] Build status: SCHEDULED
[13:39:12.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:11:0) after 9m57s
[13:49:09.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:11:0)
[13:49:09.334] Build status: SCHEDULED
[13:49:09.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:12:0) after 3m53s
[13:53:02.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:12:0)
[13:53:02.431] Build status: SCHEDULED
[13:53:02.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:13:0) after 5m44s
[13:56:55.165] Received PubSub notification, asking Buildbucket for the build status
[13:56:55.183] Build status: STARTED
[13:58:46.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:13:0)
[13:58:46.472] Build status: STARTED
[13:58:46.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:15:0) after 2m57s
[14:01:43.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:15:0)
[14:01:43.936] Build status: STARTED
[14:01:43.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:16:0) after 4m27s
[14:06:10.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:16:0)
[14:06:10.977] Build status: STARTED
[14:06:10.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:17:0) after 1m47s
[14:07:57.999] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:17:0)
[14:07:58.020] Build status: STARTED
[14:07:58.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:18:0) after 3m7s
[14:11:05.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:18:0)
[14:11:05.092] Build status: STARTED
[14:11:05.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:19:0) after 4m33s
[14:15:38.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:19:0)
[14:15:38.144] Build status: STARTED
[14:15:38.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:20:0) after 2m22s
[14:18:00.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:20:0)
[14:18:00.289] Build status: STARTED
[14:18:00.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:21:0) after 4m32s
[14:22:32.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:21:0)
[14:22:32.339] Build status: STARTED
[14:22:32.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:22:0) after 8m3s
[14:30:35.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:22:0)
[14:30:35.442] Build status: STARTED
[14:30:35.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:23:0) after 8m44s
[14:39:19.466] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:23:0)
[14:39:19.489] Build status: STARTED
[14:39:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:24:0) after 3m19s
[14:42:38.529] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:24:0)
[14:42:38.560] Build status: STARTED
[14:42:38.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:25:0) after 1m46s
[14:44:24.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:25:0)
[14:44:24.747] Build status: STARTED
[14:44:24.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:26:0) after 2m26s
[14:46:50.801] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:26:0)
[14:46:50.830] Build status: STARTED
[14:46:50.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:27:0) after 4m53s
[14:51:43.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:27:0)
[14:51:43.835] Build status: STARTED
[14:51:43.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:28:0) after 9m12s
[15:00:56.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:28:0)
[15:00:56.309] Build status: STARTED
[15:00:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:29:0) after 5m24s
[15:06:20.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:29:0)
[15:06:20.353] Build status: STARTED
[15:06:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:30:0) after 7m1s
[15:13:21.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:30:0)
[15:13:21.520] Build status: STARTED
[15:13:21.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:31:0) after 6m46s
[15:20:07.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:31:0)
[15:20:07.754] Build status: STARTED
[15:20:07.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:32:0) after 3m10s
[15:23:18.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:32:0)
[15:23:18.412] Build status: STARTED
[15:23:18.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:33:0) after 1m49s
[15:25:07.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:33:0)
[15:25:07.632] Build status: STARTED
[15:25:07.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:34:0) after 9m25s
[15:34:32.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:34:0)
[15:34:32.687] Build status: STARTED
[15:34:32.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:35:0) after 5m39s
[15:40:11.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:35:0)
[15:40:11.744] Build status: STARTED
[15:40:11.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:36:0) after 3m45s
[15:43:56.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:36:0)
[15:43:56.817] Build status: STARTED
[15:43:56.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:37:0) after 8m47s
[15:52:44.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:37:0)
[15:52:44.020] Build status: STARTED
[15:52:44.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:38:0) after 7m42s
[16:00:26.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:38:0)
[16:00:26.185] Build status: STARTED
[16:00:26.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:39:0) after 9m22s
[16:09:48.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:39:0)
[16:09:48.370] Build status: STARTED
[16:09:48.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:40:0) after 3m6s
[16:12:54.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:40:0)
[16:12:54.431] Build status: STARTED
[16:12:54.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:41:0) after 1m12s
[16:14:06.455] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:41:0)
[16:14:06.490] Build status: STARTED
[16:14:06.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:42:0) after 5m13s
[16:19:19.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:42:0)
[16:19:19.557] Build status: STARTED
[16:19:19.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:43:0) after 3m59s
[16:23:18.589] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:43:0)
[16:23:18.621] Build status: STARTED
[16:23:18.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:44:0) after 5m49s
[16:29:07.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:44:0)
[16:29:07.972] Build status: STARTED
[16:29:07.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:45:0) after 7m39s
[16:36:47.015] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:45:0)
[16:36:47.046] Build status: STARTED
[16:36:47.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:46:0) after 3m4s
[16:39:51.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:46:0)
[16:39:51.104] Build status: STARTED
[16:39:51.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:47:0) after 7m23s
[16:47:14.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:47:0)
[16:47:14.435] Build status: STARTED
[16:47:14.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:48:0) after 6m16s
[16:53:30.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:48:0)
[16:53:30.592] Build status: STARTED
[16:53:30.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:49:0) after 6m22s
[16:59:52.653] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:49:0)
[16:59:52.673] Build status: STARTED
[16:59:52.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:50:0) after 7m27s
[17:07:19.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:50:0)
[17:07:19.782] Build status: STARTED
[17:07:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:51:0) after 3m47s
[17:11:06.804] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:51:0)
[17:11:06.823] Build status: STARTED
[17:11:06.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:52:0) after 4m52s
[17:15:58.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:52:0)
[17:15:58.979] Build status: STARTED
[17:15:58.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:53:0) after 3m9s
[17:19:08.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:53:0)
[17:19:08.141] Build status: STARTED
[17:19:08.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:54:0) after 7m15s
[17:26:23.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:54:0)
[17:26:23.203] Build status: STARTED
[17:26:23.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:55:0) after 5m23s
[17:31:46.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:55:0)
[17:31:46.583] Build status: STARTED
[17:31:46.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:56:0) after 8m40s
[17:40:26.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:56:0)
[17:40:26.627] Build status: STARTED
[17:40:26.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:57:0) after 3m21s
[17:43:47.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:57:0)
[17:43:47.875] Build status: STARTED
[17:43:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:58:0) after 4m23s
[17:48:11.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:58:0)
[17:48:11.422] Build status: STARTED
[17:48:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:59:0) after 7m15s
[17:55:26.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:59:0)
[17:55:26.525] Build status: STARTED
[17:55:26.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:60:0) after 5m36s
[18:01:02.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:60:0)
[18:01:02.761] Build status: STARTED
[18:01:02.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:61:0) after 4m22s
[18:05:24.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:61:0)
[18:05:24.903] Build status: STARTED
[18:05:24.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:62:0) after 7m8s
[18:12:33.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:62:0)
[18:12:33.244] Build status: STARTED
[18:12:33.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:63:0) after 9m28s
[18:22:01.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:63:0)
[18:22:01.556] Build status: STARTED
[18:22:01.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:64:0) after 5m7s
[18:27:08.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:64:0)
[18:27:08.629] Build status: STARTED
[18:27:08.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:65:0) after 6m59s
[18:34:08.464] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:65:0)
[18:34:08.483] Build status: STARTED
[18:34:08.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:66:0) after 2m41s
[18:36:49.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:66:0)
[18:36:49.589] Build status: STARTED
[18:36:49.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:67:0) after 4m26s
[18:41:15.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:67:0)
[18:41:15.953] Build status: STARTED
[18:41:15.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:68:0) after 1m29s
[18:42:45.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:68:0)
[18:42:45.360] Build status: STARTED
[18:42:45.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:69:0) after 2m44s
[18:45:29.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:69:0)
[18:45:29.422] Build status: STARTED
[18:45:29.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:70:0) after 8m50s
[18:54:19.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:70:0)
[18:54:19.468] Build status: STARTED
[18:54:19.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:71:0) after 4m48s
[18:59:07.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:71:0)
[18:59:07.531] Build status: STARTED
[18:59:07.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:72:0) after 9m23s
[19:08:30.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:72:0)
[19:08:30.640] Build status: STARTED
[19:08:30.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:73:0) after 8m54s
[19:17:24.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:73:0)
[19:17:24.882] Build status: STARTED
[19:17:24.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:74:0) after 8m10s
[19:25:34.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:74:0)
[19:25:34.935] Build status: STARTED
[19:25:34.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:75:0) after 5m36s
[19:31:11.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:75:0)
[19:31:11.038] Build status: STARTED
[19:31:11.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:76:0) after 1m33s
[19:32:44.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:76:0)
[19:32:44.484] Build status: STARTED
[19:32:44.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:77:0) after 4m59s
[19:37:43.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:77:0)
[19:37:43.858] Build status: STARTED
[19:37:43.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:78:0) after 3m9s
[19:40:52.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:78:0)
[19:40:52.970] Build status: STARTED
[19:40:52.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:79:0) after 7m12s
[19:48:05.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:79:0)
[19:48:05.167] Build status: STARTED
[19:48:05.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:80:0) after 2m1s
[19:50:06.401] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:80:0)
[19:50:06.432] Build status: STARTED
[19:50:06.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:81:0) after 6m33s
[19:56:39.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:81:0)
[19:56:39.883] Build status: STARTED
[19:56:39.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:82:0) after 5m48s
[20:02:28.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:82:0)
[20:02:28.088] Build status: STARTED
[20:02:28.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:83:0) after 4m59s
[20:07:27.172] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:83:0)
[20:07:27.190] Build status: STARTED
[20:07:27.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:84:0) after 6m48s
[20:14:15.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:84:0)
[20:14:15.233] Build status: STARTED
[20:14:15.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:85:0) after 5m26s
[20:19:41.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:85:0)
[20:19:41.254] Build status: STARTED
[20:19:41.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:86:0) after 1m12s
[20:20:53.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:86:0)
[20:20:53.431] Build status: STARTED
[20:20:53.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:87:0) after 4m51s
[20:25:44.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:87:0)
[20:25:44.473] Build status: STARTED
[20:25:44.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:88:0) after 1m53s
[20:27:37.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:88:0)
[20:27:37.651] Build status: STARTED
[20:27:37.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:89:0) after 5m15s
[20:32:52.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:89:0)
[20:32:52.733] Build status: STARTED
[20:32:52.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:90:0) after 3m20s
[20:36:12.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:90:0)
[20:36:12.888] Build status: STARTED
[20:36:12.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:91:0) after 5m34s
[20:41:47.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:91:0)
[20:41:47.064] Build status: STARTED
[20:41:47.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:92:0) after 8m24s
[20:50:11.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:92:0)
[20:50:11.139] Build status: STARTED
[20:50:11.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:93:0) after 4m57s
[20:55:08.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:93:0)
[20:55:08.319] Build status: STARTED
[20:55:08.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:94:0) after 3m8s
[20:58:16.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:94:0)
[20:58:16.397] Build status: STARTED
[20:58:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:95:0) after 4m22s
[21:02:38.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:95:0)
[21:02:38.585] Build status: STARTED
[21:02:38.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:96:0) after 2m45s
[21:05:23.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:96:0)
[21:05:23.728] Build status: STARTED
[21:05:23.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:97:0) after 3m1s
[21:08:25.003] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:97:0)
[21:08:25.036] Build status: STARTED
[21:08:25.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:98:0) after 1m17s
[21:09:42.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:98:0)
[21:09:42.686] Build status: STARTED
[21:09:42.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:99:0) after 3m56s
[21:13:38.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:99:0)
[21:13:38.741] Build status: STARTED
[21:13:38.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:100:0) after 7m10s
[21:20:48.963] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:100:0)
[21:20:48.982] Build status: STARTED
[21:20:48.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:101:0) after 5m41s
[21:26:30.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:101:0)
[21:26:30.039] Build status: STARTED
[21:26:30.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:102:0) after 7m46s
[21:34:16.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:102:0)
[21:34:16.148] Build status: STARTED
[21:34:16.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:103:0) after 9m11s
[21:43:27.760] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:103:0)
[21:43:27.818] Build status: STARTED
[21:43:27.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:104:0) after 4m5s
[21:47:33.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:104:0)
[21:47:33.156] Build status: STARTED
[21:47:33.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:105:0) after 1m22s
[21:48:55.189] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:105:0)
[21:48:55.218] Build status: STARTED
[21:48:55.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:106:0) after 7m57s
[21:56:52.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:106:0)
[21:56:52.417] Build status: STARTED
[21:56:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:107:0) after 9m21s
[22:06:13.413] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:107:0)
[22:06:13.440] Build status: STARTED
[22:06:13.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:108:0) after 3m19s
[22:09:32.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:108:0)
[22:09:32.650] Build status: STARTED
[22:09:32.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:109:0) after 8m58s
[22:18:30.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:109:0)
[22:18:30.876] Build status: STARTED
[22:18:30.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:110:0) after 6m20s
[22:24:50.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:110:0)
[22:24:50.979] Build status: STARTED
[22:24:50.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:111:0) after 3m49s
[22:28:40.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:111:0)
[22:28:40.257] Build status: STARTED
[22:28:40.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:112:0) after 3m47s
[22:32:27.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:112:0)
[22:32:27.617] Build status: STARTED
[22:32:27.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:113:0) after 8m44s
[22:41:11.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:113:0)
[22:41:11.784] Build status: STARTED
[22:41:11.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:114:0) after 8m40s
[22:49:52.172] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:114:0)
[22:49:52.194] Build status: STARTED
[22:49:52.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:115:0) after 4m10s
[22:54:02.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:115:0)
[22:54:02.284] Build status: STARTED
[22:54:02.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:116:0) after 8m26s
[23:02:29.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:116:0)
[23:02:29.038] Build status: STARTED
[23:02:29.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:117:0) after 3m37s
[23:06:06.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:117:0)
[23:06:06.331] Build status: STARTED
[23:06:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:118:0) after 7m49s
[23:13:55.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:118:0)
[23:13:55.665] Build status: STARTED
[23:13:55.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:119:0) after 7m40s
[23:21:35.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:119:0)
[23:21:35.826] Build status: STARTED
[23:21:35.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:120:0) after 6m42s
[23:28:17.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:120:0)
[23:28:18.010] Build status: STARTED
[23:28:18.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:121:0) after 2m46s
[23:31:04.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:121:0)
[23:31:04.067] Build status: STARTED
[23:31:04.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:122:0) after 6m36s
[23:37:40.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:122:0)
[23:37:40.234] Build status: STARTED
[23:37:40.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:123:0) after 8m9s
[23:45:49.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:123:0)
[23:45:49.974] Build status: STARTED
[23:45:49.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:124:0) after 7m12s
[23:53:02.111] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:124:0)
[23:53:02.131] Build status: STARTED
[23:53:02.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:125:0) after 9m26s
[00:02:28.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:125:0)
[00:02:28.406] Build status: STARTED
[00:02:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:126:0) after 2m46s
[00:05:36.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:126:0)
[00:05:36.639] Build status: STARTED
[00:05:36.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:127:0) after 1m16s
[00:06:52.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:127:0)
[00:06:52.855] Build status: STARTED
[00:06:52.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:128:0) after 1m25s
[00:08:18.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:128:0)
[00:08:18.061] Build status: STARTED
[00:08:18.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:129:0) after 8m7s
[00:16:25.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:129:0)
[00:16:25.295] Build status: STARTED
[00:16:25.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:130:0) after 4m23s
[00:20:48.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:130:0)
[00:20:48.341] Build status: STARTED
[00:20:48.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:131:0) after 7m56s
[00:28:44.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:131:0)
[00:28:44.432] Build status: STARTED
[00:28:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:132:0) after 9m24s
[00:38:08.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:132:0)
[00:38:08.613] Build status: STARTED
[00:38:08.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:133:0) after 3m30s
[00:41:38.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:133:0)
[00:41:38.915] Build status: STARTED
[00:41:38.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:134:0) after 7m12s
[00:48:51.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:134:0)
[00:48:51.502] Build status: STARTED
[00:48:51.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:135:0) after 2m31s
[00:51:22.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:135:0)
[00:51:22.558] Build status: STARTED
[00:51:22.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:136:0) after 4m35s
[00:55:58.266] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:136:0)
[00:55:58.297] Build status: STARTED
[00:55:58.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:137:0) after 2m56s
[00:58:54.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:137:0)
[00:58:54.373] Build status: STARTED
[00:58:54.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:138:0) after 6m0s
[01:04:54.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:138:0)
[01:04:54.632] Build status: STARTED
[01:04:54.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:139:0) after 5m18s
[01:10:12.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:139:0)
[01:10:12.748] Build status: STARTED
[01:10:12.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:140:0) after 3m30s
[01:13:42.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:140:0)
[01:13:42.867] Build status: STARTED
[01:13:42.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:141:0) after 8m41s
[01:22:23.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:141:0)
[01:22:23.889] Build status: STARTED
[01:22:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:142:0) after 1m33s
[01:23:57.132] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:142:0)
[01:23:57.153] Build status: STARTED
[01:23:57.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:143:0) after 6m15s
[01:30:12.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:143:0)
[01:30:12.206] Build status: STARTED
[01:30:12.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:144:0) after 8m28s
[01:38:40.244] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:144:0)
[01:38:40.268] Build status: STARTED
[01:38:40.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:145:0) after 9m27s
[01:48:07.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:145:0)
[01:48:07.547] Build status: STARTED
[01:48:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:146:0) after 3m10s
[01:51:17.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:146:0)
[01:51:17.619] Build status: STARTED
[01:51:17.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:147:0) after 2m26s
[01:53:43.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:147:0)
[01:53:43.781] Build status: STARTED
[01:53:43.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:148:0) after 2m19s
[01:56:02.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:148:0)
[01:56:02.938] Build status: STARTED
[01:56:02.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:149:0) after 5m25s
[02:01:27.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:149:0)
[02:01:28.000] Build status: STARTED
[02:01:28.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:150:0) after 1m53s
[02:03:21.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:150:0)
[02:03:21.065] Build status: STARTED
[02:03:21.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:151:0) after 5m46s
[02:09:07.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:151:0)
[02:09:07.148] Build status: STARTED
[02:09:07.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:152:0) after 8m5s
[02:17:12.155] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:152:0)
[02:17:12.194] Build status: STARTED
[02:17:12.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:153:0) after 5m30s
[02:22:42.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:153:0)
[02:22:42.240] Build status: STARTED
[02:22:42.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:154:0) after 8m13s
[02:30:55.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:154:0)
[02:30:55.390] Build status: STARTED
[02:30:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:155:0) after 3m36s
[02:34:31.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:155:0)
[02:34:31.559] Build status: STARTED
[02:34:31.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:156:0) after 1m29s
[02:36:00.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:156:0)
[02:36:00.620] Build status: STARTED
[02:36:00.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:157:0) after 9m39s
[02:45:39.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:157:0)
[02:45:39.789] Build status: STARTED
[02:45:39.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:158:0) after 9m36s
[02:55:16.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:158:0)
[02:55:16.045] Build status: STARTED
[02:55:16.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:159:0) after 1m31s
[02:56:47.019] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:159:0)
[02:56:47.041] Build status: STARTED
[02:56:47.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:160:0) after 2m18s
[02:59:05.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:160:0)
[02:59:05.101] Build status: STARTED
[02:59:05.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:161:0) after 7m7s
[03:06:12.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:161:0)
[03:06:12.499] Build status: STARTED
[03:06:12.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:162:0) after 2m59s
[03:09:11.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:162:0)
[03:09:11.662] Build status: STARTED
[03:09:11.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:163:0) after 3m26s
[03:12:37.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:163:0)
[03:12:37.938] Build status: STARTED
[03:12:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:164:0) after 4m1s
[03:16:38.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:164:0)
[03:16:39.046] Build status: STARTED
[03:16:39.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:165:0) after 4m56s
[03:21:35.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:165:0)
[03:21:35.092] Build status: STARTED
[03:21:35.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:166:0) after 2m55s
[03:24:30.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:166:0)
[03:24:30.230] Build status: STARTED
[03:24:30.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:167:0) after 5m29s
[03:29:59.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:167:0)
[03:29:59.293] Build status: STARTED
[03:29:59.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:168:0) after 5m38s
[03:35:37.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:168:0)
[03:35:37.339] Build status: STARTED
[03:35:37.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:169:0) after 5m32s
[03:41:09.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:169:0)
[03:41:09.489] Build status: STARTED
[03:41:09.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:170:0) after 2m30s
[03:43:39.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:170:0)
[03:43:39.646] Build status: STARTED
[03:43:39.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:171:0) after 2m44s
[03:46:23.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:171:0)
[03:46:23.793] Build status: STARTED
[03:46:23.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:172:0) after 2m18s
[03:48:42.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:172:0)
[03:48:42.258] Build status: STARTED
[03:48:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:173:0) after 7m33s
[03:56:15.369] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:173:0)
[03:56:15.400] Build status: STARTED
[03:56:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8990851025259338192:174:0) after 3m57s
[03:57:38.218] Received PubSub notification, asking Buildbucket for the build status
[03:57:38.251] Build:
{
"id": "8825420963268235137",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1967,
"createdBy": "project:chromium",
"createTime": "2022-01-10T13:01:58.065315440Z",
"startTime": "2022-01-10T13:56:54.620232Z",
"endTime": "2022-01-11T03:57:37.660497018Z",
"updateTime": "2022-01-11T03:57:37.660497018Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "11df2b0a6cbbba569c1d4fcfe9e7507e7410ecdb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:57:38.251] Invocation finished in 14h55m41.468124058s with status FAILED