[12:06:10.626] New invocation is queued and will start shortly
[12:06:11.789] Starting the invocation (attempt 1)
[12:06:11.816] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e8632e21c359856c42f8af92c3b9c272ed29f9f"
[12:06:11.816] Popped gitiles commit info from properties and tags
[12:06:11.816] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:06:11.816] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:06:11.816] Buildbucket request:
{
"requestId": "8936949338965792960",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxUBSanVptr"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8632e21c359856c42f8af92c3b9c272ed29f9f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936949338965792960"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTLinuxUBSanVptr"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:06:12.716] Scheduled build:
{
"id": "8771519276932606017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxUBSanVptr"
},
"number": 24288,
"createdBy": "project:chromium",
"createTime": "2023-08-28T12:06:11.935631141Z",
"updateTime": "2023-08-28T12:06:11.935631141Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8632e21c359856c42f8af92c3b9c272ed29f9f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:06:12.716] Task URL: https://cr-buildbucket.appspot.com/build/8771519276932606017
[12:06:12.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:2:0) after 3m23s
[12:06:13.683] Received PubSub notification, asking Buildbucket for the build status
[12:06:13.698] Build status: SCHEDULED
[12:08:03.782] Received PubSub notification, asking Buildbucket for the build status
[12:08:03.824] Build status: STARTED
[12:09:35.717] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:2:0)
[12:09:35.759] Build status: STARTED
[12:09:35.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:5:0) after 2m10s
[12:11:45.800] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:5:0)
[12:11:45.824] Build status: STARTED
[12:11:45.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:6:0) after 2m7s
[12:13:52.940] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:6:0)
[12:13:52.958] Build status: STARTED
[12:13:52.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:7:0) after 3m29s
[12:17:22.476] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:7:0)
[12:17:22.517] Build status: STARTED
[12:17:22.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:8:0) after 8m24s
[12:25:46.722] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:8:0)
[12:25:46.803] Build status: STARTED
[12:25:46.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:9:0) after 2m59s
[12:28:45.879] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:9:0)
[12:28:45.899] Build status: STARTED
[12:28:45.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:10:0) after 5m24s
[12:34:09.914] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:10:0)
[12:34:09.937] Build status: STARTED
[12:34:09.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:11:0) after 1m6s
[12:35:15.998] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:11:0)
[12:35:16.018] Build status: STARTED
[12:35:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:12:0) after 5m29s
[12:40:45.039] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:12:0)
[12:40:45.065] Build status: STARTED
[12:40:45.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:13:0) after 4m33s
[12:45:18.084] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:13:0)
[12:45:18.112] Build status: STARTED
[12:45:18.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:14:0) after 2m29s
[12:47:47.330] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:14:0)
[12:47:47.350] Build status: STARTED
[12:47:47.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:15:0) after 9m41s
[12:57:28.854] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:15:0)
[12:57:28.877] Build status: STARTED
[12:57:28.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:16:0) after 5m16s
[13:02:45.244] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:16:0)
[13:02:45.279] Build status: STARTED
[13:02:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:17:0) after 4m55s
[13:07:40.311] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:17:0)
[13:07:40.336] Build status: STARTED
[13:07:40.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:18:0) after 9m53s
[13:17:33.343] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:18:0)
[13:17:33.362] Build status: STARTED
[13:17:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:19:0) after 4m42s
[13:22:15.497] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:19:0)
[13:22:15.522] Build status: STARTED
[13:22:15.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:20:0) after 9m13s
[13:31:28.644] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:20:0)
[13:31:28.667] Build status: STARTED
[13:31:28.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:21:0) after 6m10s
[13:37:38.682] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:21:0)
[13:37:38.709] Build status: STARTED
[13:37:38.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:22:0) after 3m56s
[13:41:34.724] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:22:0)
[13:41:34.743] Build status: STARTED
[13:41:34.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:23:0) after 8m45s
[13:50:19.931] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:23:0)
[13:50:20.045] Build status: STARTED
[13:50:20.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:24:0) after 8m19s
[13:58:39.170] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:24:0)
[13:58:39.196] Build status: STARTED
[13:58:39.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:25:0) after 6m35s
[14:05:14.319] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:25:0)
[14:05:14.385] Build status: STARTED
[14:05:14.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:26:0) after 1m6s
[14:06:20.931] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:26:0)
[14:06:20.948] Build status: STARTED
[14:06:20.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:27:0) after 9m20s
[14:15:41.107] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:27:0)
[14:15:41.133] Build status: STARTED
[14:15:41.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:28:0) after 6m8s
[14:21:49.262] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:28:0)
[14:21:49.358] Build status: STARTED
[14:21:49.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:29:0) after 3m58s
[14:25:47.372] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:29:0)
[14:25:47.391] Build status: STARTED
[14:25:47.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:30:0) after 1m35s
[14:27:22.545] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:30:0)
[14:27:22.577] Build status: STARTED
[14:27:22.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:31:0) after 4m21s
[14:31:43.611] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:31:0)
[14:31:43.628] Build status: STARTED
[14:31:43.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:32:0) after 2m1s
[14:33:44.959] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:32:0)
[14:33:44.988] Build status: STARTED
[14:33:44.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:33:0) after 7m44s
[14:41:29.012] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:33:0)
[14:41:29.052] Build status: STARTED
[14:41:29.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:34:0) after 7m9s
[14:48:38.151] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:34:0)
[14:48:38.170] Build status: STARTED
[14:48:38.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:35:0) after 7m9s
[14:55:47.462] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:35:0)
[14:55:47.510] Build status: STARTED
[14:55:47.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:36:0) after 3m16s
[14:59:03.631] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:36:0)
[14:59:03.660] Build status: STARTED
[14:59:03.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:37:0) after 4m28s
[15:03:31.837] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:37:0)
[15:03:31.860] Build status: STARTED
[15:03:31.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:38:0) after 2m4s
[15:05:36.166] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:38:0)
[15:05:36.189] Build status: STARTED
[15:05:36.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:39:0) after 2m29s
[15:08:05.376] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:39:0)
[15:08:05.416] Build status: STARTED
[15:08:05.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:40:0) after 3m27s
[15:11:32.428] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:40:0)
[15:11:32.478] Build status: STARTED
[15:11:32.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:41:0) after 8m11s
[15:19:43.494] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:41:0)
[15:19:43.512] Build status: STARTED
[15:19:43.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:42:0) after 4m51s
[15:24:34.592] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:42:0)
[15:24:34.609] Build status: STARTED
[15:24:34.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:43:0) after 3m57s
[15:28:31.625] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:43:0)
[15:28:31.644] Build status: STARTED
[15:28:31.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:44:0) after 6m13s
[15:34:44.659] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:44:0)
[15:34:44.679] Build status: STARTED
[15:34:44.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:45:0) after 2m47s
[15:37:31.697] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:45:0)
[15:37:31.719] Build status: STARTED
[15:37:31.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:46:0) after 6m53s
[15:44:24.691] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:46:0)
[15:44:24.713] Build status: STARTED
[15:44:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:47:0) after 1m14s
[15:45:39.018] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:47:0)
[15:45:39.041] Build status: STARTED
[15:45:39.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:48:0) after 7m2s
[15:52:41.060] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:48:0)
[15:52:41.084] Build status: STARTED
[15:52:41.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:49:0) after 9m10s
[16:01:51.148] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:49:0)
[16:01:51.222] Build status: STARTED
[16:01:51.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:50:0) after 3m16s
[16:05:07.284] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:50:0)
[16:05:07.309] Build status: STARTED
[16:05:07.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:51:0) after 3m39s
[16:08:46.343] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:51:0)
[16:08:46.416] Build status: STARTED
[16:08:46.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:52:0) after 1m35s
[16:10:21.596] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:52:0)
[16:10:21.636] Build status: STARTED
[16:10:21.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:53:0) after 8m32s
[16:18:53.622] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:53:0)
[16:18:53.638] Build status: STARTED
[16:18:53.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:54:0) after 2m34s
[16:21:27.689] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:54:0)
[16:21:27.706] Build status: STARTED
[16:21:27.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:55:0) after 8m34s
[16:30:02.029] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:55:0)
[16:30:02.054] Build status: STARTED
[16:30:02.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:56:0) after 2m6s
[16:32:08.099] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:56:0)
[16:32:08.116] Build status: STARTED
[16:32:08.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:57:0) after 5m51s
[16:37:59.096] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:57:0)
[16:37:59.128] Build status: STARTED
[16:37:59.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:58:0) after 2m38s
[16:40:37.152] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:58:0)
[16:40:37.178] Build status: STARTED
[16:40:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:59:0) after 4m5s
[16:44:42.333] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:59:0)
[16:44:42.368] Build status: STARTED
[16:44:42.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:60:0) after 2m9s
[16:46:51.434] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:60:0)
[16:46:51.452] Build status: STARTED
[16:46:51.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:61:0) after 2m24s
[16:49:15.475] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:61:0)
[16:49:15.491] Build status: STARTED
[16:49:15.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:62:0) after 3m54s
[16:53:09.527] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:62:0)
[16:53:09.551] Build status: STARTED
[16:53:09.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:63:0) after 3m52s
[16:57:01.688] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:63:0)
[16:57:01.726] Build status: STARTED
[16:57:01.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:64:0) after 9m11s
[17:06:12.786] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:64:0)
[17:06:12.803] Build status: STARTED
[17:06:12.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:65:0) after 4m14s
[17:10:26.826] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:65:0)
[17:10:26.896] Build status: STARTED
[17:10:26.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:66:0) after 8m47s
[17:19:13.916] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:66:0)
[17:19:13.961] Build status: STARTED
[17:19:13.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:67:0) after 2m54s
[17:22:07.983] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:67:0)
[17:22:08.078] Build status: STARTED
[17:22:08.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:68:0) after 6m57s
[17:29:05.215] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:68:0)
[17:29:05.244] Build status: STARTED
[17:29:05.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:69:0) after 7m0s
[17:36:05.293] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:69:0)
[17:36:05.345] Build status: STARTED
[17:36:05.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:70:0) after 7m40s
[17:43:45.640] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:70:0)
[17:43:45.680] Build status: STARTED
[17:43:45.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:71:0) after 9m30s
[17:53:15.700] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:71:0)
[17:53:15.730] Build status: STARTED
[17:53:15.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:72:0) after 7m10s
[18:00:26.320] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:72:0)
[18:00:26.380] Build status: STARTED
[18:00:26.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:73:0) after 9m50s
[18:10:16.990] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:73:0)
[18:10:17.012] Build status: STARTED
[18:10:17.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:74:0) after 5m46s
[18:16:03.056] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:74:0)
[18:16:03.090] Build status: STARTED
[18:16:03.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:75:0) after 8m2s
[18:24:05.417] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:75:0)
[18:24:05.458] Build status: STARTED
[18:24:05.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:76:0) after 4m0s
[18:28:05.806] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:76:0)
[18:28:05.829] Build status: STARTED
[18:28:05.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:77:0) after 9m6s
[18:37:11.858] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:77:0)
[18:37:11.879] Build status: STARTED
[18:37:11.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:78:0) after 6m11s
[18:43:22.921] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:78:0)
[18:43:22.965] Build status: STARTED
[18:43:22.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:79:0) after 1m7s
[18:44:29.980] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:79:0)
[18:44:30.004] Build status: STARTED
[18:44:30.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:80:0) after 4m43s
[18:49:13.022] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:80:0)
[18:49:13.044] Build status: STARTED
[18:49:13.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:81:0) after 6m36s
[18:55:49.069] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:81:0)
[18:55:49.090] Build status: STARTED
[18:55:49.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:82:0) after 6m43s
[19:02:32.146] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:82:0)
[19:02:32.296] Build status: STARTED
[19:02:32.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:83:0) after 7m20s
[19:09:52.315] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:83:0)
[19:09:52.334] Build status: STARTED
[19:09:52.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:84:0) after 5m50s
[19:15:42.833] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:84:0)
[19:15:42.945] Build status: STARTED
[19:15:42.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:85:0) after 3m27s
[19:19:10.048] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:85:0)
[19:19:10.148] Build status: STARTED
[19:19:10.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:86:0) after 2m14s
[19:21:24.170] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:86:0)
[19:21:24.189] Build status: STARTED
[19:21:24.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:87:0) after 3m10s
[19:24:34.297] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:87:0)
[19:24:34.320] Build status: STARTED
[19:24:34.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:88:0) after 2m27s
[19:27:01.542] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:88:0)
[19:27:01.562] Build status: STARTED
[19:27:01.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:89:0) after 8m16s
[19:35:17.593] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:89:0)
[19:35:17.612] Build status: STARTED
[19:35:17.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:90:0) after 3m9s
[19:38:26.629] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:90:0)
[19:38:26.672] Build status: STARTED
[19:38:26.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:91:0) after 9m1s
[19:47:27.699] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:91:0)
[19:47:27.715] Build status: STARTED
[19:47:27.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:92:0) after 4m47s
[19:52:14.765] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:92:0)
[19:52:14.785] Build status: STARTED
[19:52:14.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:93:0) after 1m10s
[19:53:24.965] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:93:0)
[19:53:25.027] Build status: STARTED
[19:53:25.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:94:0) after 4m38s
[19:58:03.482] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:94:0)
[19:58:03.545] Build status: STARTED
[19:58:03.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:95:0) after 4m30s
[20:02:34.189] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:95:0)
[20:02:34.208] Build status: STARTED
[20:02:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:96:0) after 8m9s
[20:10:43.266] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:96:0)
[20:10:43.346] Build status: STARTED
[20:10:43.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:97:0) after 6m25s
[20:17:08.680] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:97:0)
[20:17:08.699] Build status: STARTED
[20:17:08.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:98:0) after 5m44s
[20:22:52.724] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:98:0)
[20:22:52.745] Build status: STARTED
[20:22:52.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:99:0) after 4m5s
[20:26:57.812] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:99:0)
[20:26:57.860] Build status: STARTED
[20:26:57.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:100:0) after 7m25s
[20:34:22.877] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:100:0)
[20:34:22.896] Build status: STARTED
[20:34:22.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:101:0) after 2m29s
[20:36:51.925] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:101:0)
[20:36:51.945] Build status: STARTED
[20:36:51.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:102:0) after 8m4s
[20:44:55.970] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:102:0)
[20:44:55.989] Build status: STARTED
[20:44:55.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:103:0) after 5m51s
[20:50:47.217] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:103:0)
[20:50:47.284] Build status: STARTED
[20:50:47.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:104:0) after 6m19s
[20:57:06.490] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:104:0)
[20:57:06.507] Build status: STARTED
[20:57:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:105:0) after 3m56s
[21:01:02.528] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:105:0)
[21:01:02.589] Build status: STARTED
[21:01:02.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:106:0) after 5m18s
[21:06:20.608] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:106:0)
[21:06:20.633] Build status: STARTED
[21:06:20.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxUBSanVptr:8936949338965792960:107:0) after 8m44s
[21:11:00.528] Received PubSub notification, asking Buildbucket for the build status
[21:11:00.589] Build:
{
"id": "8771519276932606017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTLinuxUBSanVptr"
},
"number": 24288,
"createdBy": "project:chromium",
"createTime": "2023-08-28T12:06:11.935631141Z",
"startTime": "2023-08-28T12:08:03.183639Z",
"endTime": "2023-08-28T21:11:00.299371325Z",
"updateTime": "2023-08-28T21:11:00.299371325Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8632e21c359856c42f8af92c3b9c272ed29f9f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:11:00.589] Invocation finished in 9h4m49.977361919s with status SUCCEEDED