[11:22:55.014] New invocation is queued and will start shortly
[11:22:56.114] Starting the invocation (attempt 1)
[11:22:56.180] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/585fb4ae011c4b505760072813525868205f4ba5"
[11:22:56.181] Popped gitiles commit info from properties and tags
[11:22:56.181] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:22:56.181] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:22:56.181] Buildbucket request:
{
"requestId": "8889207459367049104",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU FYI Win x64 Builder (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "585fb4ae011c4b505760072813525868205f4ba5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889207459367049104"
},
{
"key": "scheduler_job_id",
"value": "chromium/GPU FYI Win x64 Builder (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:22:56.791] Scheduled build:
{
"id": "8723777397391835457",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU FYI Win x64 Builder (dbg)"
},
"number": 74212,
"createdBy": "project:chromium",
"createTime": "2025-02-05T11:22:56.270870227Z",
"updateTime": "2025-02-05T11:22:56.270870227Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "585fb4ae011c4b505760072813525868205f4ba5",
"ref": "refs/heads/main"
}
}
}
[11:22:56.791] Task URL: https://cr-buildbucket.appspot.com/build/8723777397391835457
[11:22:56.791] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:2:0) after 6m36s
[11:23:15.206] Received PubSub notification, asking Buildbucket for the build status
[11:23:15.232] Build status: STARTED
[11:23:25.318] Received PubSub notification, asking Buildbucket for the build status
[11:23:25.346] Build status: STARTED
[11:29:32.962] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:2:0)
[11:29:32.989] Build status: STARTED
[11:29:32.989] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:5:0) after 2m33s
[11:32:06.018] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:5:0)
[11:32:06.074] Build status: STARTED
[11:32:06.074] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:6:0) after 4m59s
[11:37:05.100] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:6:0)
[11:37:05.133] Build status: STARTED
[11:37:05.133] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:7:0) after 1m55s
[11:39:00.185] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:7:0)
[11:39:00.208] Build status: STARTED
[11:39:00.208] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:8:0) after 5m50s
[11:44:50.608] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:8:0)
[11:44:50.632] Build status: STARTED
[11:44:50.632] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:9:0) after 5m4s
[11:49:54.654] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:9:0)
[11:49:54.683] Build status: STARTED
[11:49:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:10:0) after 6m54s
[11:56:48.811] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:10:0)
[11:56:48.840] Build status: STARTED
[11:56:48.840] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:11:0) after 4m41s
[12:01:29.908] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:11:0)
[12:01:29.924] Build status: STARTED
[12:01:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:12:0) after 6m56s
[12:08:26.024] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:12:0)
[12:08:26.051] Build status: STARTED
[12:08:26.051] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:13:0) after 6m49s
[12:15:15.070] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:13:0)
[12:15:15.095] Build status: STARTED
[12:15:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:14:0) after 1m39s
[12:16:54.174] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:14:0)
[12:16:54.248] Build status: STARTED
[12:16:54.248] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:15:0) after 5m0s
[12:21:54.269] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:15:0)
[12:21:54.383] Build status: STARTED
[12:21:54.383] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:16:0) after 4m6s
[12:26:00.431] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:16:0)
[12:26:00.446] Build status: STARTED
[12:26:00.446] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:17:0) after 5m15s
[12:31:15.520] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:17:0)
[12:31:15.535] Build status: STARTED
[12:31:15.535] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:18:0) after 4m21s
[12:35:36.556] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:18:0)
[12:35:36.576] Build status: STARTED
[12:35:36.576] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:19:0) after 1m59s
[12:37:35.603] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:19:0)
[12:37:35.621] Build status: STARTED
[12:37:35.621] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:20:0) after 6m19s
[12:43:54.772] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:20:0)
[12:43:54.789] Build status: STARTED
[12:43:54.789] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:21:0) after 6m55s
[12:50:49.814] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:21:0)
[12:50:49.829] Build status: STARTED
[12:50:49.829] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:22:0) after 4m42s
[12:55:31.918] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:22:0)
[12:55:31.935] Build status: STARTED
[12:55:31.935] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:23:0) after 7m26s
[13:02:58.023] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:23:0)
[13:02:58.042] Build status: STARTED
[13:02:58.042] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:24:0) after 4m25s
[13:07:23.069] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:24:0)
[13:07:23.090] Build status: STARTED
[13:07:23.090] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:25:0) after 5m46s
[13:13:09.530] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:25:0)
[13:13:09.603] Build status: STARTED
[13:13:09.603] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:26:0) after 9m31s
[13:22:40.637] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:26:0)
[13:22:40.687] Build status: STARTED
[13:22:40.687] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:27:0) after 7m59s
[13:30:40.460] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:27:0)
[13:30:40.553] Build status: STARTED
[13:30:40.553] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:28:0) after 1m52s
[13:32:32.578] Handling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:28:0)
[13:32:32.614] Build status: STARTED
[13:32:32.614] Scheduling timer "check-buildbucket-build-status" (chromium/GPU FYI Win x64 Builder (dbg):8889207459367049104:29:0) after 9m41s
[13:41:09.357] Received PubSub notification, asking Buildbucket for the build status
[13:41:09.386] Build:
{
"id": "8723777397391835457",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU FYI Win x64 Builder (dbg)"
},
"number": 74212,
"createdBy": "project:chromium",
"createTime": "2025-02-05T11:22:56.270870227Z",
"startTime": "2025-02-05T11:23:04.801298301Z",
"endTime": "2025-02-05T13:41:07.712759719Z",
"updateTime": "2025-02-05T13:41:07.712759719Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "585fb4ae011c4b505760072813525868205f4ba5",
"ref": "refs/heads/main"
}
}
}
[13:41:09.386] Invocation finished in 2h18m14.38374172s with status SUCCEEDED