[07:25:02.146] New invocation is queued and will start shortly
[07:25:03.319] Starting the invocation (attempt 1)
[07:25:03.349] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c39d87934cd9726784c187c56f489afca00a0086"
[07:25:03.349] Popped gitiles commit info from properties and tags
[07:25:03.349] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:25:03.349] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:25:03.349] Buildbucket request:
{
"requestId": "8934792699645579376",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux V8 API Stability"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934792699645579376",
"job": "v8/Linux V8 API Stability",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "543adbbf02b3551d07ed8a16a65d9edca2c17975"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@543adbbf02b3551d07ed8a16a65d9edca2c17975",
"title": "543adbbf02b3551d07ed8a16a65d9edca2c17975",
"url": "https://chromium.googlesource.com/chromium/src/+/543adbbf02b3551d07ed8a16a65d9edca2c17975"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e9308dc61447b0800533b7294d96bde76ab80f70"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e9308dc61447b0800533b7294d96bde76ab80f70",
"title": "e9308dc61447b0800533b7294d96bde76ab80f70",
"url": "https://chromium.googlesource.com/chromium/src/+/e9308dc61447b0800533b7294d96bde76ab80f70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4c0668e77a2162091e4a9f758e8574b003bff58c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4c0668e77a2162091e4a9f758e8574b003bff58c",
"title": "4c0668e77a2162091e4a9f758e8574b003bff58c",
"url": "https://chromium.googlesource.com/chromium/src/+/4c0668e77a2162091e4a9f758e8574b003bff58c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4ee0653f27e60f893d831aafbb4ec974dc7ce4a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4ee0653f27e60f893d831aafbb4ec974dc7ce4a2",
"title": "4ee0653f27e60f893d831aafbb4ec974dc7ce4a2",
"url": "https://chromium.googlesource.com/chromium/src/+/4ee0653f27e60f893d831aafbb4ec974dc7ce4a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "66b4335f9aac0551d1289e978cc5ebcb5d795b4e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@66b4335f9aac0551d1289e978cc5ebcb5d795b4e",
"title": "66b4335f9aac0551d1289e978cc5ebcb5d795b4e",
"url": "https://chromium.googlesource.com/chromium/src/+/66b4335f9aac0551d1289e978cc5ebcb5d795b4e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "788150147d613209f3e59880074a4295fa37faac"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@788150147d613209f3e59880074a4295fa37faac",
"title": "788150147d613209f3e59880074a4295fa37faac",
"url": "https://chromium.googlesource.com/chromium/src/+/788150147d613209f3e59880074a4295fa37faac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c39d87934cd9726784c187c56f489afca00a0086"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c39d87934cd9726784c187c56f489afca00a0086",
"title": "c39d87934cd9726784c187c56f489afca00a0086",
"url": "https://chromium.googlesource.com/chromium/src/+/c39d87934cd9726784c187c56f489afca00a0086"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c39d87934cd9726784c187c56f489afca00a0086",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934792699645579376"
},
{
"key": "scheduler_job_id",
"value": "v8/Linux V8 API Stability"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:25:03.927] Scheduled build:
{
"id": "8769362637665460273",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux V8 API Stability"
},
"number": 145293,
"createdBy": "project:v8",
"createTime": "2023-09-21T07:25:03.413399091Z",
"updateTime": "2023-09-21T07:25:03.413399091Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c39d87934cd9726784c187c56f489afca00a0086",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:25:03.927] Task URL: https://cr-buildbucket.appspot.com/build/8769362637665460273
[07:25:03.927] Scheduling timer "check-buildbucket-build-status" (v8/Linux V8 API Stability:8934792699645579376:2:0) after 5m50s
[07:25:04.888] Received PubSub notification, asking Buildbucket for the build status
[07:25:04.923] Build status: SCHEDULED
[07:25:47.073] Received PubSub notification, asking Buildbucket for the build status
[07:25:47.100] Build status: STARTED
[07:30:53.979] Handling timer "check-buildbucket-build-status" (v8/Linux V8 API Stability:8934792699645579376:2:0)
[07:30:54.129] Build status: STARTED
[07:30:54.129] Scheduling timer "check-buildbucket-build-status" (v8/Linux V8 API Stability:8934792699645579376:5:0) after 9m6s
[07:37:59.129] Received PubSub notification, asking Buildbucket for the build status
[07:37:59.147] Build:
{
"id": "8769362637665460273",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux V8 API Stability"
},
"number": 145293,
"createdBy": "project:v8",
"createTime": "2023-09-21T07:25:03.413399091Z",
"startTime": "2023-09-21T07:25:46.464287Z",
"endTime": "2023-09-21T07:37:53.542081202Z",
"updateTime": "2023-09-21T07:37:53.542081202Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c39d87934cd9726784c187c56f489afca00a0086",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:37:59.147] Invocation finished in 12m57.005648717s with status SUCCEEDED