[20:44:10.820] New invocation is queued and will start shortly
[20:44:12.069] Starting the invocation (attempt 1)
[20:44:12.102] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5d669c2b78280c122592434664ef5aec695678e"
[20:44:12.102] Popped gitiles commit info from properties and tags
[20:44:12.102] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:44:12.102] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:44:12.102] Buildbucket request:
{
"requestId": "8952861815104536080",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5d669c2b78280c122592434664ef5aec695678e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952861815104536080"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:44:12.744] Scheduled build:
{
"id": "8787431752892996673",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4460,
"createdBy": "project:chromium",
"createTime": "2023-03-05T20:44:12.301081840Z",
"updateTime": "2023-03-05T20:44:12.301081840Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5d669c2b78280c122592434664ef5aec695678e",
"ref": "refs/heads/main"
}
}
}
[20:44:12.744] Task URL: https://cr-buildbucket.appspot.com/build/8787431752892996673
[20:44:12.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:2:0) after 6m14s
[20:44:25.955] Received PubSub notification, asking Buildbucket for the build status
[20:44:25.991] Build status: STARTED
[20:50:26.771] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:2:0)
[20:50:26.797] Build status: STARTED
[20:50:26.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:4:0) after 3m30s
[20:53:56.815] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:4:0)
[20:53:56.850] Build status: STARTED
[20:53:56.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:5:0) after 6m5s
[21:00:01.870] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:5:0)
[21:00:01.916] Build status: STARTED
[21:00:01.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:6:0) after 2m2s
[21:02:04.037] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:6:0)
[21:02:04.064] Build status: STARTED
[21:02:04.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:7:0) after 3m2s
[21:05:06.092] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:7:0)
[21:05:06.113] Build status: STARTED
[21:05:06.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:8:0) after 6m41s
[21:11:47.130] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:8:0)
[21:11:47.154] Build status: STARTED
[21:11:47.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:9:0) after 1m39s
[21:13:26.179] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:9:0)
[21:13:26.220] Build status: STARTED
[21:13:26.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:10:0) after 4m32s
[21:17:58.243] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:10:0)
[21:17:58.274] Build status: STARTED
[21:17:58.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:11:0) after 1m42s
[21:19:40.490] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:11:0)
[21:19:40.513] Build status: STARTED
[21:19:40.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:12:0) after 2m52s
[21:22:32.538] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:12:0)
[21:22:32.557] Build status: STARTED
[21:22:32.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:13:0) after 7m11s
[21:29:43.751] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:13:0)
[21:29:43.770] Build status: STARTED
[21:29:43.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:14:0) after 2m49s
[21:32:32.944] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:14:0)
[21:32:33.072] Build status: STARTED
[21:32:33.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:15:0) after 3m48s
[21:36:21.090] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:15:0)
[21:36:21.110] Build status: STARTED
[21:36:21.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:16:0) after 4m52s
[21:41:13.127] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:16:0)
[21:41:13.146] Build status: STARTED
[21:41:13.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:17:0) after 7m46s
[21:48:59.162] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:17:0)
[21:48:59.206] Build status: STARTED
[21:48:59.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:18:0) after 3m54s
[21:52:53.221] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:18:0)
[21:52:53.261] Build status: STARTED
[21:52:53.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:19:0) after 7m21s
[22:00:14.277] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:19:0)
[22:00:14.300] Build status: STARTED
[22:00:14.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:20:0) after 2m18s
[22:02:32.315] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:20:0)
[22:02:32.334] Build status: STARTED
[22:02:32.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:21:0) after 2m39s
[22:05:11.359] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:21:0)
[22:05:11.380] Build status: STARTED
[22:05:11.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:22:0) after 9m53s
[22:15:04.405] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:22:0)
[22:15:04.445] Build status: STARTED
[22:15:04.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:23:0) after 2m14s
[22:17:18.504] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:23:0)
[22:17:18.525] Build status: STARTED
[22:17:18.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:24:0) after 3m41s
[22:20:59.845] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:24:0)
[22:20:59.881] Build status: STARTED
[22:20:59.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:25:0) after 4m12s
[22:25:11.902] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:25:0)
[22:25:11.928] Build status: STARTED
[22:25:11.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:26:0) after 9m47s
[22:34:59.002] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:26:0)
[22:34:59.024] Build status: STARTED
[22:34:59.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:27:0) after 6m9s
[22:41:08.349] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:27:0)
[22:41:08.370] Build status: STARTED
[22:41:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:28:0) after 7m21s
[22:48:29.389] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:28:0)
[22:48:29.407] Build status: STARTED
[22:48:29.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:29:0) after 6m26s
[22:54:55.546] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:29:0)
[22:54:55.566] Build status: STARTED
[22:54:55.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:30:0) after 4m37s
[22:59:32.582] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:30:0)
[22:59:32.601] Build status: STARTED
[22:59:32.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:31:0) after 5m22s
[23:04:54.623] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:31:0)
[23:04:54.646] Build status: STARTED
[23:04:54.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:32:0) after 1m43s
[23:06:37.666] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:32:0)
[23:06:37.705] Build status: STARTED
[23:06:37.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:33:0) after 8m5s
[23:14:42.737] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:33:0)
[23:14:42.760] Build status: STARTED
[23:14:42.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:34:0) after 8m27s
[23:23:09.778] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:34:0)
[23:23:09.797] Build status: STARTED
[23:23:09.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:35:0) after 4m3s
[23:27:12.929] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:35:0)
[23:27:12.950] Build status: STARTED
[23:27:12.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:36:0) after 1m24s
[23:28:37.260] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:36:0)
[23:28:37.285] Build status: STARTED
[23:28:37.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:37:0) after 8m9s
[23:36:46.305] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:37:0)
[23:36:46.329] Build status: STARTED
[23:36:46.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:38:0) after 8m18s
[23:45:04.354] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:38:0)
[23:45:04.390] Build status: STARTED
[23:45:04.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:39:0) after 6m54s
[23:51:58.460] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:39:0)
[23:51:58.480] Build status: STARTED
[23:51:58.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:40:0) after 4m47s
[23:56:45.703] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:40:0)
[23:56:45.726] Build status: STARTED
[23:56:45.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:41:0) after 6m29s
[00:03:14.756] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:41:0)
[00:03:14.791] Build status: STARTED
[00:03:14.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:42:0) after 8m20s
[00:11:34.929] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:42:0)
[00:11:34.948] Build status: STARTED
[00:11:34.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:43:0) after 4m4s
[00:15:38.969] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:43:0)
[00:15:38.997] Build status: STARTED
[00:15:38.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:44:0) after 2m29s
[00:18:07.971] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:44:0)
[00:18:07.993] Build status: STARTED
[00:18:07.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:45:0) after 3m53s
[00:22:01.128] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:45:0)
[00:22:01.152] Build status: STARTED
[00:22:01.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:46:0) after 1m40s
[00:23:41.170] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:46:0)
[00:23:41.244] Build status: STARTED
[00:23:41.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:47:0) after 4m52s
[00:28:33.273] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:47:0)
[00:28:33.294] Build status: STARTED
[00:28:33.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:48:0) after 4m34s
[00:33:07.334] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:48:0)
[00:33:07.354] Build status: STARTED
[00:33:07.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:49:0) after 6m35s
[00:39:42.351] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:49:0)
[00:39:42.376] Build status: STARTED
[00:39:42.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:50:0) after 1m3s
[00:40:45.353] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:50:0)
[00:40:45.375] Build status: STARTED
[00:40:45.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:51:0) after 7m53s
[00:48:38.396] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:51:0)
[00:48:38.417] Build status: STARTED
[00:48:38.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:52:0) after 5m52s
[00:54:30.448] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:52:0)
[00:54:30.466] Build status: STARTED
[00:54:30.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:53:0) after 8m44s
[01:03:14.508] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:53:0)
[01:03:14.535] Build status: STARTED
[01:03:14.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:54:0) after 9m8s
[01:12:22.827] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:54:0)
[01:12:22.846] Build status: STARTED
[01:12:22.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:55:0) after 4m57s
[01:17:19.828] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:55:0)
[01:17:19.854] Build status: STARTED
[01:17:19.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:56:0) after 2m56s
[01:20:15.884] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:56:0)
[01:20:15.913] Build status: STARTED
[01:20:15.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:57:0) after 2m7s
[01:22:23.069] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:57:0)
[01:22:23.096] Build status: STARTED
[01:22:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:58:0) after 9m48s
[01:32:11.196] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:58:0)
[01:32:11.220] Build status: STARTED
[01:32:11.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:59:0) after 9m52s
[01:42:03.398] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:59:0)
[01:42:03.420] Build status: STARTED
[01:42:03.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:60:0) after 6m1s
[01:48:04.534] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:60:0)
[01:48:04.554] Build status: STARTED
[01:48:04.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:61:0) after 3m17s
[01:51:21.649] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:61:0)
[01:51:21.683] Build status: STARTED
[01:51:21.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:62:0) after 5m6s
[01:56:27.708] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:62:0)
[01:56:27.790] Build status: STARTED
[01:56:27.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:63:0) after 8m53s
[02:05:20.919] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:63:0)
[02:05:20.943] Build status: STARTED
[02:05:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:64:0) after 9m1s
[02:14:22.719] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:64:0)
[02:14:22.752] Build status: STARTED
[02:14:22.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:65:0) after 3m52s
[02:18:15.146] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:65:0)
[02:18:15.168] Build status: STARTED
[02:18:15.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:66:0) after 2m40s
[02:20:55.185] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:66:0)
[02:20:55.203] Build status: STARTED
[02:20:55.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:67:0) after 6m51s
[02:27:46.428] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:67:0)
[02:27:46.448] Build status: STARTED
[02:27:46.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:68:0) after 6m32s
[02:34:18.469] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:68:0)
[02:34:18.493] Build status: STARTED
[02:34:18.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:69:0) after 3m3s
[02:37:21.559] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:69:0)
[02:37:21.582] Build status: STARTED
[02:37:21.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:70:0) after 8m43s
[02:46:04.687] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:70:0)
[02:46:04.842] Build status: STARTED
[02:46:04.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:71:0) after 6m59s
[02:53:04.027] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:71:0)
[02:53:04.101] Build status: STARTED
[02:53:04.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:72:0) after 6m16s
[02:59:20.131] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:72:0)
[02:59:20.150] Build status: STARTED
[02:59:20.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:73:0) after 5m6s
[03:04:26.316] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:73:0)
[03:04:26.335] Build status: STARTED
[03:04:26.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:74:0) after 6m45s
[03:11:11.354] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:74:0)
[03:11:11.373] Build status: STARTED
[03:11:11.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:75:0) after 2m57s
[03:14:08.381] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:75:0)
[03:14:08.401] Build status: STARTED
[03:14:08.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:76:0) after 3m59s
[03:18:07.541] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:76:0)
[03:18:07.566] Build status: STARTED
[03:18:07.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:77:0) after 3m15s
[03:21:22.665] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:77:0)
[03:21:22.688] Build status: STARTED
[03:21:22.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:78:0) after 2m15s
[03:23:37.712] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:78:0)
[03:23:37.747] Build status: STARTED
[03:23:37.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:79:0) after 9m23s
[03:33:00.943] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:79:0)
[03:33:00.966] Build status: STARTED
[03:33:00.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:80:0) after 4m2s
[03:37:03.005] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:80:0)
[03:37:03.027] Build status: STARTED
[03:37:03.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:81:0) after 5m9s
[03:42:12.205] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:81:0)
[03:42:12.226] Build status: STARTED
[03:42:12.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:82:0) after 1m46s
[03:43:58.244] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:82:0)
[03:43:58.271] Build status: STARTED
[03:43:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:83:0) after 1m21s
[03:45:19.404] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:83:0)
[03:45:19.424] Build status: STARTED
[03:45:19.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:84:0) after 5m6s
[03:50:25.439] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:84:0)
[03:50:25.470] Build status: STARTED
[03:50:25.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:85:0) after 4m52s
[03:55:17.520] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:85:0)
[03:55:17.566] Build status: STARTED
[03:55:17.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:86:0) after 6m9s
[04:01:26.598] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:86:0)
[04:01:26.623] Build status: STARTED
[04:01:26.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:87:0) after 4m1s
[04:05:27.714] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:87:0)
[04:05:27.732] Build status: STARTED
[04:05:27.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:88:0) after 3m12s
[04:08:39.760] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:88:0)
[04:08:39.783] Build status: STARTED
[04:08:39.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:89:0) after 2m55s
[04:11:34.803] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:89:0)
[04:11:34.823] Build status: STARTED
[04:11:34.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:90:0) after 1m1s
[04:12:35.862] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:90:0)
[04:12:35.886] Build status: STARTED
[04:12:35.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:91:0) after 9m7s
[04:21:42.913] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:91:0)
[04:21:42.934] Build status: STARTED
[04:21:42.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:92:0) after 9m18s
[04:31:00.964] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:92:0)
[04:31:00.986] Build status: STARTED
[04:31:00.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:93:0) after 6m15s
[04:37:16.013] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:93:0)
[04:37:16.036] Build status: STARTED
[04:37:16.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:94:0) after 2m33s
[04:39:49.052] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:94:0)
[04:39:49.081] Build status: STARTED
[04:39:49.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:95:0) after 1m26s
[04:41:15.099] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:95:0)
[04:41:15.117] Build status: STARTED
[04:41:15.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:96:0) after 6m50s
[04:48:05.135] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:96:0)
[04:48:05.156] Build status: STARTED
[04:48:05.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:97:0) after 4m41s
[04:52:46.249] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:97:0)
[04:52:46.272] Build status: STARTED
[04:52:46.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:98:0) after 9m50s
[05:02:36.293] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:98:0)
[05:02:36.317] Build status: STARTED
[05:02:36.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:99:0) after 2m1s
[05:04:37.554] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:99:0)
[05:04:37.575] Build status: STARTED
[05:04:37.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:100:0) after 1m26s
[05:06:03.595] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:100:0)
[05:06:03.615] Build status: STARTED
[05:06:03.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:101:0) after 6m41s
[05:12:44.648] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:101:0)
[05:12:44.667] Build status: STARTED
[05:12:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:102:0) after 2m21s
[05:15:05.695] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:102:0)
[05:15:05.715] Build status: STARTED
[05:15:05.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:103:0) after 6m23s
[05:21:28.742] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:103:0)
[05:21:28.764] Build status: STARTED
[05:21:28.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:104:0) after 5m15s
[05:26:44.028] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:104:0)
[05:26:44.052] Build status: STARTED
[05:26:44.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:105:0) after 5m36s
[05:32:20.226] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:105:0)
[05:32:20.252] Build status: STARTED
[05:32:20.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:106:0) after 8m33s
[05:40:53.270] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:106:0)
[05:40:53.288] Build status: STARTED
[05:40:53.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:107:0) after 2m17s
[05:43:10.337] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:107:0)
[05:43:10.369] Build status: STARTED
[05:43:10.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:108:0) after 7m33s
[05:50:43.391] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:108:0)
[05:50:43.414] Build status: STARTED
[05:50:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:109:0) after 2m1s
[05:52:44.528] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:109:0)
[05:52:44.553] Build status: STARTED
[05:52:44.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:110:0) after 8m1s
[06:00:45.632] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:110:0)
[06:00:45.654] Build status: STARTED
[06:00:45.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:111:0) after 9m20s
[06:10:05.711] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:111:0)
[06:10:05.735] Build status: STARTED
[06:10:05.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:112:0) after 8m54s
[06:18:59.969] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:112:0)
[06:18:59.991] Build status: STARTED
[06:18:59.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:113:0) after 2m32s
[06:21:32.010] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:113:0)
[06:21:32.039] Build status: STARTED
[06:21:32.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:114:0) after 1m42s
[06:23:14.064] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:114:0)
[06:23:14.092] Build status: STARTED
[06:23:14.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:115:0) after 8m9s
[06:31:23.224] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:115:0)
[06:31:23.321] Build status: STARTED
[06:31:23.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:116:0) after 5m42s
[06:37:05.373] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:116:0)
[06:37:05.399] Build status: STARTED
[06:37:05.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:117:0) after 9m23s
[06:46:28.459] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:117:0)
[06:46:28.544] Build status: STARTED
[06:46:28.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:118:0) after 6m59s
[06:53:27.747] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:118:0)
[06:53:27.788] Build status: STARTED
[06:53:27.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8952861815104536080:119:0) after 9m10s
[06:54:08.609] Received PubSub notification, asking Buildbucket for the build status
[06:54:08.629] Build:
{
"id": "8787431752892996673",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 4460,
"createdBy": "project:chromium",
"createTime": "2023-03-05T20:44:12.301081840Z",
"startTime": "2023-03-05T20:44:25.396076Z",
"endTime": "2023-03-06T06:54:08.142195962Z",
"updateTime": "2023-03-06T06:54:08.142195962Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5d669c2b78280c122592434664ef5aec695678e",
"ref": "refs/heads/main"
}
}
}
[06:54:08.629] Invocation finished in 10h9m57.821296509s with status SUCCEEDED