[01:07:55.619] New invocation is queued and will start shortly
[01:07:58.559] Starting the invocation (attempt 1)
[01:07:58.609] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63c6e5a84b9153dabe76ecd97ccd47b4814506e6"
[01:07:58.609] Popped gitiles commit info from properties and tags
[01:07:58.609] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:07:58.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:07:58.611] Buildbucket request:
{
"requestId": "8985731920406826960",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "63c6e5a84b9153dabe76ecd97ccd47b4814506e6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8985731920406826960"
},
{
"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"
}
}
[01:07:59.109] Scheduled build:
{
"id": "8820301856522544801",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8831,
"createdBy": "project:chromium",
"createTime": "2022-03-08T01:07:58.692612844Z",
"updateTime": "2022-03-08T01:07:58.692612844Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "63c6e5a84b9153dabe76ecd97ccd47b4814506e6",
"ref": "refs/heads/main"
}
}
}
[01:07:59.109] Task URL: https://cr-buildbucket.appspot.com/build/8820301856522544801
[01:07:59.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:2:0) after 9m18s
[01:14:58.254] Received PubSub notification, asking Buildbucket for the build status
[01:14:58.283] Build status: STARTED
[01:17:17.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:2:0)
[01:17:17.317] Build status: STARTED
[01:17:17.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:4:0) after 5m29s
[01:22:46.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:4:0)
[01:22:46.372] Build status: STARTED
[01:22:46.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:5:0) after 6m42s
[01:29:28.670] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:5:0)
[01:29:28.695] Build status: STARTED
[01:29:28.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:6:0) after 2m59s
[01:32:27.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:6:0)
[01:32:27.778] Build status: STARTED
[01:32:27.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:7:0) after 7m34s
[01:40:01.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:7:0)
[01:40:01.835] Build status: STARTED
[01:40:01.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:8:0) after 8m37s
[01:48:38.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:8:0)
[01:48:38.952] Build status: STARTED
[01:48:38.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:9:0) after 3m59s
[01:52:37.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:9:0)
[01:52:38.005] Build status: STARTED
[01:52:38.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:10:0) after 5m18s
[01:57:56.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:10:0)
[01:57:56.401] Build status: STARTED
[01:57:56.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:11:0) after 2m41s
[02:00:37.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:11:0)
[02:00:37.593] Build status: STARTED
[02:00:37.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:12:0) after 5m27s
[02:06:04.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:12:0)
[02:06:04.986] Build status: STARTED
[02:06:04.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:13:0) after 6m18s
[02:12:24.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:13:0)
[02:12:24.119] Build status: STARTED
[02:12:24.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:14:0) after 1m42s
[02:14:06.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:14:0)
[02:14:06.950] Build status: STARTED
[02:14:06.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:15:0) after 1m32s
[02:15:39.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:15:0)
[02:15:39.195] Build status: STARTED
[02:15:39.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:16:0) after 7m12s
[02:22:51.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:16:0)
[02:22:51.499] Build status: STARTED
[02:22:51.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:17:0) after 5m8s
[02:27:59.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:17:0)
[02:27:59.538] Build status: STARTED
[02:27:59.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:18:0) after 6m15s
[02:34:14.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:18:0)
[02:34:14.716] Build status: STARTED
[02:34:14.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:19:0) after 1m49s
[02:36:03.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:19:0)
[02:36:03.773] Build status: STARTED
[02:36:03.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:20:0) after 7m22s
[02:43:25.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:20:0)
[02:43:25.825] Build status: STARTED
[02:43:25.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:21:0) after 3m4s
[02:46:29.902] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:21:0)
[02:46:29.999] Build status: STARTED
[02:46:29.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:22:0) after 4m15s
[02:50:45.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:22:0)
[02:50:45.056] Build status: STARTED
[02:50:45.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:23:0) after 3m49s
[02:54:34.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:23:0)
[02:54:34.139] Build status: STARTED
[02:54:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:24:0) after 2m19s
[02:56:53.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:24:0)
[02:56:53.292] Build status: STARTED
[02:56:53.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:25:0) after 9m12s
[03:06:05.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:25:0)
[03:06:05.594] Build status: STARTED
[03:06:05.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:26:0) after 1m59s
[03:08:04.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:26:0)
[03:08:04.796] Build status: STARTED
[03:08:04.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:27:0) after 5m29s
[03:13:33.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:27:0)
[03:13:34.005] Build status: STARTED
[03:13:34.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:28:0) after 3m22s
[03:16:56.227] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:28:0)
[03:16:56.246] Build status: STARTED
[03:16:56.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:29:0) after 1m55s
[03:18:51.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:29:0)
[03:18:51.632] Build status: STARTED
[03:18:51.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:30:0) after 6m51s
[03:25:42.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:30:0)
[03:25:42.798] Build status: STARTED
[03:25:42.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:31:0) after 9m56s
[03:35:38.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:31:0)
[03:35:38.890] Build status: STARTED
[03:35:38.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:32:0) after 7m54s
[03:43:32.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:32:0)
[03:43:33.043] Build status: STARTED
[03:43:33.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:33:0) after 7m29s
[03:51:02.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:33:0)
[03:51:02.211] Build status: STARTED
[03:51:02.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:34:0) after 4m24s
[03:55:26.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:34:0)
[03:55:26.332] Build status: STARTED
[03:55:26.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:35:0) after 3m14s
[03:58:40.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:35:0)
[03:58:40.423] Build status: STARTED
[03:58:40.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:36:0) after 3m9s
[04:01:49.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:36:0)
[04:01:49.816] Build status: STARTED
[04:01:49.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:37:0) after 5m18s
[04:07:07.849] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:37:0)
[04:07:07.872] Build status: STARTED
[04:07:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:38:0) after 7m43s
[04:14:51.003] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:38:0)
[04:14:51.036] Build status: STARTED
[04:14:51.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:39:0) after 5m36s
[04:20:27.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:39:0)
[04:20:27.292] Build status: STARTED
[04:20:27.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:40:0) after 7m37s
[04:28:04.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:40:0)
[04:28:04.962] Build status: STARTED
[04:28:04.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:41:0) after 1m41s
[04:29:46.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:41:0)
[04:29:46.221] Build status: STARTED
[04:29:46.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:42:0) after 6m18s
[04:36:04.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:42:0)
[04:36:04.401] Build status: STARTED
[04:36:04.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:43:0) after 2m27s
[04:38:31.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:43:0)
[04:38:31.475] Build status: STARTED
[04:38:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:44:0) after 2m48s
[04:41:19.610] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:44:0)
[04:41:19.661] Build status: STARTED
[04:41:19.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:45:0) after 5m44s
[04:47:03.740] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:45:0)
[04:47:03.771] Build status: STARTED
[04:47:03.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:46:0) after 8m53s
[04:55:58.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:46:0)
[04:55:58.525] Build status: STARTED
[04:55:58.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:47:0) after 7m50s
[05:03:48.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:47:0)
[05:03:48.720] Build status: STARTED
[05:03:48.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:48:0) after 4m6s
[05:07:54.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:48:0)
[05:07:54.771] Build status: STARTED
[05:07:54.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:49:0) after 6m14s
[05:14:08.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:49:0)
[05:14:08.843] Build status: STARTED
[05:14:08.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:50:0) after 9m25s
[05:23:33.883] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:50:0)
[05:23:33.947] Build status: STARTED
[05:23:33.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:51:0) after 8m13s
[05:31:47.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:51:0)
[05:31:47.058] Build status: STARTED
[05:31:47.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:52:0) after 1m14s
[05:33:01.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:52:0)
[05:33:01.211] Build status: STARTED
[05:33:01.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:53:0) after 6m0s
[05:39:01.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:53:0)
[05:39:01.404] Build status: STARTED
[05:39:01.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:54:0) after 8m55s
[05:47:56.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:54:0)
[05:47:56.472] Build status: STARTED
[05:47:56.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:55:0) after 5m1s
[05:52:57.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:55:0)
[05:52:57.539] Build status: STARTED
[05:52:57.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:56:0) after 4m29s
[05:57:26.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:56:0)
[05:57:26.796] Build status: STARTED
[05:57:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:57:0) after 1m36s
[05:59:02.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:57:0)
[05:59:02.843] Build status: STARTED
[05:59:02.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:58:0) after 6m42s
[06:05:44.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:58:0)
[06:05:44.984] Build status: STARTED
[06:05:44.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:59:0) after 6m19s
[06:12:04.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:59:0)
[06:12:04.187] Build status: STARTED
[06:12:04.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:60:0) after 9m34s
[06:21:38.222] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:60:0)
[06:21:38.247] Build status: STARTED
[06:21:38.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:61:0) after 4m52s
[06:26:30.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:61:0)
[06:26:30.569] Build status: STARTED
[06:26:30.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:62:0) after 2m49s
[06:29:19.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:62:0)
[06:29:19.614] Build status: STARTED
[06:29:19.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:63:0) after 7m49s
[06:37:08.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:63:0)
[06:37:08.684] Build status: STARTED
[06:37:08.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:64:0) after 8m57s
[06:46:05.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:64:0)
[06:46:05.791] Build status: STARTED
[06:46:05.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:65:0) after 3m48s
[06:49:53.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:65:0)
[06:49:53.845] Build status: STARTED
[06:49:53.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:66:0) after 3m34s
[06:53:28.046] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:66:0)
[06:53:28.081] Build status: STARTED
[06:53:28.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:67:0) after 7m22s
[07:00:50.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:67:0)
[07:00:50.214] Build status: STARTED
[07:00:50.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:68:0) after 3m37s
[07:04:27.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:68:0)
[07:04:27.295] Build status: STARTED
[07:04:27.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:69:0) after 6m49s
[07:11:16.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:69:0)
[07:11:16.428] Build status: STARTED
[07:11:16.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:70:0) after 7m44s
[07:19:00.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:70:0)
[07:19:00.522] Build status: STARTED
[07:19:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:71:0) after 7m19s
[07:26:19.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:71:0)
[07:26:19.680] Build status: STARTED
[07:26:19.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:72:0) after 8m53s
[07:35:12.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:72:0)
[07:35:12.732] Build status: STARTED
[07:35:12.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:73:0) after 4m5s
[07:39:17.787] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:73:0)
[07:39:17.811] Build status: STARTED
[07:39:17.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:74:0) after 5m25s
[07:44:42.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:74:0)
[07:44:42.869] Build status: STARTED
[07:44:42.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:75:0) after 1m32s
[07:46:14.989] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:75:0)
[07:46:15.026] Build status: STARTED
[07:46:15.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:76:0) after 9m51s
[07:56:06.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:76:0)
[07:56:06.089] Build status: STARTED
[07:56:06.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:77:0) after 9m22s
[08:05:28.117] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:77:0)
[08:05:28.138] Build status: STARTED
[08:05:28.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:78:0) after 9m51s
[08:15:19.169] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:78:0)
[08:15:19.192] Build status: STARTED
[08:15:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:79:0) after 1m24s
[08:16:43.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:79:0)
[08:16:43.206] Build status: STARTED
[08:16:43.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:80:0) after 9m1s
[08:25:44.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:80:0)
[08:25:44.292] Build status: STARTED
[08:25:44.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:81:0) after 8m50s
[08:34:34.326] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:81:0)
[08:34:34.347] Build status: STARTED
[08:34:34.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:82:0) after 3m23s
[08:37:57.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:82:0)
[08:37:57.549] Build status: STARTED
[08:37:57.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:83:0) after 2m54s
[08:40:51.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:83:0)
[08:40:51.620] Build status: STARTED
[08:40:51.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:84:0) after 4m30s
[08:45:21.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:84:0)
[08:45:21.750] Build status: STARTED
[08:45:21.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:85:0) after 6m13s
[08:51:34.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:85:0)
[08:51:34.813] Build status: STARTED
[08:51:34.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:86:0) after 1m12s
[08:52:47.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:86:0)
[08:52:47.068] Build status: STARTED
[08:52:47.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:87:0) after 4m37s
[08:57:24.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:87:0)
[08:57:24.163] Build status: STARTED
[08:57:24.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:88:0) after 4m53s
[09:02:17.294] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:88:0)
[09:02:17.337] Build status: STARTED
[09:02:17.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:89:0) after 9m25s
[09:11:42.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:89:0)
[09:11:42.433] Build status: STARTED
[09:11:42.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:90:0) after 2m25s
[09:14:07.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:90:0)
[09:14:07.508] Build status: STARTED
[09:14:07.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:91:0) after 6m43s
[09:20:50.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:91:0)
[09:20:50.764] Build status: STARTED
[09:20:50.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:92:0) after 9m7s
[09:29:57.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:92:0)
[09:29:57.915] Build status: STARTED
[09:29:57.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:93:0) after 3m39s
[09:33:37.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:93:0)
[09:33:37.142] Build status: STARTED
[09:33:37.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:94:0) after 7m25s
[09:41:02.248] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:94:0)
[09:41:02.287] Build status: STARTED
[09:41:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:95:0) after 1m57s
[09:42:59.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:95:0)
[09:42:59.532] Build status: STARTED
[09:42:59.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:96:0) after 2m6s
[09:45:05.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:96:0)
[09:45:05.604] Build status: STARTED
[09:45:05.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:97:0) after 2m49s
[09:47:54.693] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:97:0)
[09:47:54.715] Build status: STARTED
[09:47:54.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:98:0) after 8m19s
[09:56:13.750] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:98:0)
[09:56:13.789] Build status: STARTED
[09:56:13.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:99:0) after 4m53s
[10:01:07.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:99:0)
[10:01:07.092] Build status: STARTED
[10:01:07.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:100:0) after 1m56s
[10:03:03.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:100:0)
[10:03:03.165] Build status: STARTED
[10:03:03.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:101:0) after 4m8s
[10:07:11.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:101:0)
[10:07:11.261] Build status: STARTED
[10:07:11.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:102:0) after 1m42s
[10:08:53.359] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:102:0)
[10:08:53.395] Build status: STARTED
[10:08:53.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:103:0) after 8m19s
[10:17:12.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:103:0)
[10:17:12.572] Build status: STARTED
[10:17:12.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:104:0) after 3m46s
[10:20:58.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:104:0)
[10:20:58.650] Build status: STARTED
[10:20:58.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:105:0) after 4m9s
[10:25:07.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:105:0)
[10:25:07.676] Build status: STARTED
[10:25:07.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:106:0) after 2m29s
[10:27:36.995] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:106:0)
[10:27:37.016] Build status: STARTED
[10:27:37.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:107:0) after 2m1s
[10:29:38.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:107:0)
[10:29:38.075] Build status: STARTED
[10:29:38.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:108:0) after 2m50s
[10:32:28.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:108:0)
[10:32:28.240] Build status: STARTED
[10:32:28.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:109:0) after 5m8s
[10:37:36.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:109:0)
[10:37:36.421] Build status: STARTED
[10:37:36.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:110:0) after 1m51s
[10:39:27.723] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:110:0)
[10:39:27.748] Build status: STARTED
[10:39:27.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:111:0) after 3m52s
[10:43:19.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:111:0)
[10:43:19.798] Build status: STARTED
[10:43:19.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8985731920406826960:112:0) after 9m52s
[10:44:10.683] Received PubSub notification, asking Buildbucket for the build status
[10:44:10.707] Build:
{
"id": "8820301856522544801",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8831,
"createdBy": "project:chromium",
"createTime": "2022-03-08T01:07:58.692612844Z",
"startTime": "2022-03-08T01:14:57.524229Z",
"endTime": "2022-03-08T10:44:10.276686102Z",
"updateTime": "2022-03-08T10:44:10.276686102Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "63c6e5a84b9153dabe76ecd97ccd47b4814506e6",
"ref": "refs/heads/main"
}
}
}
[10:44:10.707] Invocation finished in 9h36m15.102425999s with status SUCCEEDED