[20:11:03.273] New invocation is queued and will start shortly
[20:11:04.379] Starting the invocation (attempt 1)
[20:11:04.413] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e575172cd0f13d5b31bb1908c6091d6e729bafc"
[20:11:04.413] Popped gitiles commit info from properties and tags
[20:11:04.413] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:11:04.413] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:11:04.413] Buildbucket request:
{
"requestId": "8919161827698252368",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ChromeOS FYI Release (amd64-generic)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e575172cd0f13d5b31bb1908c6091d6e729bafc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919161827698252368"
},
{
"key": "scheduler_job_id",
"value": "chromium/ChromeOS FYI Release (amd64-generic)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:11:05.749] Scheduled build:
{
"id": "8753731765641199921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ChromeOS FYI Release (amd64-generic)"
},
"number": 11095,
"createdBy": "project:chromium",
"createTime": "2024-03-11T20:11:04.606018209Z",
"updateTime": "2024-03-11T20:11:04.606018209Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e575172cd0f13d5b31bb1908c6091d6e729bafc",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:11:05.749] Task URL: https://cr-buildbucket.appspot.com/build/8753731765641199921
[20:11:05.749] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:2:0) after 3m41s
[20:11:06.605] Received PubSub notification, asking Buildbucket for the build status
[20:11:06.651] Build status: SCHEDULED
[20:11:07.200] Received PubSub notification, asking Buildbucket for the build status
[20:11:07.233] Build status: STARTED
[20:14:46.774] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:2:0)
[20:14:46.874] Build status: STARTED
[20:14:46.874] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:5:0) after 2m51s
[20:17:38.147] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:5:0)
[20:17:38.236] Build status: STARTED
[20:17:38.247] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:6:0) after 8m46s
[20:26:24.308] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:6:0)
[20:26:24.329] Build status: STARTED
[20:26:24.329] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:7:0) after 8m29s
[20:34:53.403] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:7:0)
[20:34:53.425] Build status: STARTED
[20:34:53.425] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:8:0) after 9m15s
[20:44:08.559] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:8:0)
[20:44:08.582] Build status: STARTED
[20:44:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:9:0) after 4m19s
[20:48:27.565] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:9:0)
[20:48:27.586] Build status: STARTED
[20:48:27.586] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:10:0) after 3m9s
[20:51:36.618] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:10:0)
[20:51:36.673] Build status: STARTED
[20:51:36.673] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:11:0) after 1m7s
[20:52:43.734] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:11:0)
[20:52:43.772] Build status: STARTED
[20:52:43.772] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:12:0) after 7m54s
[21:00:37.892] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:12:0)
[21:00:37.915] Build status: STARTED
[21:00:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:13:0) after 3m33s
[21:04:10.986] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:13:0)
[21:04:11.029] Build status: STARTED
[21:04:11.029] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:14:0) after 5m3s
[21:09:14.198] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:14:0)
[21:09:14.218] Build status: STARTED
[21:09:14.218] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:15:0) after 6m34s
[21:15:48.244] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:15:0)
[21:15:48.263] Build status: STARTED
[21:15:48.263] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:16:0) after 4m44s
[21:20:32.318] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:16:0)
[21:20:32.338] Build status: STARTED
[21:20:32.338] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:17:0) after 9m47s
[21:30:19.426] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:17:0)
[21:30:19.448] Build status: STARTED
[21:30:19.448] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:18:0) after 1m46s
[21:32:05.538] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:18:0)
[21:32:05.558] Build status: STARTED
[21:32:05.558] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:19:0) after 3m9s
[21:35:14.591] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:19:0)
[21:35:14.612] Build status: STARTED
[21:35:14.612] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:20:0) after 9m26s
[21:44:40.669] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:20:0)
[21:44:40.685] Build status: STARTED
[21:44:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:21:0) after 5m6s
[21:49:46.870] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:21:0)
[21:49:46.969] Build status: STARTED
[21:49:46.969] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:22:0) after 9m34s
[21:59:21.059] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:22:0)
[21:59:21.089] Build status: STARTED
[21:59:21.089] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:23:0) after 6m10s
[22:05:31.263] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:23:0)
[22:05:31.337] Build status: STARTED
[22:05:31.337] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:24:0) after 8m56s
[22:14:27.354] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:24:0)
[22:14:27.372] Build status: STARTED
[22:14:27.373] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:25:0) after 9m32s
[22:23:59.600] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:25:0)
[22:23:59.635] Build status: STARTED
[22:23:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:26:0) after 3m16s
[22:27:15.662] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:26:0)
[22:27:15.729] Build status: STARTED
[22:27:15.729] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:27:0) after 1m52s
[22:29:07.809] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:27:0)
[22:29:07.830] Build status: STARTED
[22:29:07.830] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:28:0) after 3m21s
[22:32:28.940] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:28:0)
[22:32:28.973] Build status: STARTED
[22:32:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:29:0) after 9m53s
[22:42:22.116] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:29:0)
[22:42:22.141] Build status: STARTED
[22:42:22.141] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:30:0) after 6m30s
[22:48:52.180] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:30:0)
[22:48:52.261] Build status: STARTED
[22:48:52.261] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:31:0) after 5m22s
[22:54:14.309] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:31:0)
[22:54:14.326] Build status: STARTED
[22:54:14.326] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:32:0) after 1m35s
[22:55:49.349] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:32:0)
[22:55:49.415] Build status: STARTED
[22:55:49.415] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:33:0) after 3m43s
[22:59:32.404] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:33:0)
[22:59:32.423] Build status: STARTED
[22:59:32.423] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:34:0) after 6m19s
[23:05:51.421] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:34:0)
[23:05:51.448] Build status: STARTED
[23:05:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:35:0) after 4m37s
[23:10:28.489] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:35:0)
[23:10:28.511] Build status: STARTED
[23:10:28.511] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:36:0) after 3m53s
[23:14:21.522] Handling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:36:0)
[23:14:21.548] Build status: STARTED
[23:14:21.548] Scheduling timer "check-buildbucket-build-status" (chromium/ChromeOS FYI Release (amd64-generic):8919161827698252368:37:0) after 3m13s
[23:14:49.007] Received PubSub notification, asking Buildbucket for the build status
[23:14:49.033] Build:
{
"id": "8753731765641199921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ChromeOS FYI Release (amd64-generic)"
},
"number": 11095,
"createdBy": "project:chromium",
"createTime": "2024-03-11T20:11:04.606018209Z",
"startTime": "2024-03-11T20:11:06.409953Z",
"endTime": "2024-03-11T23:14:47.718136Z",
"updateTime": "2024-03-11T23:14:47.718136Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7e575172cd0f13d5b31bb1908c6091d6e729bafc",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:14:49.033] Invocation finished in 3h3m45.772325363s with status SUCCEEDED