[04:02:52.758] New invocation is queued and will start shortly
[04:02:53.823] Starting the invocation (attempt 1)
[04:02:53.850] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6884f7c7c7a7065ba41fb2d2449d3cd6e50b879c"
[04:02:53.850] Popped gitiles commit info from properties and tags
[04:02:53.850] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:02:53.850] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:02:53.850] Buildbucket request:
{
"requestId": "8835692336990808272",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6884f7c7c7a7065ba41fb2d2449d3cd6e50b879c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835692336990808272"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMacASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:02:54.404] Scheduled build:
{
"id": "8670262275095464465",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 42915,
"createdBy": "project:chromium",
"createTime": "2026-09-19T04:02:53.943923131Z",
"updateTime": "2026-09-19T04:02:53.943923131Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6884f7c7c7a7065ba41fb2d2449d3cd6e50b879c",
"ref": "refs/heads/main"
}
}
}
[04:02:54.404] Task URL: https://cr-buildbucket.appspot.com/build/8670262275095464465
[04:02:54.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:2:0) after 5m7s
[04:02:55.436] Received PubSub notification, asking Buildbucket for the build status
[04:02:55.454] Build status: SCHEDULED
[04:02:58.175] Received PubSub notification, asking Buildbucket for the build status
[04:02:58.199] Build status: STARTED
[04:08:01.471] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:2:0)
[04:08:01.493] Build status: STARTED
[04:08:01.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:5:0) after 2m48s
[04:10:49.507] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:5:0)
[04:10:49.524] Build status: STARTED
[04:10:49.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:6:0) after 2m57s
[04:13:46.612] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:6:0)
[04:13:46.639] Build status: STARTED
[04:13:46.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:7:0) after 3m8s
[04:16:54.657] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:7:0)
[04:16:54.677] Build status: STARTED
[04:16:54.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:8:0) after 8m20s
[04:25:14.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:8:0)
[04:25:14.732] Build status: STARTED
[04:25:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:9:0) after 7m19s
[04:32:33.826] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:9:0)
[04:32:33.937] Build status: STARTED
[04:32:33.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:10:0) after 1m54s
[04:34:27.954] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:10:0)
[04:34:27.970] Build status: STARTED
[04:34:27.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:11:0) after 3m18s
[04:37:45.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:11:0)
[04:37:46.109] Build status: STARTED
[04:37:46.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:12:0) after 2m54s
[04:40:40.129] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:12:0)
[04:40:40.166] Build status: STARTED
[04:40:40.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:13:0) after 3m21s
[04:44:01.196] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:13:0)
[04:44:01.214] Build status: STARTED
[04:44:01.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:14:0) after 4m9s
[04:48:10.232] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:14:0)
[04:48:10.263] Build status: STARTED
[04:48:10.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:15:0) after 7m42s
[04:55:52.295] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:15:0)
[04:55:52.317] Build status: STARTED
[04:55:52.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:16:0) after 2m25s
[04:58:17.340] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:16:0)
[04:58:17.361] Build status: STARTED
[04:58:17.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:17:0) after 2m48s
[05:01:05.489] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:17:0)
[05:01:05.519] Build status: STARTED
[05:01:05.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:18:0) after 8m0s
[05:09:05.539] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:18:0)
[05:09:05.559] Build status: STARTED
[05:09:05.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:19:0) after 3m55s
[05:13:00.576] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:19:0)
[05:13:00.602] Build status: STARTED
[05:13:00.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:20:0) after 5m24s
[05:18:24.632] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:20:0)
[05:18:24.649] Build status: STARTED
[05:18:24.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:21:0) after 1m42s
[05:20:06.719] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:21:0)
[05:20:06.740] Build status: STARTED
[05:20:06.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:22:0) after 1m2s
[05:21:08.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:22:0)
[05:21:08.811] Build status: STARTED
[05:21:08.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:23:0) after 6m25s
[05:27:33.830] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:23:0)
[05:27:33.858] Build status: STARTED
[05:27:33.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:24:0) after 3m12s
[05:30:45.881] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:24:0)
[05:30:45.903] Build status: STARTED
[05:30:45.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:25:0) after 1m38s
[05:32:23.952] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:25:0)
[05:32:23.972] Build status: STARTED
[05:32:23.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:26:0) after 1m10s
[05:33:33.991] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:26:0)
[05:33:34.010] Build status: STARTED
[05:33:34.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:27:0) after 4m9s
[05:37:43.034] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:27:0)
[05:37:43.063] Build status: STARTED
[05:37:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:28:0) after 7m46s
[05:45:29.075] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:28:0)
[05:45:29.113] Build status: STARTED
[05:45:29.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:29:0) after 8m29s
[05:53:58.144] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:29:0)
[05:53:58.167] Build status: STARTED
[05:53:58.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:30:0) after 4m17s
[05:58:15.237] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:30:0)
[05:58:15.253] Build status: STARTED
[05:58:15.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:31:0) after 1m37s
[05:59:52.323] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:31:0)
[05:59:52.344] Build status: STARTED
[05:59:52.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:32:0) after 7m8s
[06:07:00.390] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:32:0)
[06:07:00.413] Build status: STARTED
[06:07:00.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:33:0) after 9m46s
[06:16:46.437] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:33:0)
[06:16:46.462] Build status: STARTED
[06:16:46.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:34:0) after 5m31s
[06:22:17.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:34:0)
[06:22:17.592] Build status: STARTED
[06:22:17.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:35:0) after 8m35s
[06:30:52.610] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:35:0)
[06:30:52.633] Build status: STARTED
[06:30:52.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:36:0) after 8m0s
[06:38:52.707] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:36:0)
[06:38:52.731] Build status: STARTED
[06:38:52.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:37:0) after 8m46s
[06:47:38.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:37:0)
[06:47:38.783] Build status: STARTED
[06:47:38.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:38:0) after 4m28s
[06:52:06.914] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:38:0)
[06:52:06.954] Build status: STARTED
[06:52:06.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:39:0) after 9m54s
[07:02:00.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:39:0)
[07:02:01.002] Build status: STARTED
[07:02:01.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:40:0) after 8m41s
[07:10:42.024] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:40:0)
[07:10:42.103] Build status: STARTED
[07:10:42.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:41:0) after 2m9s
[07:12:51.120] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:41:0)
[07:12:51.140] Build status: STARTED
[07:12:51.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:42:0) after 8m45s
[07:21:36.209] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:42:0)
[07:21:36.228] Build status: STARTED
[07:21:36.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8835692336990808272:43:0) after 7m9s
[07:28:12.525] Received PubSub notification, asking Buildbucket for the build status
[07:28:12.544] Build:
{
"id": "8670262275095464465",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 42915,
"createdBy": "project:chromium",
"createTime": "2026-09-19T04:02:53.943923131Z",
"startTime": "2026-09-19T04:02:57.571346690Z",
"endTime": "2026-09-19T07:28:12.164788314Z",
"updateTime": "2026-09-19T07:28:12.164788314Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6884f7c7c7a7065ba41fb2d2449d3cd6e50b879c",
"ref": "refs/heads/main"
}
}
}
[07:28:12.544] Invocation finished in 3h25m19.792273098s with status SUCCEEDED