[19:33:48.851] New invocation is queued and will start shortly
[19:33:49.974] Starting the invocation (attempt 1)
[19:33:50.012] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2814309be80d03fa256981e0fb8c34b729c4dbb"
[19:33:50.012] Popped gitiles commit info from properties and tags
[19:33:50.012] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:33:50.012] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:33:50.012] Buildbucket request:
{
"requestId": "8955131166329507952",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2814309be80d03fa256981e0fb8c34b729c4dbb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8955131166329507952"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:33:50.521] Scheduled build:
{
"id": "8789701104302019713",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 11190,
"createdBy": "project:chromium",
"createTime": "2023-02-08T19:33:50.147137023Z",
"updateTime": "2023-02-08T19:33:50.147137023Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2814309be80d03fa256981e0fb8c34b729c4dbb",
"ref": "refs/heads/main"
}
}
}
[19:33:50.521] Task URL: https://cr-buildbucket.appspot.com/build/8789701104302019713
[19:33:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:2:0) after 3m40s
[19:37:30.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:2:0)
[19:37:30.903] Build status: SCHEDULED
[19:37:30.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:3:0) after 7m4s
[19:44:34.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:3:0)
[19:44:34.965] Build status: SCHEDULED
[19:44:34.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:4:0) after 1m38s
[19:46:13.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:4:0)
[19:46:13.079] Build status: SCHEDULED
[19:46:13.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:5:0) after 5m57s
[19:52:10.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:5:0)
[19:52:10.161] Build status: SCHEDULED
[19:52:10.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:6:0) after 8m21s
[20:00:31.285] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:6:0)
[20:00:31.309] Build status: SCHEDULED
[20:00:31.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:7:0) after 5m26s
[20:05:57.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:7:0)
[20:05:57.418] Build status: SCHEDULED
[20:05:57.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:8:0) after 3m34s
[20:07:18.628] Received PubSub notification, asking Buildbucket for the build status
[20:07:18.653] Build status: STARTED
[20:09:31.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:8:0)
[20:09:31.514] Build status: STARTED
[20:09:31.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:10:0) after 8m47s
[20:18:19.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:10:0)
[20:18:19.135] Build status: STARTED
[20:18:19.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:11:0) after 5m25s
[20:23:44.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:11:0)
[20:23:44.454] Build status: STARTED
[20:23:44.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:12:0) after 1m51s
[20:25:35.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:12:0)
[20:25:35.747] Build status: STARTED
[20:25:35.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:13:0) after 9m39s
[20:35:14.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:13:0)
[20:35:14.807] Build status: STARTED
[20:35:14.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:14:0) after 4m56s
[20:40:10.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:14:0)
[20:40:10.851] Build status: STARTED
[20:40:10.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:15:0) after 2m37s
[20:42:47.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:15:0)
[20:42:47.904] Build status: STARTED
[20:42:47.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:16:0) after 1m54s
[20:44:41.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:16:0)
[20:44:41.967] Build status: STARTED
[20:44:41.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:17:0) after 9m7s
[20:53:48.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:17:0)
[20:53:49.015] Build status: STARTED
[20:53:49.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:18:0) after 2m22s
[20:56:11.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:18:0)
[20:56:11.083] Build status: STARTED
[20:56:11.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:19:0) after 6m10s
[21:02:21.287] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:19:0)
[21:02:21.310] Build status: STARTED
[21:02:21.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:20:0) after 7m20s
[21:09:41.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:20:0)
[21:09:41.374] Build status: STARTED
[21:09:41.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:21:0) after 4m22s
[21:14:03.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:21:0)
[21:14:03.887] Build status: STARTED
[21:14:03.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:22:0) after 6m22s
[21:20:25.927] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:22:0)
[21:20:25.962] Build status: STARTED
[21:20:25.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:23:0) after 4m58s
[21:25:23.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:23:0)
[21:25:24.037] Build status: STARTED
[21:25:24.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:24:0) after 9m57s
[21:35:21.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:24:0)
[21:35:21.094] Build status: STARTED
[21:35:21.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:25:0) after 2m17s
[21:37:38.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:25:0)
[21:37:38.208] Build status: STARTED
[21:37:38.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:26:0) after 3m32s
[21:41:10.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:26:0)
[21:41:10.257] Build status: STARTED
[21:41:10.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:27:0) after 5m50s
[21:47:00.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:27:0)
[21:47:00.338] Build status: STARTED
[21:47:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:28:0) after 7m22s
[21:54:22.361] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:28:0)
[21:54:22.383] Build status: STARTED
[21:54:22.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:29:0) after 6m42s
[22:01:04.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:29:0)
[22:01:04.435] Build status: STARTED
[22:01:04.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:30:0) after 7m3s
[22:08:07.466] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:30:0)
[22:08:07.490] Build status: STARTED
[22:08:07.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:31:0) after 6m24s
[22:14:31.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:31:0)
[22:14:31.933] Build status: STARTED
[22:14:31.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:32:0) after 8m57s
[22:23:29.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:32:0)
[22:23:29.515] Build status: STARTED
[22:23:29.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:33:0) after 1m45s
[22:25:14.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:33:0)
[22:25:14.569] Build status: STARTED
[22:25:14.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:34:0) after 2m13s
[22:27:27.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:34:0)
[22:27:27.687] Build status: STARTED
[22:27:27.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:35:0) after 5m21s
[22:32:48.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:35:0)
[22:32:48.800] Build status: STARTED
[22:32:48.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:36:0) after 4m25s
[22:37:13.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:36:0)
[22:37:13.907] Build status: STARTED
[22:37:13.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:37:0) after 6m28s
[22:43:42.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:37:0)
[22:43:42.642] Build status: STARTED
[22:43:42.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:38:0) after 7m28s
[22:51:10.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:38:0)
[22:51:10.690] Build status: STARTED
[22:51:10.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:39:0) after 7m45s
[22:58:55.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:39:0)
[22:58:55.808] Build status: STARTED
[22:58:55.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:40:0) after 7m37s
[23:06:32.845] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:40:0)
[23:06:32.871] Build status: STARTED
[23:06:32.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:41:0) after 3m37s
[23:10:09.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:41:0)
[23:10:09.958] Build status: STARTED
[23:10:09.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:42:0) after 9m23s
[23:19:33.082] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:42:0)
[23:19:33.102] Build status: STARTED
[23:19:33.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:43:0) after 2m52s
[23:22:25.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:43:0)
[23:22:25.447] Build status: STARTED
[23:22:25.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:44:0) after 9m33s
[23:31:58.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:44:0)
[23:31:58.569] Build status: STARTED
[23:31:58.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:45:0) after 6m15s
[23:38:13.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:45:0)
[23:38:13.658] Build status: STARTED
[23:38:13.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:46:0) after 9m53s
[23:48:06.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:46:0)
[23:48:06.783] Build status: STARTED
[23:48:06.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:47:0) after 7m14s
[23:55:20.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:47:0)
[23:55:20.851] Build status: STARTED
[23:55:20.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:48:0) after 4m21s
[23:59:41.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:48:0)
[23:59:41.901] Build status: STARTED
[23:59:41.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:49:0) after 7m59s
[00:07:40.943] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:49:0)
[00:07:40.970] Build status: STARTED
[00:07:40.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:50:0) after 3m14s
[00:10:55.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:50:0)
[00:10:55.212] Build status: STARTED
[00:10:55.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:51:0) after 7m28s
[00:18:23.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:51:0)
[00:18:23.261] Build status: STARTED
[00:18:23.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:52:0) after 1m4s
[00:19:27.333] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:52:0)
[00:19:27.407] Build status: STARTED
[00:19:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:53:0) after 8m49s
[00:28:16.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:53:0)
[00:28:16.455] Build status: STARTED
[00:28:16.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:54:0) after 6m17s
[00:34:33.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:54:0)
[00:34:33.514] Build status: STARTED
[00:34:33.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:55:0) after 7m16s
[00:41:49.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:55:0)
[00:41:49.565] Build status: STARTED
[00:41:49.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:56:0) after 4m39s
[00:46:28.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:56:0)
[00:46:28.612] Build status: STARTED
[00:46:28.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:57:0) after 7m2s
[00:53:30.644] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:57:0)
[00:53:30.665] Build status: STARTED
[00:53:30.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:58:0) after 2m21s
[00:55:51.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:58:0)
[00:55:51.738] Build status: STARTED
[00:55:51.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:59:0) after 1m43s
[00:57:34.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:59:0)
[00:57:34.835] Build status: STARTED
[00:57:34.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:60:0) after 1m12s
[00:58:46.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:60:0)
[00:58:46.900] Build status: STARTED
[00:58:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:61:0) after 9m20s
[01:08:06.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:61:0)
[01:08:06.977] Build status: STARTED
[01:08:06.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:62:0) after 2m28s
[01:10:35.008] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:62:0)
[01:10:35.031] Build status: STARTED
[01:10:35.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:63:0) after 3m22s
[01:13:57.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:63:0)
[01:13:57.305] Build status: STARTED
[01:13:57.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:64:0) after 5m53s
[01:19:50.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:64:0)
[01:19:50.427] Build status: STARTED
[01:19:50.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:65:0) after 8m16s
[01:28:06.477] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:65:0)
[01:28:06.500] Build status: STARTED
[01:28:06.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:66:0) after 3m18s
[01:31:24.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:66:0)
[01:31:24.554] Build status: STARTED
[01:31:24.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:67:0) after 2m36s
[01:34:00.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:67:0)
[01:34:00.609] Build status: STARTED
[01:34:00.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:68:0) after 2m10s
[01:36:10.653] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:68:0)
[01:36:10.675] Build status: STARTED
[01:36:10.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:69:0) after 6m26s
[01:42:36.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:69:0)
[01:42:36.938] Build status: STARTED
[01:42:36.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:70:0) after 8m29s
[01:51:05.995] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:70:0)
[01:51:06.018] Build status: STARTED
[01:51:06.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:71:0) after 2m33s
[01:53:39.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:71:0)
[01:53:39.063] Build status: STARTED
[01:53:39.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:72:0) after 3m9s
[01:56:48.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:72:0)
[01:56:48.115] Build status: STARTED
[01:56:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:73:0) after 3m18s
[02:00:06.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:73:0)
[02:00:06.252] Build status: STARTED
[02:00:06.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:74:0) after 9m50s
[02:09:56.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:74:0)
[02:09:56.578] Build status: STARTED
[02:09:56.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:75:0) after 2m0s
[02:11:56.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:75:0)
[02:11:56.802] Build status: STARTED
[02:11:56.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:76:0) after 8m18s
[02:20:14.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:76:0)
[02:20:15.058] Build status: STARTED
[02:20:15.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:77:0) after 3m9s
[02:23:24.248] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:77:0)
[02:23:24.267] Build status: STARTED
[02:23:24.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:78:0) after 5m49s
[02:29:13.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:78:0)
[02:29:13.351] Build status: STARTED
[02:29:13.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:79:0) after 5m6s
[02:34:19.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:79:0)
[02:34:19.570] Build status: STARTED
[02:34:19.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:80:0) after 7m28s
[02:41:47.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:80:0)
[02:41:47.654] Build status: STARTED
[02:41:47.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:81:0) after 4m10s
[02:45:57.632] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:81:0)
[02:45:57.658] Build status: STARTED
[02:45:57.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:82:0) after 1m53s
[02:47:50.729] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:82:0)
[02:47:50.754] Build status: STARTED
[02:47:50.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:83:0) after 2m10s
[02:50:00.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:83:0)
[02:50:00.793] Build status: STARTED
[02:50:00.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:84:0) after 2m55s
[02:52:56.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:84:0)
[02:52:56.121] Build status: STARTED
[02:52:56.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:85:0) after 5m14s
[02:58:10.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:85:0)
[02:58:10.171] Build status: STARTED
[02:58:10.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:86:0) after 6m46s
[03:04:56.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:86:0)
[03:04:56.407] Build status: STARTED
[03:04:56.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:87:0) after 7m25s
[03:12:21.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:87:0)
[03:12:21.479] Build status: STARTED
[03:12:21.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:88:0) after 3m34s
[03:15:55.575] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:88:0)
[03:15:55.596] Build status: STARTED
[03:15:55.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:89:0) after 2m30s
[03:18:25.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:89:0)
[03:18:25.884] Build status: STARTED
[03:18:25.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:90:0) after 4m16s
[03:22:41.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:90:0)
[03:22:41.961] Build status: STARTED
[03:22:41.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:91:0) after 7m1s
[03:29:42.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:91:0)
[03:29:43.167] Build status: STARTED
[03:29:43.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:92:0) after 3m25s
[03:33:08.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:92:0)
[03:33:08.318] Build status: STARTED
[03:33:08.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:93:0) after 2m15s
[03:35:23.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:93:0)
[03:35:23.523] Build status: STARTED
[03:35:23.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:94:0) after 5m46s
[03:41:09.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:94:0)
[03:41:09.583] Build status: STARTED
[03:41:09.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:95:0) after 5m8s
[03:46:17.608] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:95:0)
[03:46:17.630] Build status: STARTED
[03:46:17.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:96:0) after 1m39s
[03:47:56.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:96:0)
[03:47:56.877] Build status: STARTED
[03:47:56.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:97:0) after 6m3s
[03:54:00.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:97:0)
[03:54:00.086] Build status: STARTED
[03:54:00.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:98:0) after 9m20s
[04:03:20.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:98:0)
[04:03:20.153] Build status: STARTED
[04:03:20.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:99:0) after 3m1s
[04:06:21.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:99:0)
[04:06:21.179] Build status: STARTED
[04:06:21.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:100:0) after 8m53s
[04:15:14.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:100:0)
[04:15:14.333] Build status: STARTED
[04:15:14.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:101:0) after 2m7s
[04:17:21.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:101:0)
[04:17:21.414] Build status: STARTED
[04:17:21.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:102:0) after 3m50s
[04:21:12.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:102:0)
[04:21:12.063] Build status: STARTED
[04:21:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:103:0) after 9m29s
[04:30:41.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:103:0)
[04:30:41.121] Build status: STARTED
[04:30:41.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:104:0) after 5m56s
[04:36:37.178] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:104:0)
[04:36:37.202] Build status: STARTED
[04:36:37.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:105:0) after 9m36s
[04:46:13.513] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:105:0)
[04:46:13.535] Build status: STARTED
[04:46:13.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:106:0) after 6m18s
[04:52:31.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:106:0)
[04:52:31.680] Build status: STARTED
[04:52:31.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:107:0) after 8m58s
[05:01:29.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:107:0)
[05:01:29.739] Build status: STARTED
[05:01:29.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:108:0) after 8m26s
[05:09:56.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:108:0)
[05:09:56.034] Build status: STARTED
[05:09:56.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:109:0) after 8m3s
[05:17:59.268] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:109:0)
[05:17:59.303] Build status: STARTED
[05:17:59.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:110:0) after 1m40s
[05:19:39.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:110:0)
[05:19:39.320] Build status: STARTED
[05:19:39.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:111:0) after 5m13s
[05:24:52.589] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:111:0)
[05:24:52.610] Build status: STARTED
[05:24:52.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:112:0) after 2m41s
[05:27:33.734] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:112:0)
[05:27:33.756] Build status: STARTED
[05:27:33.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:113:0) after 4m18s
[05:31:52.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:113:0)
[05:31:52.093] Build status: STARTED
[05:31:52.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:114:0) after 5m47s
[05:37:39.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:114:0)
[05:37:39.327] Build status: STARTED
[05:37:39.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:115:0) after 7m9s
[05:44:48.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:115:0)
[05:44:48.487] Build status: STARTED
[05:44:48.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:116:0) after 6m8s
[05:50:56.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:116:0)
[05:50:56.669] Build status: STARTED
[05:50:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:117:0) after 3m49s
[05:54:45.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:117:0)
[05:54:45.862] Build status: STARTED
[05:54:45.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:118:0) after 3m2s
[05:57:48.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:118:0)
[05:57:48.228] Build status: STARTED
[05:57:48.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:119:0) after 5m5s
[06:02:53.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:119:0)
[06:02:53.427] Build status: STARTED
[06:02:53.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:120:0) after 1m59s
[06:04:52.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:120:0)
[06:04:52.528] Build status: STARTED
[06:04:52.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:121:0) after 8m51s
[06:13:43.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:121:0)
[06:13:43.683] Build status: STARTED
[06:13:43.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:122:0) after 2m25s
[06:16:08.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:122:0)
[06:16:08.729] Build status: STARTED
[06:16:08.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:123:0) after 3m55s
[06:20:03.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:123:0)
[06:20:03.883] Build status: STARTED
[06:20:03.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:124:0) after 7m38s
[06:27:42.373] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:124:0)
[06:27:42.394] Build status: STARTED
[06:27:42.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:125:0) after 4m23s
[06:32:05.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:125:0)
[06:32:05.868] Build status: STARTED
[06:32:05.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:126:0) after 2m25s
[06:34:30.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:126:0)
[06:34:30.958] Build status: STARTED
[06:34:30.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:127:0) after 8m4s
[06:42:34.995] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:127:0)
[06:42:35.053] Build status: STARTED
[06:42:35.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:128:0) after 9m43s
[06:52:18.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:128:0)
[06:52:18.260] Build status: STARTED
[06:52:18.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:129:0) after 6m1s
[06:58:19.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:129:0)
[06:58:19.881] Build status: STARTED
[06:58:19.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:130:0) after 3m28s
[07:01:47.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:130:0)
[07:01:47.933] Build status: STARTED
[07:01:47.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:131:0) after 9m42s
[07:11:30.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:131:0)
[07:11:30.563] Build status: STARTED
[07:11:30.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:132:0) after 3m22s
[07:14:52.816] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:132:0)
[07:14:52.835] Build status: STARTED
[07:14:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:133:0) after 5m49s
[07:20:42.075] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:133:0)
[07:20:42.098] Build status: STARTED
[07:20:42.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:134:0) after 4m33s
[07:25:15.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:134:0)
[07:25:15.394] Build status: STARTED
[07:25:15.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:135:0) after 4m55s
[07:30:10.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:135:0)
[07:30:10.443] Build status: STARTED
[07:30:10.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:136:0) after 3m19s
[07:33:29.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:136:0)
[07:33:29.792] Build status: STARTED
[07:33:29.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8955131166329507952:137:0) after 2m55s
[07:36:06.836] Received PubSub notification, asking Buildbucket for the build status
[07:36:06.859] Build:
{
"id": "8789701104302019713",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 11190,
"createdBy": "project:chromium",
"createTime": "2023-02-08T19:33:50.147137023Z",
"startTime": "2023-02-08T20:07:18.101373Z",
"endTime": "2023-02-09T07:36:06.529179069Z",
"updateTime": "2023-02-09T07:36:06.529179069Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2814309be80d03fa256981e0fb8c34b729c4dbb",
"ref": "refs/heads/main"
}
}
}
[07:36:06.859] Invocation finished in 12h2m18.02970719s with status FAILED