[22:40:55.268] New invocation is queued and will start shortly
[22:40:56.868] Starting the invocation (attempt 1)
[22:40:56.898] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ffca9c169a23fc1884e7fda28d3af60c24a6eff2"
[22:40:56.898] Popped gitiles commit info from properties and tags
[22:40:56.898] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:40:56.898] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:40:56.898] Buildbucket request:
{
"requestId": "8897318530005858512",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU Win x64 Builder"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ffca9c169a23fc1884e7fda28d3af60c24a6eff2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897318530005858512"
},
{
"key": "scheduler_job_id",
"value": "chromium/GPU Win x64 Builder"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:40:57.403] Scheduled build:
{
"id": "8731888467575206049",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU Win x64 Builder"
},
"number": 70665,
"createdBy": "project:chromium",
"createTime": "2024-11-07T22:40:56.957490103Z",
"updateTime": "2024-11-07T22:40:56.957490103Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ffca9c169a23fc1884e7fda28d3af60c24a6eff2",
"ref": "refs/heads/main"
}
}
}
[22:40:57.403] Task URL: https://cr-buildbucket.appspot.com/build/8731888467575206049
[22:40:57.403] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:2:0) after 7m27s
[22:40:58.409] Received PubSub notification, asking Buildbucket for the build status
[22:40:58.470] Build status: SCHEDULED
[22:45:16.767] Received PubSub notification, asking Buildbucket for the build status
[22:45:16.828] Build status: STARTED
[22:48:24.428] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:2:0)
[22:48:24.449] Build status: STARTED
[22:48:24.449] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:5:0) after 3m13s
[22:51:37.479] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:5:0)
[22:51:37.514] Build status: STARTED
[22:51:37.514] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:6:0) after 9m50s
[23:01:27.542] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:6:0)
[23:01:27.563] Build status: STARTED
[23:01:27.563] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:7:0) after 8m5s
[23:09:32.582] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:7:0)
[23:09:32.606] Build status: STARTED
[23:09:32.606] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:8:0) after 1m12s
[23:10:44.629] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:8:0)
[23:10:44.643] Build status: STARTED
[23:10:44.643] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:9:0) after 8m3s
[23:18:47.666] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:9:0)
[23:18:47.689] Build status: STARTED
[23:18:47.689] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:10:0) after 8m2s
[23:26:49.722] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:10:0)
[23:26:49.742] Build status: STARTED
[23:26:49.742] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:11:0) after 1m53s
[23:28:42.812] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:11:0)
[23:28:42.834] Build status: STARTED
[23:28:42.834] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:12:0) after 8m15s
[23:36:57.984] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:12:0)
[23:36:58.008] Build status: STARTED
[23:36:58.008] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:13:0) after 4m26s
[23:41:24.026] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:13:0)
[23:41:24.053] Build status: STARTED
[23:41:24.053] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:14:0) after 1m21s
[23:42:45.107] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:14:0)
[23:42:45.122] Build status: STARTED
[23:42:45.122] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:15:0) after 4m37s
[23:47:23.076] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:15:0)
[23:47:23.095] Build status: STARTED
[23:47:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:16:0) after 9m55s
[23:57:18.535] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:16:0)
[23:57:18.595] Build status: STARTED
[23:57:18.596] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:17:0) after 4m28s
[00:01:46.866] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:17:0)
[00:01:46.904] Build status: STARTED
[00:01:46.904] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:18:0) after 8m43s
[00:10:29.983] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:18:0)
[00:10:30.011] Build status: STARTED
[00:10:30.011] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:19:0) after 7m28s
[00:17:58.041] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:19:0)
[00:17:58.061] Build status: STARTED
[00:17:58.061] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:20:0) after 2m25s
[00:20:23.118] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:20:0)
[00:20:23.146] Build status: STARTED
[00:20:23.146] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:21:0) after 3m55s
[00:24:18.248] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:21:0)
[00:24:18.266] Build status: STARTED
[00:24:18.267] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:22:0) after 4m33s
[00:28:51.266] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:22:0)
[00:28:51.283] Build status: STARTED
[00:28:51.283] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:23:0) after 1m1s
[00:29:52.891] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:23:0)
[00:29:52.907] Build status: STARTED
[00:29:52.907] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:24:0) after 2m12s
[00:32:04.929] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:24:0)
[00:32:04.956] Build status: STARTED
[00:32:04.956] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:25:0) after 5m45s
[00:37:49.977] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:25:0)
[00:37:49.993] Build status: STARTED
[00:37:49.993] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:26:0) after 8m3s
[00:45:53.070] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:26:0)
[00:45:53.135] Build status: STARTED
[00:45:53.135] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:27:0) after 6m35s
[00:52:28.289] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:27:0)
[00:52:28.311] Build status: STARTED
[00:52:28.311] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:28:0) after 4m4s
[00:56:32.511] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:28:0)
[00:56:32.536] Build status: STARTED
[00:56:32.537] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:29:0) after 3m25s
[00:59:57.677] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:29:0)
[00:59:57.702] Build status: STARTED
[00:59:57.702] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:30:0) after 6m23s
[01:06:20.790] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:30:0)
[01:06:20.810] Build status: STARTED
[01:06:20.810] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:31:0) after 7m46s
[01:14:06.831] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:31:0)
[01:14:06.907] Build status: STARTED
[01:14:06.908] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:32:0) after 5m15s
[01:19:22.003] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:32:0)
[01:19:22.046] Build status: STARTED
[01:19:22.046] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:33:0) after 8m11s
[01:27:33.076] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:33:0)
[01:27:33.101] Build status: STARTED
[01:27:33.101] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:34:0) after 8m49s
[01:36:22.189] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:34:0)
[01:36:22.205] Build status: STARTED
[01:36:22.205] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:35:0) after 8m45s
[01:45:07.229] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:35:0)
[01:45:07.252] Build status: STARTED
[01:45:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:36:0) after 6m10s
[01:51:17.497] Handling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:36:0)
[01:51:17.566] Build status: STARTED
[01:51:17.567] Scheduling timer "check-buildbucket-build-status" (chromium/GPU Win x64 Builder:8897318530005858512:37:0) after 9m16s
[01:57:54.635] Received PubSub notification, asking Buildbucket for the build status
[01:57:54.657] Build:
{
"id": "8731888467575206049",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "GPU Win x64 Builder"
},
"number": 70665,
"createdBy": "project:chromium",
"createTime": "2024-11-07T22:40:56.957490103Z",
"startTime": "2024-11-07T22:45:13.365399004Z",
"endTime": "2024-11-08T01:57:53.998400230Z",
"updateTime": "2024-11-08T01:57:53.998400230Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ffca9c169a23fc1884e7fda28d3af60c24a6eff2",
"ref": "refs/heads/main"
}
}
}
[01:57:54.657] Invocation finished in 3h16m59.400979645s with status SUCCEEDED