[20:59:14.253] New invocation is queued and will start shortly
[20:59:15.320] Starting the invocation (attempt 1)
[20:59:15.352] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97285b78e9ac50ef2f8dbb61bc7067e3611e6b30"
[20:59:15.352] Popped gitiles commit info from properties and tags
[20:59:15.352] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:59:15.352] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:59:15.353] Buildbucket request:
{
"requestId": "8887449858042412064",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97285b78e9ac50ef2f8dbb61bc7067e3611e6b30",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887449858042412064"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:59:15.834] Scheduled build:
{
"id": "8722019796184725009",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 15048,
"createdBy": "project:chromium",
"createTime": "2025-02-24T20:59:15.399992732Z",
"updateTime": "2025-02-24T20:59:15.399992732Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97285b78e9ac50ef2f8dbb61bc7067e3611e6b30",
"ref": "refs/heads/main"
}
}
}
[20:59:15.834] Task URL: https://cr-buildbucket.appspot.com/build/8722019796184725009
[20:59:15.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:2:0) after 2m51s
[20:59:16.801] Received PubSub notification, asking Buildbucket for the build status
[20:59:16.824] Build status: SCHEDULED
[20:59:20.929] Received PubSub notification, asking Buildbucket for the build status
[20:59:21.019] Build status: STARTED
[21:02:06.885] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:2:0)
[21:02:06.953] Build status: STARTED
[21:02:06.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:5:0) after 7m32s
[21:09:38.983] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:5:0)
[21:09:39.004] Build status: STARTED
[21:09:39.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:6:0) after 2m42s
[21:12:21.070] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:6:0)
[21:12:21.128] Build status: STARTED
[21:12:21.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:7:0) after 9m56s
[21:22:17.149] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:7:0)
[21:22:17.171] Build status: STARTED
[21:22:17.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:8:0) after 4m20s
[21:26:37.348] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:8:0)
[21:26:37.447] Build status: STARTED
[21:26:37.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:9:0) after 7m29s
[21:34:06.505] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:9:0)
[21:34:06.963] Build status: STARTED
[21:34:06.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:10:0) after 5m46s
[21:39:52.983] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:10:0)
[21:39:53.005] Build status: STARTED
[21:39:53.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:11:0) after 3m14s
[21:43:07.049] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:11:0)
[21:43:07.065] Build status: STARTED
[21:43:07.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:12:0) after 1m8s
[21:44:15.094] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:12:0)
[21:44:15.109] Build status: STARTED
[21:44:15.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:13:0) after 4m14s
[21:48:29.208] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:13:0)
[21:48:29.222] Build status: STARTED
[21:48:29.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:14:0) after 8m27s
[21:56:56.203] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:14:0)
[21:56:56.250] Build status: STARTED
[21:56:56.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:15:0) after 2m8s
[21:59:04.293] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:15:0)
[21:59:04.316] Build status: STARTED
[21:59:04.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:16:0) after 5m47s
[22:04:51.514] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:16:0)
[22:04:51.576] Build status: STARTED
[22:04:51.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:17:0) after 5m25s
[22:10:16.666] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:17:0)
[22:10:16.685] Build status: STARTED
[22:10:16.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:18:0) after 3m33s
[22:13:49.703] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:18:0)
[22:13:49.780] Build status: STARTED
[22:13:49.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:19:0) after 8m27s
[22:22:16.904] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:19:0)
[22:22:17.001] Build status: STARTED
[22:22:17.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:20:0) after 6m37s
[22:28:54.047] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:20:0)
[22:28:54.107] Build status: STARTED
[22:28:54.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:21:0) after 4m51s
[22:33:45.170] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:21:0)
[22:33:45.184] Build status: STARTED
[22:33:45.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:22:0) after 5m32s
[22:39:17.216] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:22:0)
[22:39:17.233] Build status: STARTED
[22:39:17.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:23:0) after 4m43s
[22:44:00.255] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:23:0)
[22:44:00.344] Build status: STARTED
[22:44:00.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:24:0) after 1m12s
[22:45:12.408] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:24:0)
[22:45:12.420] Build status: STARTED
[22:45:12.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:25:0) after 5m57s
[22:51:09.455] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:25:0)
[22:51:09.478] Build status: STARTED
[22:51:09.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:26:0) after 6m30s
[22:57:39.564] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:26:0)
[22:57:39.578] Build status: STARTED
[22:57:39.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:27:0) after 7m50s
[23:05:29.566] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:27:0)
[23:05:29.630] Build status: STARTED
[23:05:29.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:28:0) after 5m52s
[23:11:21.700] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:28:0)
[23:11:21.715] Build status: STARTED
[23:11:21.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:29:0) after 4m52s
[23:16:13.794] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:29:0)
[23:16:13.810] Build status: STARTED
[23:16:13.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:30:0) after 2m34s
[23:18:47.820] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:30:0)
[23:18:47.836] Build status: STARTED
[23:18:47.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:31:0) after 7m53s
[23:26:40.865] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:31:0)
[23:26:40.891] Build status: STARTED
[23:26:40.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:32:0) after 8m27s
[23:35:07.976] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:32:0)
[23:35:07.990] Build status: STARTED
[23:35:07.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:33:0) after 4m11s
[23:39:19.019] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:33:0)
[23:39:19.033] Build status: STARTED
[23:39:19.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:34:0) after 1m0s
[23:40:19.108] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:34:0)
[23:40:19.123] Build status: STARTED
[23:40:19.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:35:0) after 2m37s
[23:42:56.155] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:35:0)
[23:42:56.175] Build status: STARTED
[23:42:56.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:36:0) after 9m11s
[23:52:07.202] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:36:0)
[23:52:07.260] Build status: STARTED
[23:52:07.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:37:0) after 6m13s
[23:58:20.291] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:37:0)
[23:58:20.309] Build status: STARTED
[23:58:20.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:38:0) after 3m59s
[00:02:19.357] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:38:0)
[00:02:19.376] Build status: STARTED
[00:02:19.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:39:0) after 5m6s
[00:07:25.511] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:39:0)
[00:07:25.528] Build status: STARTED
[00:07:25.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:40:0) after 2m8s
[00:09:33.622] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:40:0)
[00:09:33.641] Build status: STARTED
[00:09:33.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:41:0) after 3m35s
[00:13:08.666] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:41:0)
[00:13:08.682] Build status: STARTED
[00:13:08.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:42:0) after 8m22s
[00:21:30.710] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:42:0)
[00:21:30.726] Build status: STARTED
[00:21:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:43:0) after 7m18s
[00:28:48.753] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:43:0)
[00:28:48.772] Build status: STARTED
[00:28:48.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:44:0) after 4m40s
[00:33:28.811] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:44:0)
[00:33:28.888] Build status: STARTED
[00:33:28.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:45:0) after 9m23s
[00:42:51.921] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:45:0)
[00:42:51.941] Build status: STARTED
[00:42:51.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:46:0) after 4m33s
[00:47:24.962] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:46:0)
[00:47:24.979] Build status: STARTED
[00:47:24.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:47:0) after 4m54s
[00:52:18.985] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:47:0)
[00:52:19.000] Build status: STARTED
[00:52:19.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:48:0) after 6m0s
[00:58:19.082] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:48:0)
[00:58:19.097] Build status: STARTED
[00:58:19.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:49:0) after 9m13s
[01:07:32.126] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:49:0)
[01:07:32.260] Build status: STARTED
[01:07:32.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:50:0) after 4m56s
[01:12:28.349] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:50:0)
[01:12:28.367] Build status: STARTED
[01:12:28.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:51:0) after 7m45s
[01:20:13.398] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:51:0)
[01:20:13.414] Build status: STARTED
[01:20:13.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:52:0) after 3m34s
[01:23:47.438] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:52:0)
[01:23:47.457] Build status: STARTED
[01:23:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:53:0) after 2m7s
[01:25:54.488] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:53:0)
[01:25:54.503] Build status: STARTED
[01:25:54.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:54:0) after 2m23s
[01:28:17.505] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:54:0)
[01:28:17.543] Build status: STARTED
[01:28:17.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:55:0) after 5m33s
[01:33:50.566] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:55:0)
[01:33:50.602] Build status: STARTED
[01:33:50.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:56:0) after 9m18s
[01:43:08.682] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:56:0)
[01:43:08.696] Build status: STARTED
[01:43:08.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:57:0) after 8m9s
[01:51:17.752] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:57:0)
[01:51:17.765] Build status: STARTED
[01:51:17.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8887449858042412064:58:0) after 6m46s
[01:51:33.302] Received PubSub notification, asking Buildbucket for the build status
[01:51:33.316] Build:
{
"id": "8722019796184725009",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 15048,
"createdBy": "project:chromium",
"createTime": "2025-02-24T20:59:15.399992732Z",
"startTime": "2025-02-24T20:59:20.730982001Z",
"endTime": "2025-02-25T01:51:32.659172462Z",
"updateTime": "2025-02-25T01:51:32.659172462Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97285b78e9ac50ef2f8dbb61bc7067e3611e6b30",
"ref": "refs/heads/main"
}
}
}
[01:51:33.316] Invocation finished in 4h52m19.072033254s with status FAILED