[00:52:28.970] New invocation is queued and will start shortly
[00:52:30.086] Starting the invocation (attempt 1)
[00:52:30.120] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fbb627a19187f65ec84dd6ca69e8fa7ef75ad1c2"
[00:52:30.120] Popped gitiles commit info from properties and tags
[00:52:30.120] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:52:30.120] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:52:30.120] Buildbucket request:
{
"requestId": "8995336170507313664",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fbb627a19187f65ec84dd6ca69e8fa7ef75ad1c2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8995336170507313664"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:52:30.592] Scheduled build:
{
"id": "8829906108577536481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 736,
"createdBy": "project:chromium",
"createTime": "2021-11-22T00:52:30.178133097Z",
"updateTime": "2021-11-22T00:52:30.178133097Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fbb627a19187f65ec84dd6ca69e8fa7ef75ad1c2",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:52:30.592] Task URL: https://cr-buildbucket.appspot.com/build/8829906108577536481
[00:52:30.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:2:0) after 3m31s
[00:56:01.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:2:0)
[00:56:01.852] Build status: SCHEDULED
[00:56:01.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:3:0) after 1m58s
[00:58:00.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:3:0)
[00:58:00.111] Build status: SCHEDULED
[00:58:00.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:4:0) after 3m30s
[01:01:30.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:4:0)
[01:01:30.160] Build status: SCHEDULED
[01:01:30.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:5:0) after 2m53s
[01:04:24.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:5:0)
[01:04:24.093] Build status: SCHEDULED
[01:04:24.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:6:0) after 3m16s
[01:07:40.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:6:0)
[01:07:40.472] Build status: SCHEDULED
[01:07:40.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:7:0) after 1m36s
[01:09:16.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:7:0)
[01:09:16.740] Build status: SCHEDULED
[01:09:16.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:8:0) after 3m37s
[01:12:54.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:8:0)
[01:12:54.220] Build status: SCHEDULED
[01:12:54.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:9:0) after 3m58s
[01:16:52.239] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:9:0)
[01:16:52.376] Build status: SCHEDULED
[01:16:52.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:10:0) after 5m41s
[01:22:33.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:10:0)
[01:22:33.735] Build status: SCHEDULED
[01:22:33.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:11:0) after 2m31s
[01:25:04.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:11:0)
[01:25:05.034] Build status: SCHEDULED
[01:25:05.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:12:0) after 3m31s
[01:28:36.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:12:0)
[01:28:36.087] Build status: SCHEDULED
[01:28:36.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:13:0) after 2m55s
[01:31:31.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:13:0)
[01:31:31.133] Build status: SCHEDULED
[01:31:31.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:14:0) after 1m36s
[01:33:07.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:14:0)
[01:33:07.286] Build status: SCHEDULED
[01:33:07.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:15:0) after 9m3s
[01:36:20.357] Received PubSub notification, asking Buildbucket for the build status
[01:36:20.448] Build status: STARTED
[01:42:11.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:15:0)
[01:42:11.207] Build status: STARTED
[01:42:11.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:17:0) after 1m13s
[01:43:24.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:17:0)
[01:43:24.258] Build status: STARTED
[01:43:24.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:18:0) after 8m43s
[01:52:07.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:18:0)
[01:52:07.374] Build status: STARTED
[01:52:07.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:19:0) after 4m22s
[01:56:29.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:19:0)
[01:56:29.419] Build status: STARTED
[01:56:29.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:20:0) after 7m31s
[02:04:00.412] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:20:0)
[02:04:00.462] Build status: STARTED
[02:04:00.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:21:0) after 1m12s
[02:05:12.519] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:21:0)
[02:05:12.552] Build status: STARTED
[02:05:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:22:0) after 7m13s
[02:12:25.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:22:0)
[02:12:25.611] Build status: STARTED
[02:12:25.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:23:0) after 4m10s
[02:16:35.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:23:0)
[02:16:35.673] Build status: STARTED
[02:16:35.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:24:0) after 1m56s
[02:18:31.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:24:0)
[02:18:31.980] Build status: STARTED
[02:18:31.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:25:0) after 2m27s
[02:20:59.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:25:0)
[02:20:59.140] Build status: STARTED
[02:20:59.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:26:0) after 5m55s
[02:26:54.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:26:0)
[02:26:54.197] Build status: STARTED
[02:26:54.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:27:0) after 9m31s
[02:36:25.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:27:0)
[02:36:25.266] Build status: STARTED
[02:36:25.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:28:0) after 2m51s
[02:39:16.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:28:0)
[02:39:16.322] Build status: STARTED
[02:39:16.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:29:0) after 6m55s
[02:46:11.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:29:0)
[02:46:11.768] Build status: STARTED
[02:46:11.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:30:0) after 2m27s
[02:48:38.789] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:30:0)
[02:48:38.827] Build status: STARTED
[02:48:38.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:31:0) after 7m23s
[02:56:01.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:31:0)
[02:56:01.905] Build status: STARTED
[02:56:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:32:0) after 4m21s
[03:00:22.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:32:0)
[03:00:23.099] Build status: STARTED
[03:00:23.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:33:0) after 9m41s
[03:10:04.117] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:33:0)
[03:10:04.587] Build status: STARTED
[03:10:04.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:34:0) after 8m36s
[03:18:40.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:34:0)
[03:18:40.698] Build status: STARTED
[03:18:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:35:0) after 6m27s
[03:25:07.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:35:0)
[03:25:07.750] Build status: STARTED
[03:25:07.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:36:0) after 5m25s
[03:30:32.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:36:0)
[03:30:32.832] Build status: STARTED
[03:30:32.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:37:0) after 8m28s
[03:39:00.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:37:0)
[03:39:00.935] Build status: STARTED
[03:39:00.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:38:0) after 6m28s
[03:45:28.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:38:0)
[03:45:28.983] Build status: STARTED
[03:45:28.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:39:0) after 8m58s
[03:54:27.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:39:0)
[03:54:27.073] Build status: STARTED
[03:54:27.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:40:0) after 5m52s
[04:00:19.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:40:0)
[04:00:19.127] Build status: STARTED
[04:00:19.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:41:0) after 4m12s
[04:04:31.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:41:0)
[04:04:31.264] Build status: STARTED
[04:04:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:42:0) after 1m28s
[04:05:59.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:42:0)
[04:05:59.430] Build status: STARTED
[04:05:59.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:43:0) after 5m14s
[04:11:13.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:43:0)
[04:11:13.484] Build status: STARTED
[04:11:13.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:44:0) after 8m9s
[04:19:22.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:44:0)
[04:19:22.538] Build status: STARTED
[04:19:22.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:45:0) after 9m5s
[04:28:27.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:45:0)
[04:28:27.595] Build status: STARTED
[04:28:27.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:46:0) after 8m31s
[04:36:59.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:46:0)
[04:36:59.128] Build status: STARTED
[04:36:59.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:47:0) after 4m31s
[04:41:30.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:47:0)
[04:41:30.184] Build status: STARTED
[04:41:30.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:48:0) after 3m51s
[04:45:22.052] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:48:0)
[04:45:22.088] Build status: STARTED
[04:45:22.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:49:0) after 8m49s
[04:54:11.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:49:0)
[04:54:11.353] Build status: STARTED
[04:54:11.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:50:0) after 1m40s
[04:55:51.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:50:0)
[04:55:51.549] Build status: STARTED
[04:55:51.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:51:0) after 3m44s
[04:59:35.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:51:0)
[04:59:35.800] Build status: STARTED
[04:59:35.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:52:0) after 1m50s
[05:01:26.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:52:0)
[05:01:26.300] Build status: STARTED
[05:01:26.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:53:0) after 4m51s
[05:06:17.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:53:0)
[05:06:17.781] Build status: STARTED
[05:06:17.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:54:0) after 2m12s
[05:08:29.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:54:0)
[05:08:29.800] Build status: STARTED
[05:08:29.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:55:0) after 6m31s
[05:15:00.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:55:0)
[05:15:00.838] Build status: STARTED
[05:15:00.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:56:0) after 2m23s
[05:17:24.078] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:56:0)
[05:17:24.359] Build status: STARTED
[05:17:24.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:57:0) after 3m16s
[05:20:40.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:57:0)
[05:20:40.414] Build status: STARTED
[05:20:40.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:58:0) after 1m4s
[05:21:44.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:58:0)
[05:21:44.559] Build status: STARTED
[05:21:44.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:59:0) after 9m36s
[05:31:20.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:59:0)
[05:31:20.642] Build status: STARTED
[05:31:20.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:60:0) after 4m0s
[05:35:20.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:60:0)
[05:35:20.701] Build status: STARTED
[05:35:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:61:0) after 5m55s
[05:41:15.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:61:0)
[05:41:15.755] Build status: STARTED
[05:41:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:62:0) after 6m14s
[05:47:29.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:62:0)
[05:47:30.069] Build status: STARTED
[05:47:30.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:63:0) after 5m11s
[05:52:41.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:63:0)
[05:52:41.254] Build status: STARTED
[05:52:41.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:64:0) after 8m42s
[06:01:23.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:64:0)
[06:01:23.312] Build status: STARTED
[06:01:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:65:0) after 1m7s
[06:02:30.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:65:0)
[06:02:30.439] Build status: STARTED
[06:02:30.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:66:0) after 5m44s
[06:08:14.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:66:0)
[06:08:14.564] Build status: STARTED
[06:08:14.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:67:0) after 7m24s
[06:15:38.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:67:0)
[06:15:38.607] Build status: STARTED
[06:15:38.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:68:0) after 7m1s
[06:22:39.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:68:0)
[06:22:39.704] Build status: STARTED
[06:22:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:69:0) after 1m29s
[06:24:08.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:69:0)
[06:24:08.760] Build status: STARTED
[06:24:08.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:70:0) after 3m35s
[06:27:43.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:70:0)
[06:27:43.829] Build status: STARTED
[06:27:43.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:71:0) after 4m34s
[06:32:18.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:71:0)
[06:32:18.108] Build status: STARTED
[06:32:18.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:72:0) after 8m39s
[06:40:57.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:72:0)
[06:40:57.258] Build status: STARTED
[06:40:57.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:73:0) after 3m49s
[06:44:46.258] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:73:0)
[06:44:46.289] Build status: STARTED
[06:44:46.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:74:0) after 3m33s
[06:48:19.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:74:0)
[06:48:19.343] Build status: STARTED
[06:48:19.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:75:0) after 3m13s
[06:51:32.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:75:0)
[06:51:32.408] Build status: STARTED
[06:51:32.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:76:0) after 3m9s
[06:54:41.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:76:0)
[06:54:41.461] Build status: STARTED
[06:54:41.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:77:0) after 4m55s
[06:59:36.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:77:0)
[06:59:36.512] Build status: STARTED
[06:59:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:78:0) after 4m58s
[07:04:35.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:78:0)
[07:04:35.295] Build status: STARTED
[07:04:35.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:79:0) after 6m43s
[07:11:18.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:79:0)
[07:11:18.412] Build status: STARTED
[07:11:18.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:80:0) after 1m55s
[07:13:13.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:80:0)
[07:13:13.470] Build status: STARTED
[07:13:13.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:81:0) after 3m41s
[07:16:54.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:81:0)
[07:16:54.612] Build status: STARTED
[07:16:54.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:82:0) after 1m36s
[07:18:30.633] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:82:0)
[07:18:30.662] Build status: STARTED
[07:18:30.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:83:0) after 7m46s
[07:26:16.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:83:0)
[07:26:16.713] Build status: STARTED
[07:26:16.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:84:0) after 3m52s
[07:30:08.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:84:0)
[07:30:08.796] Build status: STARTED
[07:30:08.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:85:0) after 6m41s
[07:36:49.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:85:0)
[07:36:49.948] Build status: STARTED
[07:36:49.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:86:0) after 3m11s
[07:40:01.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:86:0)
[07:40:01.041] Build status: STARTED
[07:40:01.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:87:0) after 7m0s
[07:47:01.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:87:0)
[07:47:01.099] Build status: STARTED
[07:47:01.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:88:0) after 8m37s
[07:55:38.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:88:0)
[07:55:38.224] Build status: STARTED
[07:55:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:89:0) after 5m54s
[08:01:32.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:89:0)
[08:01:32.306] Build status: STARTED
[08:01:32.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:90:0) after 5m58s
[08:07:30.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:90:0)
[08:07:30.369] Build status: STARTED
[08:07:30.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:91:0) after 1m45s
[08:09:15.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:91:0)
[08:09:15.470] Build status: STARTED
[08:09:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:92:0) after 7m46s
[08:17:01.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:92:0)
[08:17:01.672] Build status: STARTED
[08:17:01.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:93:0) after 8m25s
[08:25:26.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:93:0)
[08:25:26.809] Build status: STARTED
[08:25:26.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:94:0) after 7m51s
[08:33:17.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:94:0)
[08:33:17.979] Build status: STARTED
[08:33:17.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:95:0) after 7m11s
[08:40:29.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:95:0)
[08:40:29.038] Build status: STARTED
[08:40:29.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:96:0) after 4m6s
[08:44:35.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:96:0)
[08:44:35.091] Build status: STARTED
[08:44:35.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:97:0) after 2m44s
[08:47:19.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:97:0)
[08:47:19.178] Build status: STARTED
[08:47:19.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:98:0) after 9m37s
[08:56:56.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:98:0)
[08:56:56.277] Build status: STARTED
[08:56:56.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:99:0) after 5m3s
[09:01:59.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:99:0)
[09:01:59.568] Build status: STARTED
[09:01:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:100:0) after 3m15s
[09:05:14.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:100:0)
[09:05:14.848] Build status: STARTED
[09:05:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:101:0) after 6m41s
[09:11:55.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:101:0)
[09:11:55.914] Build status: STARTED
[09:11:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:102:0) after 3m30s
[09:15:25.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:102:0)
[09:15:25.970] Build status: STARTED
[09:15:25.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:103:0) after 9m14s
[09:24:39.995] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:103:0)
[09:24:40.023] Build status: STARTED
[09:24:40.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:104:0) after 2m49s
[09:27:29.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:104:0)
[09:27:29.219] Build status: STARTED
[09:27:29.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:105:0) after 7m31s
[09:35:00.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:105:0)
[09:35:00.283] Build status: STARTED
[09:35:00.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:106:0) after 8m0s
[09:43:00.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:106:0)
[09:43:00.339] Build status: STARTED
[09:43:00.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:107:0) after 4m14s
[09:47:14.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:107:0)
[09:47:14.395] Build status: STARTED
[09:47:14.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:108:0) after 5m33s
[09:52:47.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:108:0)
[09:52:47.533] Build status: STARTED
[09:52:47.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:109:0) after 7m21s
[10:00:08.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:109:0)
[10:00:08.781] Build status: STARTED
[10:00:08.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:110:0) after 3m36s
[10:03:44.801] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:110:0)
[10:03:44.832] Build status: STARTED
[10:03:44.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:111:0) after 8m17s
[10:12:01.955] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:111:0)
[10:12:01.986] Build status: STARTED
[10:12:01.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:112:0) after 5m44s
[10:17:46.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:112:0)
[10:17:46.054] Build status: STARTED
[10:17:46.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:113:0) after 5m50s
[10:23:36.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:113:0)
[10:23:36.298] Build status: STARTED
[10:23:36.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:114:0) after 6m9s
[10:29:45.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:114:0)
[10:29:45.481] Build status: STARTED
[10:29:45.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:115:0) after 5m42s
[10:35:27.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:115:0)
[10:35:27.558] Build status: STARTED
[10:35:27.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:116:0) after 2m10s
[10:37:37.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:116:0)
[10:37:37.729] Build status: STARTED
[10:37:37.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:117:0) after 2m41s
[10:40:18.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:117:0)
[10:40:18.781] Build status: STARTED
[10:40:18.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:8995336170507313664:118:0) after 1m35s
[10:40:22.823] Received PubSub notification, asking Buildbucket for the build status
[10:40:22.856] Build:
{
"id": "8829906108577536481",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 736,
"createdBy": "project:chromium",
"createTime": "2021-11-22T00:52:30.178133097Z",
"startTime": "2021-11-22T01:36:19.609787Z",
"endTime": "2021-11-22T10:40:22.096827242Z",
"updateTime": "2021-11-22T10:40:22.096827242Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fbb627a19187f65ec84dd6ca69e8fa7ef75ad1c2",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:40:22.856] Invocation finished in 9h47m53.901949656s with status FAILED