[15:38:53.518] New invocation is queued and will start shortly
[15:38:54.826] Starting the invocation (attempt 1)
[15:38:54.854] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32837a76aa7c6e2e50f701ee9a7eb885aa4467bb"
[15:38:54.854] Popped gitiles commit info from properties and tags
[15:38:54.854] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:38:54.854] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:38:54.854] Buildbucket request:
{
"requestId": "8872340319055718736",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "32837a76aa7c6e2e50f701ee9a7eb885aa4467bb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872340319055718736"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-13-x64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:38:55.347] Scheduled build:
{
"id": "8706910256943994193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"number": 14239,
"createdBy": "project:chromium",
"createTime": "2025-08-10T15:38:54.906079882Z",
"updateTime": "2025-08-10T15:38:54.906079882Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "32837a76aa7c6e2e50f701ee9a7eb885aa4467bb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:38:55.347] Task URL: https://cr-buildbucket.appspot.com/build/8706910256943994193
[15:38:55.347] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:2:0) after 4m51s
[15:38:56.312] Received PubSub notification, asking Buildbucket for the build status
[15:38:56.334] Build status: SCHEDULED
[15:39:00.211] Received PubSub notification, asking Buildbucket for the build status
[15:39:00.269] Build status: STARTED
[15:43:46.547] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:2:0)
[15:43:46.586] Build status: STARTED
[15:43:46.586] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:5:0) after 6m21s
[15:50:07.785] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:5:0)
[15:50:07.812] Build status: STARTED
[15:50:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:6:0) after 4m53s
[15:55:00.926] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:6:0)
[15:55:00.949] Build status: STARTED
[15:55:00.949] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:7:0) after 7m19s
[16:02:20.066] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:7:0)
[16:02:20.131] Build status: STARTED
[16:02:20.131] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:8:0) after 4m11s
[16:06:31.156] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:8:0)
[16:06:31.199] Build status: STARTED
[16:06:31.199] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:9:0) after 6m5s
[16:12:36.213] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:9:0)
[16:12:36.230] Build status: STARTED
[16:12:36.230] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:10:0) after 8m22s
[16:20:58.288] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:10:0)
[16:20:58.336] Build status: STARTED
[16:20:58.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:11:0) after 3m45s
[16:24:43.351] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:11:0)
[16:24:43.378] Build status: STARTED
[16:24:43.378] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:12:0) after 3m19s
[16:28:02.566] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:12:0)
[16:28:02.587] Build status: STARTED
[16:28:02.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:13:0) after 2m54s
[16:30:56.677] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:13:0)
[16:30:56.697] Build status: STARTED
[16:30:56.697] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:14:0) after 6m50s
[16:37:46.813] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:14:0)
[16:37:46.860] Build status: STARTED
[16:37:46.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:15:0) after 6m37s
[16:44:23.848] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:15:0)
[16:44:23.866] Build status: STARTED
[16:44:23.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:16:0) after 8m19s
[16:52:42.879] Handling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:16:0)
[16:52:42.892] Build status: STARTED
[16:52:42.892] Scheduling timer "check-buildbucket-build-status" (chromium/android-13-x64-rel:8872340319055718736:17:0) after 7m0s
[16:58:50.650] Received PubSub notification, asking Buildbucket for the build status
[16:58:50.666] Build:
{
"id": "8706910256943994193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"number": 14239,
"createdBy": "project:chromium",
"createTime": "2025-08-10T15:38:54.906079882Z",
"startTime": "2025-08-10T15:38:59.972321859Z",
"endTime": "2025-08-10T16:58:50.179582627Z",
"updateTime": "2025-08-10T16:58:50.179582627Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "32837a76aa7c6e2e50f701ee9a7eb885aa4467bb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:58:50.666] Invocation finished in 1h19m57.157902031s with status SUCCEEDED