[08:36:46.650] New invocation is queued and will start shortly
[08:36:47.831] Starting the invocation (attempt 1)
[08:36:47.860] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/9bf070ac375521334f30b8a6a7db75a16a8f2552"
[08:36:47.860] Popped gitiles commit info from properties and tags
[08:36:47.860] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:36:47.861] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:36:47.861] Buildbucket request:
{
"requestId": "8867021655181882480",
"builder": {
"project": "emscripten-releases",
"bucket": "ci",
"builder": "linux-test-suites"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8867021655181882480",
"job": "emscripten-releases/linux-test-suites",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/emscripten-releases",
"revision": "9bf070ac375521334f30b8a6a7db75a16a8f2552"
},
"id": "https://chromium.googlesource.com/emscripten-releases/+/refs/heads/main@9bf070ac375521334f30b8a6a7db75a16a8f2552",
"title": "9bf070ac375521334f30b8a6a7db75a16a8f2552",
"url": "https://chromium.googlesource.com/emscripten-releases/+/9bf070ac375521334f30b8a6a7db75a16a8f2552"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "emscripten-releases",
"id": "9bf070ac375521334f30b8a6a7db75a16a8f2552",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8867021655181882480"
},
{
"key": "scheduler_job_id",
"value": "emscripten-releases/linux-test-suites"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:36:48.568] Scheduled build:
{
"id": "8701591593070181121",
"builder": {
"project": "emscripten-releases",
"bucket": "ci",
"builder": "linux-test-suites"
},
"createdBy": "project:emscripten-releases",
"createTime": "2025-10-08T08:36:48.040530420Z",
"updateTime": "2025-10-08T08:36:48.040530420Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "emscripten-releases",
"id": "9bf070ac375521334f30b8a6a7db75a16a8f2552",
"ref": "refs/heads/main"
}
}
}
[08:36:48.568] Task URL: https://cr-buildbucket.appspot.com/build/8701591593070181121
[08:36:48.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:2:0) after 2m22s
[08:36:49.361] Received PubSub notification, asking Buildbucket for the build status
[08:36:49.379] Build status: SCHEDULED
[08:36:54.243] Received PubSub notification, asking Buildbucket for the build status
[08:36:54.257] Build status: STARTED
[08:39:10.598] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:2:0)
[08:39:10.631] Build status: STARTED
[08:39:10.631] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:5:0) after 9m41s
[08:48:51.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:5:0)
[08:48:51.885] Build status: STARTED
[08:48:51.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:6:0) after 3m10s
[08:52:01.903] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:6:0)
[08:52:01.941] Build status: STARTED
[08:52:01.941] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:7:0) after 5m15s
[08:57:17.046] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:7:0)
[08:57:17.074] Build status: STARTED
[08:57:17.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:8:0) after 5m15s
[09:02:32.144] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:8:0)
[09:02:32.162] Build status: STARTED
[09:02:32.162] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:9:0) after 4m59s
[09:07:31.232] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:9:0)
[09:07:31.252] Build status: STARTED
[09:07:31.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:10:0) after 7m34s
[09:15:05.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:10:0)
[09:15:05.290] Build status: STARTED
[09:15:05.290] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:11:0) after 2m48s
[09:17:53.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:11:0)
[09:17:53.331] Build status: STARTED
[09:17:53.331] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:12:0) after 4m45s
[09:22:38.320] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:12:0)
[09:22:38.353] Build status: STARTED
[09:22:38.353] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:13:0) after 7m28s
[09:30:06.370] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:13:0)
[09:30:06.390] Build status: STARTED
[09:30:06.391] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:14:0) after 2m38s
[09:32:44.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:14:0)
[09:32:44.445] Build status: STARTED
[09:32:44.445] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:15:0) after 2m18s
[09:35:02.533] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:15:0)
[09:35:02.548] Build status: STARTED
[09:35:02.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:16:0) after 6m29s
[09:41:31.560] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:16:0)
[09:41:31.582] Build status: STARTED
[09:41:31.582] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:17:0) after 6m30s
[09:48:01.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:17:0)
[09:48:01.619] Build status: STARTED
[09:48:01.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:18:0) after 1m15s
[09:49:16.632] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:18:0)
[09:49:16.645] Build status: STARTED
[09:49:16.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:19:0) after 8m11s
[09:57:27.656] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:19:0)
[09:57:27.689] Build status: STARTED
[09:57:27.689] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:20:0) after 6m21s
[10:03:48.701] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:20:0)
[10:03:48.720] Build status: STARTED
[10:03:48.720] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:21:0) after 5m7s
[10:08:55.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:21:0)
[10:08:55.796] Build status: STARTED
[10:08:55.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:22:0) after 9m43s
[10:18:38.811] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:22:0)
[10:18:38.831] Build status: STARTED
[10:18:38.831] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:23:0) after 2m35s
[10:21:13.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:23:0)
[10:21:13.863] Build status: STARTED
[10:21:13.863] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:24:0) after 8m3s
[10:29:16.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:24:0)
[10:29:16.909] Build status: STARTED
[10:29:16.909] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:25:0) after 7m46s
[10:37:02.921] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:25:0)
[10:37:02.938] Build status: STARTED
[10:37:02.938] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:26:0) after 4m45s
[10:41:47.926] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:26:0)
[10:41:47.955] Build status: STARTED
[10:41:47.955] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:27:0) after 4m2s
[10:45:49.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:27:0)
[10:45:50.020] Build status: STARTED
[10:45:50.020] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:28:0) after 6m36s
[10:52:26.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:28:0)
[10:52:26.088] Build status: STARTED
[10:52:26.088] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:29:0) after 1m22s
[10:53:48.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:29:0)
[10:53:48.169] Build status: STARTED
[10:53:48.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:30:0) after 1m6s
[10:54:54.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:30:0)
[10:54:54.195] Build status: STARTED
[10:54:54.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:31:0) after 5m8s
[11:00:02.347] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:31:0)
[11:00:02.361] Build status: STARTED
[11:00:02.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:32:0) after 9m6s
[11:09:08.412] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:32:0)
[11:09:08.430] Build status: STARTED
[11:09:08.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:33:0) after 1m0s
[11:10:08.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:33:0)
[11:10:08.632] Build status: STARTED
[11:10:08.632] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:34:0) after 2m34s
[11:12:42.680] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:34:0)
[11:12:42.728] Build status: STARTED
[11:12:42.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:35:0) after 7m32s
[11:20:14.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:35:0)
[11:20:14.809] Build status: STARTED
[11:20:14.809] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:36:0) after 5m13s
[11:25:27.877] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:36:0)
[11:25:27.897] Build status: STARTED
[11:25:27.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:37:0) after 6m49s
[11:32:16.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:37:0)
[11:32:17.002] Build status: STARTED
[11:32:17.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:38:0) after 5m1s
[11:37:18.106] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:38:0)
[11:37:18.125] Build status: STARTED
[11:37:18.125] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:39:0) after 4m22s
[11:41:40.236] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:39:0)
[11:41:40.260] Build status: STARTED
[11:41:40.260] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:8867021655181882480:40:0) after 7m50s
[11:48:31.411] Received PubSub notification, asking Buildbucket for the build status
[11:48:31.428] Build:
{
"id": "8701591593070181121",
"builder": {
"project": "emscripten-releases",
"bucket": "ci",
"builder": "linux-test-suites"
},
"createdBy": "project:emscripten-releases",
"createTime": "2025-10-08T08:36:48.040530420Z",
"startTime": "2025-10-08T08:36:53.901060817Z",
"endTime": "2025-10-08T11:48:31.241482821Z",
"updateTime": "2025-10-08T11:48:31.241482821Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "emscripten-releases",
"id": "9bf070ac375521334f30b8a6a7db75a16a8f2552",
"ref": "refs/heads/main"
}
}
}
[11:48:31.428] Invocation finished in 3h11m44.785580748s with status SUCCEEDED