[02:51:56.166] New invocation is queued and will start shortly
[02:51:58.266] Starting the invocation (attempt 1)
[02:51:58.297] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/406295fb1589408d3155020f3529beb67317cd34"
[02:51:58.297] Popped gitiles commit info from properties and tags
[02:51:58.297] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:51:58.297] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:51:58.297] Buildbucket request:
{
"requestId": "8833975457990530720",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win ASan Release"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "406295fb1589408d3155020f3529beb67317cd34",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833975457990530720"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win ASan Release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:51:58.855] Scheduled build:
{
"id": "8668545395031370609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win ASan Release"
},
"number": 422604,
"createdBy": "project:chromium",
"createTime": "2026-10-08T02:51:58.364097993Z",
"updateTime": "2026-10-08T02:51:58.364097993Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "406295fb1589408d3155020f3529beb67317cd34",
"ref": "refs/heads/main"
}
}
}
[02:51:58.855] Task URL: https://cr-buildbucket.appspot.com/build/8668545395031370609
[02:51:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:2:0) after 9m41s
[02:51:59.820] Received PubSub notification, asking Buildbucket for the build status
[02:51:59.843] Build status: SCHEDULED
[02:53:52.114] Received PubSub notification, asking Buildbucket for the build status
[02:53:52.160] Build status: STARTED
[03:01:39.908] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:2:0)
[03:01:39.930] Build status: STARTED
[03:01:39.930] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:5:0) after 5m24s
[03:07:04.045] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:5:0)
[03:07:04.063] Build status: STARTED
[03:07:04.063] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:6:0) after 3m4s
[03:10:08.105] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:6:0)
[03:10:08.127] Build status: STARTED
[03:10:08.127] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:7:0) after 4m57s
[03:15:05.183] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:7:0)
[03:15:05.212] Build status: STARTED
[03:15:05.212] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:8:0) after 4m18s
[03:19:23.250] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:8:0)
[03:19:23.329] Build status: STARTED
[03:19:23.329] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:9:0) after 6m15s
[03:25:38.382] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:9:0)
[03:25:38.401] Build status: STARTED
[03:25:38.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:10:0) after 6m35s
[03:32:13.436] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:10:0)
[03:32:13.543] Build status: STARTED
[03:32:13.543] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:11:0) after 9m51s
[03:42:04.582] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:11:0)
[03:42:04.668] Build status: STARTED
[03:42:04.668] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:12:0) after 1m38s
[03:43:42.688] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:12:0)
[03:43:42.705] Build status: STARTED
[03:43:42.705] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:13:0) after 3m55s
[03:47:37.762] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:13:0)
[03:47:37.781] Build status: STARTED
[03:47:37.781] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:14:0) after 7m47s
[03:55:24.771] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:14:0)
[03:55:24.789] Build status: STARTED
[03:55:24.789] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:15:0) after 6m21s
[04:01:45.869] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:15:0)
[04:01:45.979] Build status: STARTED
[04:01:45.979] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:16:0) after 4m15s
[04:06:01.099] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:16:0)
[04:06:01.126] Build status: STARTED
[04:06:01.126] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:17:0) after 6m56s
[04:12:57.214] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:17:0)
[04:12:57.236] Build status: STARTED
[04:12:57.236] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:18:0) after 6m40s
[04:19:37.237] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:18:0)
[04:19:37.267] Build status: STARTED
[04:19:37.267] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:19:0) after 7m19s
[04:26:56.282] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:19:0)
[04:26:56.333] Build status: STARTED
[04:26:56.333] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:20:0) after 2m37s
[04:29:33.459] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:20:0)
[04:29:33.503] Build status: STARTED
[04:29:33.503] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:21:0) after 5m53s
[04:35:26.557] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:21:0)
[04:35:26.577] Build status: STARTED
[04:35:26.577] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:22:0) after 5m43s
[04:41:09.625] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:22:0)
[04:41:09.652] Build status: STARTED
[04:41:09.652] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:23:0) after 6m33s
[04:47:42.670] Handling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:23:0)
[04:47:42.694] Build status: STARTED
[04:47:42.694] Scheduling timer "check-buildbucket-build-status" (chromium/Win ASan Release:8833975457990530720:24:0) after 5m33s
[04:49:00.199] Received PubSub notification, asking Buildbucket for the build status
[04:49:00.250] Build:
{
"id": "8668545395031370609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win ASan Release"
},
"number": 422604,
"createdBy": "project:chromium",
"createTime": "2026-10-08T02:51:58.364097993Z",
"startTime": "2026-10-08T02:53:51.791821879Z",
"endTime": "2026-10-08T04:48:59.863028347Z",
"updateTime": "2026-10-08T04:48:59.863028347Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "406295fb1589408d3155020f3529beb67317cd34",
"ref": "refs/heads/main"
}
}
}
[04:49:00.250] Invocation finished in 1h57m4.090453992s with status SUCCEEDED