[00:04:52.166] New invocation is queued and will start shortly
[00:04:53.381] Starting the invocation (attempt 1)
[00:04:53.420] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e41e8ce98eb93d46c3d932e1f6c22a364d364d0"
[00:04:53.420] Popped gitiles commit info from properties and tags
[00:04:53.421] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:04:53.421] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:04:53.421] Buildbucket request:
{
"requestId": "9004761250590830128",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e41e8ce98eb93d46c3d932e1f6c22a364d364d0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9004761250590830128"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dll)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:04:53.983] Scheduled build:
{
"id": "8839331188536456977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 8867,
"createdBy": "project:chromium",
"createTime": "2021-08-10T00:04:53.492118170Z",
"updateTime": "2021-08-10T00:04:53.780977523Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e41e8ce98eb93d46c3d932e1f6c22a364d364d0",
"ref": "refs/heads/main"
}
}
}
[00:04:53.983] Task URL: https://cr-buildbucket.appspot.com/build/8839331188536456977
[00:04:53.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:2:0) after 7m34s
[00:12:28.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:2:0)
[00:12:28.066] Build status: SCHEDULED
[00:12:28.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:3:0) after 5m41s
[00:18:09.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:3:0)
[00:18:09.309] Build status: SCHEDULED
[00:18:09.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:4:0) after 4m6s
[00:22:15.333] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:4:0)
[00:22:15.373] Build status: SCHEDULED
[00:22:15.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:5:0) after 2m35s
[00:24:50.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:5:0)
[00:24:50.441] Build status: SCHEDULED
[00:24:50.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:6:0) after 2m13s
[00:27:03.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:6:0)
[00:27:03.628] Build status: SCHEDULED
[00:27:03.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:7:0) after 3m36s
[00:30:39.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:7:0)
[00:30:39.704] Build status: SCHEDULED
[00:30:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:8:0) after 9m3s
[00:39:42.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:8:0)
[00:39:42.863] Build status: SCHEDULED
[00:39:42.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:9:0) after 2m22s
[00:42:04.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:9:0)
[00:42:04.991] Build status: SCHEDULED
[00:42:04.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:10:0) after 4m14s
[00:46:19.067] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:10:0)
[00:46:19.163] Build status: SCHEDULED
[00:46:19.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:11:0) after 2m19s
[00:48:38.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:11:0)
[00:48:38.297] Build status: SCHEDULED
[00:48:38.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:12:0) after 7m36s
[00:56:14.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:12:0)
[00:56:14.355] Build status: SCHEDULED
[00:56:14.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:13:0) after 6m39s
[01:02:53.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:13:0)
[01:02:53.504] Build status: SCHEDULED
[01:02:53.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:14:0) after 3m33s
[01:06:03.673] Received PubSub notification, asking Buildbucket for the build status
[01:06:03.700] Build status: STARTED
[01:06:26.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:14:0)
[01:06:26.718] Build status: STARTED
[01:06:26.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:16:0) after 3m22s
[01:09:49.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:16:0)
[01:09:49.063] Build status: STARTED
[01:09:49.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:17:0) after 1m11s
[01:11:00.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:17:0)
[01:11:00.111] Build status: STARTED
[01:11:00.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:18:0) after 5m16s
[01:16:16.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:18:0)
[01:16:16.155] Build status: STARTED
[01:16:16.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:19:0) after 8m25s
[01:24:41.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:19:0)
[01:24:41.453] Build status: STARTED
[01:24:41.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:20:0) after 8m8s
[01:32:49.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:20:0)
[01:32:49.524] Build status: STARTED
[01:32:49.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:21:0) after 7m14s
[01:40:03.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:21:0)
[01:40:03.757] Build status: STARTED
[01:40:03.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:22:0) after 4m12s
[01:44:15.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:22:0)
[01:44:15.818] Build status: STARTED
[01:44:15.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:23:0) after 1m30s
[01:45:45.845] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:23:0)
[01:45:45.874] Build status: STARTED
[01:45:45.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:24:0) after 1m8s
[01:46:53.854] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:24:0)
[01:46:53.885] Build status: STARTED
[01:46:53.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:25:0) after 9m48s
[01:56:42.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:25:0)
[01:56:42.488] Build status: STARTED
[01:56:42.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:26:0) after 4m32s
[02:01:14.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:26:0)
[02:01:14.976] Build status: STARTED
[02:01:14.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:27:0) after 1m49s
[02:03:03.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:27:0)
[02:03:04.026] Build status: STARTED
[02:03:04.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:28:0) after 6m57s
[02:10:01.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:28:0)
[02:10:01.220] Build status: STARTED
[02:10:01.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:29:0) after 5m48s
[02:15:49.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:29:0)
[02:15:49.302] Build status: STARTED
[02:15:49.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:30:0) after 6m41s
[02:22:30.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:30:0)
[02:22:30.747] Build status: STARTED
[02:22:30.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:31:0) after 8m19s
[02:30:50.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:31:0)
[02:30:50.052] Build status: STARTED
[02:30:50.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:32:0) after 2m0s
[02:32:50.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:32:0)
[02:32:50.173] Build status: STARTED
[02:32:50.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:33:0) after 5m34s
[02:38:24.200] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:33:0)
[02:38:24.232] Build status: STARTED
[02:38:24.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:34:0) after 1m29s
[02:39:53.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:34:0)
[02:39:53.779] Build status: STARTED
[02:39:53.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:35:0) after 8m2s
[02:47:55.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:35:0)
[02:47:55.843] Build status: STARTED
[02:47:55.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:36:0) after 1m31s
[02:49:27.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:36:0)
[02:49:27.046] Build status: STARTED
[02:49:27.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:37:0) after 1m38s
[02:51:05.258] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:37:0)
[02:51:05.328] Build status: STARTED
[02:51:05.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:38:0) after 9m24s
[03:00:29.628] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:38:0)
[03:00:29.659] Build status: STARTED
[03:00:29.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:39:0) after 8m9s
[03:08:38.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:39:0)
[03:08:38.727] Build status: STARTED
[03:08:38.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:40:0) after 7m29s
[03:16:07.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:40:0)
[03:16:07.882] Build status: STARTED
[03:16:07.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:41:0) after 3m10s
[03:19:17.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:41:0)
[03:19:18.011] Build status: STARTED
[03:19:18.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:42:0) after 4m54s
[03:24:12.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:42:0)
[03:24:12.101] Build status: STARTED
[03:24:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:43:0) after 8m39s
[03:32:51.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:43:0)
[03:32:51.261] Build status: STARTED
[03:32:51.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:44:0) after 6m47s
[03:39:38.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:44:0)
[03:39:38.319] Build status: STARTED
[03:39:38.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:45:0) after 4m43s
[03:44:21.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:45:0)
[03:44:21.671] Build status: STARTED
[03:44:21.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:46:0) after 1m2s
[03:45:23.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:46:0)
[03:45:23.716] Build status: STARTED
[03:45:23.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:47:0) after 7m7s
[03:52:30.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:47:0)
[03:52:30.963] Build status: STARTED
[03:52:30.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:48:0) after 8m29s
[04:01:00.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:48:0)
[04:01:00.142] Build status: STARTED
[04:01:00.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:49:0) after 9m49s
[04:10:49.208] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:49:0)
[04:10:49.243] Build status: STARTED
[04:10:49.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:50:0) after 3m43s
[04:14:32.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:50:0)
[04:14:32.561] Build status: STARTED
[04:14:32.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:51:0) after 3m46s
[04:18:18.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:51:0)
[04:18:18.784] Build status: STARTED
[04:18:18.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:52:0) after 9m53s
[04:28:11.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:52:0)
[04:28:11.827] Build status: STARTED
[04:28:11.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:53:0) after 1m12s
[04:29:23.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:53:0)
[04:29:23.956] Build status: STARTED
[04:29:23.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:54:0) after 3m52s
[04:33:16.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:54:0)
[04:33:16.097] Build status: STARTED
[04:33:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:55:0) after 5m39s
[04:38:55.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:55:0)
[04:38:55.160] Build status: STARTED
[04:38:55.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:56:0) after 4m51s
[04:43:46.190] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:56:0)
[04:43:46.221] Build status: STARTED
[04:43:46.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:57:0) after 2m14s
[04:46:00.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:57:0)
[04:46:00.640] Build status: STARTED
[04:46:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:58:0) after 8m41s
[04:54:41.732] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:58:0)
[04:54:41.762] Build status: STARTED
[04:54:41.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:59:0) after 8m53s
[05:03:34.842] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:59:0)
[05:03:34.888] Build status: STARTED
[05:03:34.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:60:0) after 2m26s
[05:06:00.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:60:0)
[05:06:00.948] Build status: STARTED
[05:06:00.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:61:0) after 6m56s
[05:12:57.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:61:0)
[05:12:57.125] Build status: STARTED
[05:12:57.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:62:0) after 9m0s
[05:21:57.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:62:0)
[05:21:57.367] Build status: STARTED
[05:21:57.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:63:0) after 5m3s
[05:27:00.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:63:0)
[05:27:00.713] Build status: STARTED
[05:27:00.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:64:0) after 5m8s
[05:32:08.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:64:0)
[05:32:08.862] Build status: STARTED
[05:32:08.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:65:0) after 8m29s
[05:40:38.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:65:0)
[05:40:38.074] Build status: STARTED
[05:40:38.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:66:0) after 3m26s
[05:44:04.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:66:0)
[05:44:04.117] Build status: STARTED
[05:44:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:67:0) after 5m54s
[05:49:58.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:67:0)
[05:49:58.563] Build status: STARTED
[05:49:58.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:68:0) after 9m0s
[05:58:58.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:68:0)
[05:58:58.631] Build status: STARTED
[05:58:58.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:69:0) after 8m42s
[06:07:40.668] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:69:0)
[06:07:40.702] Build status: STARTED
[06:07:40.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:70:0) after 3m4s
[06:10:44.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:70:0)
[06:10:44.975] Build status: STARTED
[06:10:44.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:71:0) after 3m35s
[06:14:20.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:71:0)
[06:14:20.197] Build status: STARTED
[06:14:20.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:72:0) after 2m38s
[06:16:58.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:72:0)
[06:16:58.564] Build status: STARTED
[06:16:58.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:73:0) after 2m11s
[06:19:09.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:73:0)
[06:19:09.673] Build status: STARTED
[06:19:09.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:74:0) after 1m25s
[06:20:34.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:74:0)
[06:20:36.501] Build status: STARTED
[06:20:36.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:75:0) after 7m39s
[06:28:15.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:75:0)
[06:28:15.743] Build status: STARTED
[06:28:15.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:76:0) after 7m45s
[06:36:00.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:76:0)
[06:36:00.827] Build status: STARTED
[06:36:00.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:77:0) after 1m45s
[06:37:45.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:77:0)
[06:37:45.947] Build status: STARTED
[06:37:45.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:78:0) after 1m10s
[06:38:56.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:78:0)
[06:38:56.086] Build status: STARTED
[06:38:56.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:79:0) after 5m40s
[06:44:36.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:79:0)
[06:44:36.184] Build status: STARTED
[06:44:36.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:80:0) after 4m17s
[06:48:53.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:80:0)
[06:48:53.268] Build status: STARTED
[06:48:53.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:81:0) after 1m12s
[06:50:05.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:81:0)
[06:50:05.403] Build status: STARTED
[06:50:05.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:82:0) after 4m15s
[06:54:20.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:82:0)
[06:54:20.604] Build status: STARTED
[06:54:20.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:83:0) after 7m2s
[07:01:22.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:83:0)
[07:01:22.918] Build status: STARTED
[07:01:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:84:0) after 6m46s
[07:08:08.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:84:0)
[07:08:08.939] Build status: STARTED
[07:08:08.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:85:0) after 8m29s
[07:16:37.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:85:0)
[07:16:38.001] Build status: STARTED
[07:16:38.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:86:0) after 6m51s
[07:23:29.154] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:86:0)
[07:23:29.244] Build status: STARTED
[07:23:29.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:87:0) after 9m28s
[07:32:57.373] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:87:0)
[07:32:57.399] Build status: STARTED
[07:32:57.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:88:0) after 9m9s
[07:42:06.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:88:0)
[07:42:06.505] Build status: STARTED
[07:42:06.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:89:0) after 5m0s
[07:47:06.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:89:0)
[07:47:06.596] Build status: STARTED
[07:47:06.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:90:0) after 4m33s
[07:51:39.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:90:0)
[07:51:39.752] Build status: STARTED
[07:51:39.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:91:0) after 6m12s
[07:57:51.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:91:0)
[07:57:51.830] Build status: STARTED
[07:57:51.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:92:0) after 2m41s
[08:00:32.868] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:92:0)
[08:00:32.916] Build status: STARTED
[08:00:32.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:93:0) after 1m59s
[08:02:31.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:93:0)
[08:02:32.002] Build status: STARTED
[08:02:32.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:94:0) after 6m40s
[08:09:12.125] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:94:0)
[08:09:12.164] Build status: STARTED
[08:09:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:95:0) after 2m47s
[08:11:59.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:95:0)
[08:11:59.268] Build status: STARTED
[08:11:59.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:96:0) after 2m28s
[08:14:27.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:96:0)
[08:14:27.417] Build status: STARTED
[08:14:27.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:97:0) after 4m26s
[08:18:53.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:97:0)
[08:18:53.579] Build status: STARTED
[08:18:53.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:98:0) after 2m55s
[08:21:48.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:98:0)
[08:21:48.650] Build status: STARTED
[08:21:48.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:99:0) after 6m39s
[08:28:27.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:99:0)
[08:28:27.763] Build status: STARTED
[08:28:27.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:100:0) after 5m52s
[08:34:19.793] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:100:0)
[08:34:19.849] Build status: STARTED
[08:34:19.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:101:0) after 5m59s
[08:40:18.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:101:0)
[08:40:18.962] Build status: STARTED
[08:40:18.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:102:0) after 6m26s
[08:46:45.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:102:0)
[08:46:45.132] Build status: STARTED
[08:46:45.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:103:0) after 9m9s
[08:55:54.283] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:103:0)
[08:55:54.311] Build status: STARTED
[08:55:54.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:104:0) after 2m0s
[08:57:54.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:104:0)
[08:57:54.390] Build status: STARTED
[08:57:54.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:105:0) after 7m10s
[09:05:04.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:105:0)
[09:05:04.551] Build status: STARTED
[09:05:04.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:106:0) after 6m57s
[09:12:01.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:106:0)
[09:12:01.707] Build status: STARTED
[09:12:01.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:107:0) after 4m8s
[09:16:09.729] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:107:0)
[09:16:09.768] Build status: STARTED
[09:16:09.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:108:0) after 7m7s
[09:23:16.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:108:0)
[09:23:16.836] Build status: STARTED
[09:23:16.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:109:0) after 1m28s
[09:24:44.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:109:0)
[09:24:44.890] Build status: STARTED
[09:24:44.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:110:0) after 2m39s
[09:27:23.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:110:0)
[09:27:23.931] Build status: STARTED
[09:27:23.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9004761250590830128:111:0) after 8m53s
[09:30:11.296] Received PubSub notification, asking Buildbucket for the build status
[09:30:11.324] Build:
{
"id": "8839331188536456977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 8867,
"createdBy": "project:chromium",
"createTime": "2021-08-10T00:04:53.492118170Z",
"startTime": "2021-08-10T01:06:02.701233Z",
"endTime": "2021-08-10T09:30:10.797961214Z",
"updateTime": "2021-08-10T09:30:10.798340904Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e41e8ce98eb93d46c3d932e1f6c22a364d364d0",
"ref": "refs/heads/main"
}
}
}
[09:30:11.324] Invocation finished in 9h25m19.174836546s with status FAILED