[04:20:25.247] New invocation is queued and will start shortly
[04:20:26.341] Starting the invocation (attempt 1)
[04:20:26.378] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/262fd2146f765e1f334c0b39f4e4a4ba38266e31"
[04:20:26.378] Popped gitiles commit info from properties and tags
[04:20:26.378] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:20:26.378] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:20:26.378] Buildbucket request:
{
"requestId": "9005107560560467712",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "262fd2146f765e1f334c0b39f4e4a4ba38266e31",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9005107560560467712"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-chromeos-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:20:27.386] Scheduled build:
{
"id": "8839677498579646384",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"number": 50115,
"createdBy": "project:chromium",
"createTime": "2021-08-06T04:20:26.498765Z",
"updateTime": "2021-08-06T04:20:27.205157Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "262fd2146f765e1f334c0b39f4e4a4ba38266e31",
"ref": "refs/heads/main"
}
}
}
[04:20:27.386] Task URL: https://cr-buildbucket.appspot.com/build/8839677498579646384
[04:20:27.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:2:0) after 2m57s
[04:20:37.676] Received PubSub notification, asking Buildbucket for the build status
[04:20:37.787] Build status: STARTED
[04:23:24.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:2:0)
[04:23:24.519] Build status: STARTED
[04:23:24.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:4:0) after 8m31s
[04:31:55.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:4:0)
[04:31:55.931] Build status: STARTED
[04:31:55.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:5:0) after 7m46s
[04:39:42.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:5:0)
[04:39:42.090] Build status: STARTED
[04:39:42.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:6:0) after 9m41s
[04:49:23.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:6:0)
[04:49:23.229] Build status: STARTED
[04:49:23.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:7:0) after 5m20s
[04:54:43.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:7:0)
[04:54:43.277] Build status: STARTED
[04:54:43.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9005107560560467712:8:0) after 6m3s
[05:00:26.778] Received PubSub notification, asking Buildbucket for the build status
[05:00:26.811] Build:
{
"id": "8839677498579646384",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"number": 50115,
"createdBy": "project:chromium",
"createTime": "2021-08-06T04:20:26.498765Z",
"startTime": "2021-08-06T04:20:34.501609Z",
"endTime": "2021-08-06T05:00:25.696638402Z",
"updateTime": "2021-08-06T05:00:25.698542332Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "262fd2146f765e1f334c0b39f4e4a4ba38266e31",
"ref": "refs/heads/main"
}
}
}
[05:00:26.811] Invocation finished in 40m1.586015684s with status SUCCEEDED