[22:16:28.321] New invocation is queued and will start shortly
[22:16:30.450] Starting the invocation (attempt 1)
[22:16:30.494] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/570c515e74f29d63891e8d182d2979daae6af980"
[22:16:30.494] Popped gitiles commit info from properties and tags
[22:16:30.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:16:30.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:16:30.494] Buildbucket request:
{
"requestId": "8980941068212175536",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "570c515e74f29d63891e8d182d2979daae6af980",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8980941068212175536"
},
{
"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"
}
}
[22:16:31.112] Scheduled build:
{
"id": "8815511005160361937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2510,
"createdBy": "project:chromium",
"createTime": "2022-04-29T22:16:30.589039609Z",
"updateTime": "2022-04-29T22:16:30.589039609Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "570c515e74f29d63891e8d182d2979daae6af980",
"ref": "refs/heads/main"
}
}
}
[22:16:31.112] Task URL: https://cr-buildbucket.appspot.com/build/8815511005160361937
[22:16:31.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:2:0) after 3m30s
[22:19:50.407] Received PubSub notification, asking Buildbucket for the build status
[22:19:50.460] Build status: STARTED
[22:20:01.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:2:0)
[22:20:01.236] Build status: STARTED
[22:20:01.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:4:0) after 4m2s
[22:24:03.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:4:0)
[22:24:03.319] Build status: STARTED
[22:24:03.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:5:0) after 4m46s
[22:28:49.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:5:0)
[22:28:49.357] Build status: STARTED
[22:28:49.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:6:0) after 2m55s
[22:31:44.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:6:0)
[22:31:44.462] Build status: STARTED
[22:31:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:7:0) after 7m24s
[22:39:08.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:7:0)
[22:39:08.503] Build status: STARTED
[22:39:08.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:8:0) after 6m20s
[22:45:28.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:8:0)
[22:45:28.668] Build status: STARTED
[22:45:28.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:9:0) after 6m25s
[22:51:54.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:9:0)
[22:51:54.215] Build status: STARTED
[22:51:54.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:10:0) after 8m56s
[23:00:50.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:10:0)
[23:00:50.333] Build status: STARTED
[23:00:50.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:11:0) after 8m58s
[23:09:48.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:11:0)
[23:09:48.353] Build status: STARTED
[23:09:48.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:12:0) after 9m11s
[23:18:59.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:12:0)
[23:18:59.408] Build status: STARTED
[23:18:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:13:0) after 5m35s
[23:24:34.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:13:0)
[23:24:34.459] Build status: STARTED
[23:24:34.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:14:0) after 6m24s
[23:30:58.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:14:0)
[23:30:58.687] Build status: STARTED
[23:30:58.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:15:0) after 5m47s
[23:36:45.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:15:0)
[23:36:45.782] Build status: STARTED
[23:36:45.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:16:0) after 5m18s
[23:42:04.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:16:0)
[23:42:04.067] Build status: STARTED
[23:42:04.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:17:0) after 4m30s
[23:46:34.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:17:0)
[23:46:34.384] Build status: STARTED
[23:46:34.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:18:0) after 6m48s
[23:53:22.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:18:0)
[23:53:22.432] Build status: STARTED
[23:53:22.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:19:0) after 4m28s
[23:57:50.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:19:0)
[23:57:50.716] Build status: STARTED
[23:57:50.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:20:0) after 8m52s
[00:06:42.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:20:0)
[00:06:42.842] Build status: STARTED
[00:06:42.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:21:0) after 8m56s
[00:15:39.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:21:0)
[00:15:39.206] Build status: STARTED
[00:15:39.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:22:0) after 8m58s
[00:24:37.339] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:22:0)
[00:24:37.370] Build status: STARTED
[00:24:37.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:23:0) after 9m26s
[00:34:03.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:23:0)
[00:34:03.411] Build status: STARTED
[00:34:03.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:24:0) after 3m26s
[00:37:29.477] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:24:0)
[00:37:29.535] Build status: STARTED
[00:37:29.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:25:0) after 4m44s
[00:42:13.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:25:0)
[00:42:13.741] Build status: STARTED
[00:42:13.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:26:0) after 1m50s
[00:44:03.867] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:26:0)
[00:44:03.892] Build status: STARTED
[00:44:03.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:27:0) after 7m41s
[00:51:45.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:27:0)
[00:51:45.033] Build status: STARTED
[00:51:45.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:28:0) after 3m22s
[00:55:07.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:28:0)
[00:55:07.165] Build status: STARTED
[00:55:07.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:29:0) after 7m3s
[01:02:10.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:29:0)
[01:02:10.211] Build status: STARTED
[01:02:10.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:30:0) after 2m22s
[01:04:32.266] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:30:0)
[01:04:32.302] Build status: STARTED
[01:04:32.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:31:0) after 2m57s
[01:07:29.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:31:0)
[01:07:29.495] Build status: STARTED
[01:07:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:32:0) after 5m1s
[01:12:30.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:32:0)
[01:12:30.516] Build status: STARTED
[01:12:30.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:33:0) after 2m16s
[01:14:46.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:33:0)
[01:14:46.882] Build status: STARTED
[01:14:46.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:34:0) after 3m32s
[01:18:18.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:34:0)
[01:18:18.956] Build status: STARTED
[01:18:18.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:35:0) after 9m16s
[01:27:34.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:35:0)
[01:27:35.011] Build status: STARTED
[01:27:35.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:36:0) after 1m10s
[01:28:45.030] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:36:0)
[01:28:45.077] Build status: STARTED
[01:28:45.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:37:0) after 8m9s
[01:36:55.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:37:0)
[01:36:55.181] Build status: STARTED
[01:36:55.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:38:0) after 1m58s
[01:38:53.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:38:0)
[01:38:53.853] Build status: STARTED
[01:38:53.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:39:0) after 9m40s
[01:48:34.155] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:39:0)
[01:48:34.187] Build status: STARTED
[01:48:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:40:0) after 8m31s
[01:57:05.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:40:0)
[01:57:05.629] Build status: STARTED
[01:57:05.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:41:0) after 7m15s
[02:04:20.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:41:0)
[02:04:20.686] Build status: STARTED
[02:04:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:42:0) after 2m46s
[02:07:06.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:42:0)
[02:07:06.729] Build status: STARTED
[02:07:06.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:43:0) after 1m9s
[02:08:15.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:43:0)
[02:08:15.799] Build status: STARTED
[02:08:15.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:44:0) after 5m43s
[02:13:59.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:44:0)
[02:13:59.119] Build status: STARTED
[02:13:59.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:45:0) after 9m57s
[02:23:56.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:45:0)
[02:23:56.264] Build status: STARTED
[02:23:56.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:46:0) after 1m22s
[02:25:18.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:46:0)
[02:25:18.395] Build status: STARTED
[02:25:18.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:47:0) after 6m26s
[02:31:44.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:47:0)
[02:31:45.021] Build status: STARTED
[02:31:45.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:48:0) after 3m40s
[02:35:25.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:48:0)
[02:35:25.102] Build status: STARTED
[02:35:25.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:49:0) after 6m46s
[02:42:11.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:49:0)
[02:42:11.251] Build status: STARTED
[02:42:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:50:0) after 2m14s
[02:44:25.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:50:0)
[02:44:25.292] Build status: STARTED
[02:44:25.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:51:0) after 4m48s
[02:49:13.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:51:0)
[02:49:13.584] Build status: STARTED
[02:49:13.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:52:0) after 8m43s
[02:57:56.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:52:0)
[02:57:56.717] Build status: STARTED
[02:57:56.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:53:0) after 3m51s
[03:01:47.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:53:0)
[03:01:47.881] Build status: STARTED
[03:01:47.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:54:0) after 3m42s
[03:05:29.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:54:0)
[03:05:29.944] Build status: STARTED
[03:05:29.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:55:0) after 7m2s
[03:12:32.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:55:0)
[03:12:32.097] Build status: STARTED
[03:12:32.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:56:0) after 1m18s
[03:13:50.431] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:56:0)
[03:13:50.454] Build status: STARTED
[03:13:50.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:57:0) after 6m57s
[03:20:47.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:57:0)
[03:20:47.695] Build status: STARTED
[03:20:47.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:58:0) after 8m10s
[03:28:57.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:58:0)
[03:28:57.940] Build status: STARTED
[03:28:57.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:59:0) after 8m51s
[03:37:49.077] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:59:0)
[03:37:49.109] Build status: STARTED
[03:37:49.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:60:0) after 3m10s
[03:40:59.417] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:60:0)
[03:40:59.454] Build status: STARTED
[03:40:59.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:61:0) after 9m47s
[03:50:46.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:61:0)
[03:50:46.579] Build status: STARTED
[03:50:46.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:62:0) after 3m45s
[03:54:31.599] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:62:0)
[03:54:31.625] Build status: STARTED
[03:54:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:63:0) after 3m22s
[03:57:53.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:63:0)
[03:57:53.688] Build status: STARTED
[03:57:53.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:64:0) after 3m53s
[04:01:46.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:64:0)
[04:01:46.762] Build status: STARTED
[04:01:46.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:65:0) after 4m29s
[04:06:15.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:65:0)
[04:06:15.835] Build status: STARTED
[04:06:15.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:66:0) after 2m44s
[04:08:59.859] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:66:0)
[04:08:59.905] Build status: STARTED
[04:08:59.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:67:0) after 8m11s
[04:17:11.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:67:0)
[04:17:11.078] Build status: STARTED
[04:17:11.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:68:0) after 8m38s
[04:25:49.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:68:0)
[04:25:49.218] Build status: STARTED
[04:25:49.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:69:0) after 2m32s
[04:28:21.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:69:0)
[04:28:21.266] Build status: STARTED
[04:28:21.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:70:0) after 6m20s
[04:34:41.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:70:0)
[04:34:41.312] Build status: STARTED
[04:34:41.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:71:0) after 9m10s
[04:43:51.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:71:0)
[04:43:51.731] Build status: STARTED
[04:43:51.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:72:0) after 1m41s
[04:45:32.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:72:0)
[04:45:32.868] Build status: STARTED
[04:45:32.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:73:0) after 1m21s
[04:46:54.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:73:0)
[04:46:54.241] Build status: STARTED
[04:46:54.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:74:0) after 7m4s
[04:53:58.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:74:0)
[04:53:58.326] Build status: STARTED
[04:53:58.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:75:0) after 2m11s
[04:56:09.345] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:75:0)
[04:56:09.378] Build status: STARTED
[04:56:09.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:76:0) after 3m21s
[04:59:30.447] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:76:0)
[04:59:30.483] Build status: STARTED
[04:59:30.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:77:0) after 5m14s
[05:04:44.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:77:0)
[05:04:44.571] Build status: STARTED
[05:04:44.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:78:0) after 7m20s
[05:12:04.602] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:78:0)
[05:12:04.623] Build status: STARTED
[05:12:04.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:79:0) after 4m41s
[05:16:45.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:79:0)
[05:16:45.666] Build status: STARTED
[05:16:45.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:80:0) after 1m19s
[05:18:04.793] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:80:0)
[05:18:04.821] Build status: STARTED
[05:18:04.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:81:0) after 3m20s
[05:21:24.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:81:0)
[05:21:24.900] Build status: STARTED
[05:21:24.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:82:0) after 3m59s
[05:25:23.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:82:0)
[05:25:23.971] Build status: STARTED
[05:25:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:83:0) after 1m52s
[05:27:16.465] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:83:0)
[05:27:16.486] Build status: STARTED
[05:27:16.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:84:0) after 7m25s
[05:34:41.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:84:0)
[05:34:41.557] Build status: STARTED
[05:34:41.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:85:0) after 7m13s
[05:41:54.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:85:0)
[05:41:54.615] Build status: STARTED
[05:41:54.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:86:0) after 9m33s
[05:51:27.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:86:0)
[05:51:27.680] Build status: STARTED
[05:51:27.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:87:0) after 8m30s
[05:59:57.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:87:0)
[05:59:57.976] Build status: STARTED
[05:59:57.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:88:0) after 8m48s
[06:08:46.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:88:0)
[06:08:46.596] Build status: STARTED
[06:08:46.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:89:0) after 6m10s
[06:14:56.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:89:0)
[06:14:56.714] Build status: STARTED
[06:14:56.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:90:0) after 3m33s
[06:18:29.859] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:90:0)
[06:18:29.894] Build status: STARTED
[06:18:29.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:91:0) after 1m54s
[06:20:24.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:91:0)
[06:20:24.088] Build status: STARTED
[06:20:24.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:92:0) after 1m22s
[06:21:46.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:92:0)
[06:21:46.273] Build status: STARTED
[06:21:46.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:93:0) after 6m16s
[06:28:02.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:93:0)
[06:28:02.323] Build status: STARTED
[06:28:02.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:94:0) after 1m31s
[06:29:33.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:94:0)
[06:29:33.341] Build status: STARTED
[06:29:33.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:95:0) after 3m14s
[06:32:47.417] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:95:0)
[06:32:47.436] Build status: STARTED
[06:32:47.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:96:0) after 6m55s
[06:39:42.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:96:0)
[06:39:42.654] Build status: STARTED
[06:39:42.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:97:0) after 2m5s
[06:41:47.868] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:97:0)
[06:41:47.904] Build status: STARTED
[06:41:47.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:98:0) after 9m47s
[06:51:34.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:98:0)
[06:51:34.929] Build status: STARTED
[06:51:34.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:99:0) after 1m58s
[06:53:33.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:99:0)
[06:53:33.262] Build status: STARTED
[06:53:33.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:100:0) after 8m16s
[07:01:49.284] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:100:0)
[07:01:49.313] Build status: STARTED
[07:01:49.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:101:0) after 6m47s
[07:08:36.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:101:0)
[07:08:36.928] Build status: STARTED
[07:08:36.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:102:0) after 1m35s
[07:10:11.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:102:0)
[07:10:11.999] Build status: STARTED
[07:10:11.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:103:0) after 2m32s
[07:12:44.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:103:0)
[07:12:44.815] Build status: STARTED
[07:12:44.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:104:0) after 4m18s
[07:17:03.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:104:0)
[07:17:03.087] Build status: STARTED
[07:17:03.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:105:0) after 7m32s
[07:24:35.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:105:0)
[07:24:35.145] Build status: STARTED
[07:24:35.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8980941068212175536:106:0) after 8m30s
[07:27:49.853] Received PubSub notification, asking Buildbucket for the build status
[07:27:49.881] Build:
{
"id": "8815511005160361937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 2510,
"createdBy": "project:chromium",
"createTime": "2022-04-29T22:16:30.589039609Z",
"startTime": "2022-04-29T22:19:49.806490Z",
"endTime": "2022-04-30T07:27:49.463325658Z",
"updateTime": "2022-04-30T07:27:49.463325658Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "570c515e74f29d63891e8d182d2979daae6af980",
"ref": "refs/heads/main"
}
}
}
[07:27:49.881] Invocation finished in 9h11m21.585678925s with status FAILED