[11:55:56.300] New invocation is queued and will start shortly
[11:55:57.432] Starting the invocation (attempt 1)
[11:55:57.485] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/644f8f43be1992135381a620794c9ecb217fd4e3"
[11:55:57.485] Popped gitiles commit info from properties and tags
[11:55:57.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:55:57.485] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:55:57.485] Buildbucket request:
{
"requestId": "9002542186810727488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "644f8f43be1992135381a620794c9ecb217fd4e3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9002542186810727488"
},
{
"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"
}
}
[11:55:58.037] Scheduled build:
{
"id": "8837112124746896481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1376,
"createdBy": "project:chromium",
"createTime": "2021-09-03T11:55:57.634098641Z",
"updateTime": "2021-09-03T11:55:57.884340499Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "644f8f43be1992135381a620794c9ecb217fd4e3",
"ref": "refs/heads/main"
}
}
}
[11:55:58.037] Task URL: https://cr-buildbucket.appspot.com/build/8837112124746896481
[11:55:58.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:2:0) after 3m49s
[11:59:47.117] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:2:0)
[11:59:47.163] Build status: SCHEDULED
[11:59:47.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:3:0) after 6m42s
[12:06:29.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:3:0)
[12:06:29.541] Build status: SCHEDULED
[12:06:29.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:4:0) after 2m20s
[12:08:49.567] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:4:0)
[12:08:49.613] Build status: SCHEDULED
[12:08:49.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:5:0) after 2m42s
[12:11:31.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:5:0)
[12:11:31.970] Build status: SCHEDULED
[12:11:31.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:6:0) after 1m54s
[12:13:26.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:6:0)
[12:13:26.039] Build status: SCHEDULED
[12:13:26.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:7:0) after 5m12s
[12:18:38.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:7:0)
[12:18:38.105] Build status: SCHEDULED
[12:18:38.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:8:0) after 5m41s
[12:24:19.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:8:0)
[12:24:19.162] Build status: SCHEDULED
[12:24:19.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:9:0) after 6m4s
[12:30:23.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:9:0)
[12:30:23.598] Build status: SCHEDULED
[12:30:23.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:10:0) after 6m57s
[12:37:20.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:10:0)
[12:37:20.665] Build status: SCHEDULED
[12:37:20.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:11:0) after 9m9s
[12:46:29.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:11:0)
[12:46:29.768] Build status: SCHEDULED
[12:46:29.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:12:0) after 7m56s
[12:54:25.848] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:12:0)
[12:54:25.899] Build status: SCHEDULED
[12:54:25.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:13:0) after 1m4s
[12:55:29.966] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:13:0)
[12:55:30.006] Build status: SCHEDULED
[12:55:30.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:14:0) after 4m18s
[12:59:48.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:14:0)
[12:59:48.056] Build status: SCHEDULED
[12:59:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:15:0) after 4m13s
[13:04:01.222] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:15:0)
[13:04:01.307] Build status: SCHEDULED
[13:04:01.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:16:0) after 7m57s
[13:11:58.329] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:16:0)
[13:11:58.357] Build status: SCHEDULED
[13:11:58.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:17:0) after 5m23s
[13:17:21.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:17:0)
[13:17:21.542] Build status: SCHEDULED
[13:17:21.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:18:0) after 4m5s
[13:21:26.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:18:0)
[13:21:26.585] Build status: SCHEDULED
[13:21:26.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:19:0) after 3m3s
[13:24:29.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:19:0)
[13:24:29.666] Build status: SCHEDULED
[13:24:29.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:20:0) after 1m11s
[13:25:40.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:20:0)
[13:25:40.810] Build status: SCHEDULED
[13:25:40.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:21:0) after 9m26s
[13:32:40.990] Received PubSub notification, asking Buildbucket for the build status
[13:32:41.027] Build status: STARTED
[13:35:06.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:21:0)
[13:35:07.015] Build status: STARTED
[13:35:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:23:0) after 1m45s
[13:36:52.065] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:23:0)
[13:36:52.114] Build status: STARTED
[13:36:52.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:24:0) after 8m48s
[13:45:40.140] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:24:0)
[13:45:40.168] Build status: STARTED
[13:45:40.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:25:0) after 5m3s
[13:50:43.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:25:0)
[13:50:43.337] Build status: STARTED
[13:50:43.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:26:0) after 5m2s
[13:55:45.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:26:0)
[13:55:45.512] Build status: STARTED
[13:55:45.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:27:0) after 3m11s
[13:58:56.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:27:0)
[13:58:56.795] Build status: STARTED
[13:58:56.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:28:0) after 2m39s
[14:01:35.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:28:0)
[14:01:35.918] Build status: STARTED
[14:01:35.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:29:0) after 6m57s
[14:08:33.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:29:0)
[14:08:33.077] Build status: STARTED
[14:08:33.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:30:0) after 5m58s
[14:14:31.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:30:0)
[14:14:31.266] Build status: STARTED
[14:14:31.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:31:0) after 5m48s
[14:20:19.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:31:0)
[14:20:19.461] Build status: STARTED
[14:20:19.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:32:0) after 1m48s
[14:22:07.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:32:0)
[14:22:07.575] Build status: STARTED
[14:22:07.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:33:0) after 6m43s
[14:28:50.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:33:0)
[14:28:50.736] Build status: STARTED
[14:28:50.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:34:0) after 4m39s
[14:33:29.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:34:0)
[14:33:29.895] Build status: STARTED
[14:33:29.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:35:0) after 1m31s
[14:35:01.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:35:0)
[14:35:01.211] Build status: STARTED
[14:35:01.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:36:0) after 5m9s
[14:40:10.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:36:0)
[14:40:10.416] Build status: STARTED
[14:40:10.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:37:0) after 4m43s
[14:44:53.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:37:0)
[14:44:53.572] Build status: STARTED
[14:44:53.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:38:0) after 7m5s
[14:51:58.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:38:0)
[14:51:58.688] Build status: STARTED
[14:51:58.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:39:0) after 5m47s
[14:57:45.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:39:0)
[14:57:45.748] Build status: STARTED
[14:57:45.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:40:0) after 6m11s
[15:03:56.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:40:0)
[15:03:56.789] Build status: STARTED
[15:03:56.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:41:0) after 7m50s
[15:11:46.847] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:41:0)
[15:11:46.908] Build status: STARTED
[15:11:46.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:42:0) after 6m45s
[15:18:31.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:42:0)
[15:18:32.002] Build status: STARTED
[15:18:32.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:43:0) after 7m21s
[15:25:53.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:43:0)
[15:25:53.078] Build status: STARTED
[15:25:53.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:44:0) after 3m49s
[15:29:42.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:44:0)
[15:29:42.171] Build status: STARTED
[15:29:42.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:45:0) after 7m0s
[15:36:42.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:45:0)
[15:36:42.383] Build status: STARTED
[15:36:42.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:46:0) after 5m44s
[15:42:26.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:46:0)
[15:42:26.552] Build status: STARTED
[15:42:26.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:47:0) after 4m25s
[15:46:51.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:47:0)
[15:46:51.617] Build status: STARTED
[15:46:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:48:0) after 3m55s
[15:50:47.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:48:0)
[15:50:47.193] Build status: STARTED
[15:50:47.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:49:0) after 3m43s
[15:54:30.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:49:0)
[15:54:30.217] Build status: STARTED
[15:54:30.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:50:0) after 9m47s
[16:04:17.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:50:0)
[16:04:17.554] Build status: STARTED
[16:04:17.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:51:0) after 5m59s
[16:10:16.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:51:0)
[16:10:16.616] Build status: STARTED
[16:10:16.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:52:0) after 4m15s
[16:14:31.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:52:0)
[16:14:32.032] Build status: STARTED
[16:14:32.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:53:0) after 6m15s
[16:20:47.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:53:0)
[16:20:47.323] Build status: STARTED
[16:20:47.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:54:0) after 6m22s
[16:27:09.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:54:0)
[16:27:09.556] Build status: STARTED
[16:27:09.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:55:0) after 7m46s
[16:34:55.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:55:0)
[16:34:55.653] Build status: STARTED
[16:34:55.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:56:0) after 2m48s
[16:37:43.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:56:0)
[16:37:43.736] Build status: STARTED
[16:37:43.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:57:0) after 1m37s
[16:39:20.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:57:0)
[16:39:20.779] Build status: STARTED
[16:39:20.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:58:0) after 4m29s
[16:43:50.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:58:0)
[16:43:50.224] Build status: STARTED
[16:43:50.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:59:0) after 9m28s
[16:53:18.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:59:0)
[16:53:18.412] Build status: STARTED
[16:53:18.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:60:0) after 3m8s
[16:56:26.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:60:0)
[16:56:26.594] Build status: STARTED
[16:56:26.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:61:0) after 7m2s
[17:03:28.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:61:0)
[17:03:28.760] Build status: STARTED
[17:03:28.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:62:0) after 3m30s
[17:06:58.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:62:0)
[17:06:58.855] Build status: STARTED
[17:06:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:63:0) after 2m24s
[17:09:22.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:63:0)
[17:09:22.988] Build status: STARTED
[17:09:22.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:64:0) after 7m15s
[17:16:38.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:64:0)
[17:16:38.231] Build status: STARTED
[17:16:38.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:65:0) after 9m4s
[17:25:42.254] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:65:0)
[17:25:42.284] Build status: STARTED
[17:25:42.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:66:0) after 7m31s
[17:33:13.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:66:0)
[17:33:13.371] Build status: STARTED
[17:33:13.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:67:0) after 7m19s
[17:40:32.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:67:0)
[17:40:32.713] Build status: STARTED
[17:40:32.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:68:0) after 5m5s
[17:45:37.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:68:0)
[17:45:37.825] Build status: STARTED
[17:45:37.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:69:0) after 5m39s
[17:51:16.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:69:0)
[17:51:17.057] Build status: STARTED
[17:51:17.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:70:0) after 7m39s
[17:58:56.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:70:0)
[17:58:56.114] Build status: STARTED
[17:58:56.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:71:0) after 2m18s
[18:01:14.399] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:71:0)
[18:01:14.469] Build status: STARTED
[18:01:14.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:72:0) after 5m9s
[18:06:23.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:72:0)
[18:06:23.535] Build status: STARTED
[18:06:23.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:73:0) after 6m36s
[18:12:59.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:73:0)
[18:12:59.591] Build status: STARTED
[18:12:59.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:74:0) after 8m16s
[18:21:15.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:74:0)
[18:21:15.804] Build status: STARTED
[18:21:15.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:75:0) after 9m50s
[18:31:05.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:75:0)
[18:31:05.867] Build status: STARTED
[18:31:05.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:76:0) after 9m0s
[18:40:06.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:76:0)
[18:40:06.243] Build status: STARTED
[18:40:06.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:77:0) after 5m48s
[18:45:54.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:77:0)
[18:45:54.409] Build status: STARTED
[18:45:54.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:78:0) after 5m7s
[18:51:01.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:78:0)
[18:51:01.490] Build status: STARTED
[18:51:01.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:79:0) after 4m15s
[18:55:16.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:79:0)
[18:55:16.891] Build status: STARTED
[18:55:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:80:0) after 6m58s
[19:02:15.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:80:0)
[19:02:15.369] Build status: STARTED
[19:02:15.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:81:0) after 8m32s
[19:10:47.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:81:0)
[19:10:47.783] Build status: STARTED
[19:10:47.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:82:0) after 2m40s
[19:13:27.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:82:0)
[19:13:27.978] Build status: STARTED
[19:13:27.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:83:0) after 3m9s
[19:16:37.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:83:0)
[19:16:37.146] Build status: STARTED
[19:16:37.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:84:0) after 6m4s
[19:22:41.571] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:84:0)
[19:22:41.679] Build status: STARTED
[19:22:41.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:85:0) after 8m3s
[19:30:44.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:85:0)
[19:30:44.949] Build status: STARTED
[19:30:44.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:86:0) after 5m16s
[19:36:00.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:86:0)
[19:36:01.020] Build status: STARTED
[19:36:01.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:87:0) after 5m25s
[19:41:26.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:87:0)
[19:41:26.206] Build status: STARTED
[19:41:26.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:88:0) after 7m6s
[19:48:32.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:88:0)
[19:48:32.360] Build status: STARTED
[19:48:32.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:89:0) after 9m31s
[19:58:03.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:89:0)
[19:58:03.412] Build status: STARTED
[19:58:03.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:90:0) after 3m10s
[20:01:13.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:90:0)
[20:01:13.478] Build status: STARTED
[20:01:13.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:91:0) after 7m18s
[20:08:31.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:91:0)
[20:08:31.531] Build status: STARTED
[20:08:31.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:92:0) after 9m34s
[20:18:05.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:92:0)
[20:18:05.695] Build status: STARTED
[20:18:05.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:93:0) after 5m16s
[20:23:21.817] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:93:0)
[20:23:21.858] Build status: STARTED
[20:23:21.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:94:0) after 3m26s
[20:26:47.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:94:0)
[20:26:47.982] Build status: STARTED
[20:26:47.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:95:0) after 2m31s
[20:29:19.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:95:0)
[20:29:19.304] Build status: STARTED
[20:29:19.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:96:0) after 2m52s
[20:32:11.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:96:0)
[20:32:11.608] Build status: STARTED
[20:32:11.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:97:0) after 3m39s
[20:35:50.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:97:0)
[20:35:50.866] Build status: STARTED
[20:35:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:98:0) after 9m56s
[20:45:46.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:98:0)
[20:45:47.001] Build status: STARTED
[20:45:47.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:99:0) after 6m56s
[20:52:43.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:99:0)
[20:52:43.083] Build status: STARTED
[20:52:43.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:100:0) after 3m38s
[20:56:21.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:100:0)
[20:56:21.264] Build status: STARTED
[20:56:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:101:0) after 1m44s
[20:58:05.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:101:0)
[20:58:05.461] Build status: STARTED
[20:58:05.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:102:0) after 4m8s
[21:02:13.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:102:0)
[21:02:13.593] Build status: STARTED
[21:02:13.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:103:0) after 7m21s
[21:09:34.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:103:0)
[21:09:34.649] Build status: STARTED
[21:09:34.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:104:0) after 4m52s
[21:14:26.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:104:0)
[21:14:26.744] Build status: STARTED
[21:14:26.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:9002542186810727488:105:0) after 3m20s
[21:14:39.967] Received PubSub notification, asking Buildbucket for the build status
[21:14:40.000] Build:
{
"id": "8837112124746896481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 1376,
"createdBy": "project:chromium",
"createTime": "2021-09-03T11:55:57.634098641Z",
"startTime": "2021-09-03T13:32:40.277907Z",
"endTime": "2021-09-03T21:14:39.632586904Z",
"updateTime": "2021-09-03T21:14:39.633013716Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "644f8f43be1992135381a620794c9ecb217fd4e3",
"ref": "refs/heads/main"
}
}
}
[21:14:40.000] Invocation finished in 9h18m43.718531803s with status FAILED