[04:07:01.246] New invocation is queued and will start shortly
[04:07:02.420] Starting the invocation (attempt 1)
[04:07:02.503] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1"
[04:07:02.503] Popped gitiles commit info from properties and tags
[04:07:02.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:07:02.503] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:07:02.504] Buildbucket request:
{
"requestId": "8913061885744593280",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux - Future"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913061885744593280",
"job": "v8/Linux - Future",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c242ecce7b2cfc51d6deb931bf067e54ea929353"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c242ecce7b2cfc51d6deb931bf067e54ea929353",
"title": "c242ecce7b2cfc51d6deb931bf067e54ea929353",
"url": "https://chromium.googlesource.com/chromium/src/+/c242ecce7b2cfc51d6deb931bf067e54ea929353"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "421e4595d351eb56e78b3609b1024839bf9d68ed"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@421e4595d351eb56e78b3609b1024839bf9d68ed",
"title": "421e4595d351eb56e78b3609b1024839bf9d68ed",
"url": "https://chromium.googlesource.com/chromium/src/+/421e4595d351eb56e78b3609b1024839bf9d68ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "eb1ddba3c6397fafe5290764711cb089f531cb89"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@eb1ddba3c6397fafe5290764711cb089f531cb89",
"title": "eb1ddba3c6397fafe5290764711cb089f531cb89",
"url": "https://chromium.googlesource.com/chromium/src/+/eb1ddba3c6397fafe5290764711cb089f531cb89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8e9d221de0d92fb03c38ee5474671522d3532786"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@8e9d221de0d92fb03c38ee5474671522d3532786",
"title": "8e9d221de0d92fb03c38ee5474671522d3532786",
"url": "https://chromium.googlesource.com/chromium/src/+/8e9d221de0d92fb03c38ee5474671522d3532786"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c960dc01ae62728fa4f8e614c1ca9dc71b83dec2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c960dc01ae62728fa4f8e614c1ca9dc71b83dec2",
"title": "c960dc01ae62728fa4f8e614c1ca9dc71b83dec2",
"url": "https://chromium.googlesource.com/chromium/src/+/c960dc01ae62728fa4f8e614c1ca9dc71b83dec2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a382b48acd977a9856364d006ead61a105d05866"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a382b48acd977a9856364d006ead61a105d05866",
"title": "a382b48acd977a9856364d006ead61a105d05866",
"url": "https://chromium.googlesource.com/chromium/src/+/a382b48acd977a9856364d006ead61a105d05866"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a1e3f6e87a5cb5cd60922c6af2f9c0dff22a4268"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a1e3f6e87a5cb5cd60922c6af2f9c0dff22a4268",
"title": "a1e3f6e87a5cb5cd60922c6af2f9c0dff22a4268",
"url": "https://chromium.googlesource.com/chromium/src/+/a1e3f6e87a5cb5cd60922c6af2f9c0dff22a4268"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bd1957bdddc897ab99f6e9148d74de7f002051ce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@bd1957bdddc897ab99f6e9148d74de7f002051ce",
"title": "bd1957bdddc897ab99f6e9148d74de7f002051ce",
"url": "https://chromium.googlesource.com/chromium/src/+/bd1957bdddc897ab99f6e9148d74de7f002051ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f432b9c923708689227609515e6a2b6c4a739e56"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@f432b9c923708689227609515e6a2b6c4a739e56",
"title": "f432b9c923708689227609515e6a2b6c4a739e56",
"url": "https://chromium.googlesource.com/chromium/src/+/f432b9c923708689227609515e6a2b6c4a739e56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bc98840c25d23e83a4d708e7edab17c0011b23c0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@bc98840c25d23e83a4d708e7edab17c0011b23c0",
"title": "bc98840c25d23e83a4d708e7edab17c0011b23c0",
"url": "https://chromium.googlesource.com/chromium/src/+/bc98840c25d23e83a4d708e7edab17c0011b23c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "86113379c56fb300dfd5d5e0e8ebdce14505ab8f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@86113379c56fb300dfd5d5e0e8ebdce14505ab8f",
"title": "86113379c56fb300dfd5d5e0e8ebdce14505ab8f",
"url": "https://chromium.googlesource.com/chromium/src/+/86113379c56fb300dfd5d5e0e8ebdce14505ab8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1ab9807f38b03b13b4c7edf730d88f64d40dbbb9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1ab9807f38b03b13b4c7edf730d88f64d40dbbb9",
"title": "1ab9807f38b03b13b4c7edf730d88f64d40dbbb9",
"url": "https://chromium.googlesource.com/chromium/src/+/1ab9807f38b03b13b4c7edf730d88f64d40dbbb9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "78e1b6ba262f98339a51186d5f68fc687856b079"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@78e1b6ba262f98339a51186d5f68fc687856b079",
"title": "78e1b6ba262f98339a51186d5f68fc687856b079",
"url": "https://chromium.googlesource.com/chromium/src/+/78e1b6ba262f98339a51186d5f68fc687856b079"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f3cae71c6a1f716faf9396d9e8fe8effefc9f505"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@f3cae71c6a1f716faf9396d9e8fe8effefc9f505",
"title": "f3cae71c6a1f716faf9396d9e8fe8effefc9f505",
"url": "https://chromium.googlesource.com/chromium/src/+/f3cae71c6a1f716faf9396d9e8fe8effefc9f505"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "add1e4c5b893bb0731cda05dff0df7bd7f8f159e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@add1e4c5b893bb0731cda05dff0df7bd7f8f159e",
"title": "add1e4c5b893bb0731cda05dff0df7bd7f8f159e",
"url": "https://chromium.googlesource.com/chromium/src/+/add1e4c5b893bb0731cda05dff0df7bd7f8f159e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "be187e8add83ae8d57d6df777018b6edd01149a6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@be187e8add83ae8d57d6df777018b6edd01149a6",
"title": "be187e8add83ae8d57d6df777018b6edd01149a6",
"url": "https://chromium.googlesource.com/chromium/src/+/be187e8add83ae8d57d6df777018b6edd01149a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ac50a6aa23c08c64192789aed6e2ace514fae3c2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@ac50a6aa23c08c64192789aed6e2ace514fae3c2",
"title": "ac50a6aa23c08c64192789aed6e2ace514fae3c2",
"url": "https://chromium.googlesource.com/chromium/src/+/ac50a6aa23c08c64192789aed6e2ace514fae3c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1",
"title": "b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1",
"url": "https://chromium.googlesource.com/chromium/src/+/b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913061885744593280"
},
{
"key": "scheduler_job_id",
"value": "v8/Linux - Future"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:07:03.281] Scheduled build:
{
"id": "8747631823678499969",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux - Future"
},
"number": 65493,
"createdBy": "project:v8",
"createTime": "2024-05-18T04:07:02.587802522Z",
"updateTime": "2024-05-18T04:07:02.587802522Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[04:07:03.281] Task URL: https://cr-buildbucket.appspot.com/build/8747631823678499969
[04:07:03.281] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:2:0) after 2m4s
[04:07:04.218] Received PubSub notification, asking Buildbucket for the build status
[04:07:04.235] Build status: SCHEDULED
[04:07:10.323] Received PubSub notification, asking Buildbucket for the build status
[04:07:10.346] Build status: STARTED
[04:09:07.302] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:2:0)
[04:09:07.327] Build status: STARTED
[04:09:07.327] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:5:0) after 9m36s
[04:18:43.349] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:5:0)
[04:18:43.393] Build status: STARTED
[04:18:43.394] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:6:0) after 9m30s
[04:28:13.518] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:6:0)
[04:28:13.609] Build status: STARTED
[04:28:13.609] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:7:0) after 7m48s
[04:36:01.635] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:7:0)
[04:36:01.665] Build status: STARTED
[04:36:01.665] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:8:0) after 2m32s
[04:38:33.873] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:8:0)
[04:38:33.894] Build status: STARTED
[04:38:33.894] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:9:0) after 7m54s
[04:46:28.371] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:9:0)
[04:46:28.390] Build status: STARTED
[04:46:28.390] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:10:0) after 5m27s
[04:51:55.563] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:10:0)
[04:51:55.640] Build status: STARTED
[04:51:55.640] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:11:0) after 7m51s
[04:59:46.756] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:11:0)
[04:59:46.899] Build status: STARTED
[04:59:46.899] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:12:0) after 6m59s
[05:06:46.092] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:12:0)
[05:06:46.115] Build status: STARTED
[05:06:46.115] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:13:0) after 8m13s
[05:14:59.270] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:13:0)
[05:14:59.336] Build status: STARTED
[05:14:59.336] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:14:0) after 4m27s
[05:19:26.433] Handling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:14:0)
[05:19:26.453] Build status: STARTED
[05:19:26.453] Scheduling timer "check-buildbucket-build-status" (v8/Linux - Future:8913061885744593280:15:0) after 7m11s
[05:24:28.684] Received PubSub notification, asking Buildbucket for the build status
[05:24:28.705] Build:
{
"id": "8747631823678499969",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "Linux - Future"
},
"number": 65493,
"createdBy": "project:v8",
"createTime": "2024-05-18T04:07:02.587802522Z",
"startTime": "2024-05-18T04:07:09.986200092Z",
"endTime": "2024-05-18T05:24:28.253804484Z",
"updateTime": "2024-05-18T05:24:28.253804484Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5f37dfdfae3dd163f1b0c5c397bb0bc428d41b1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:24:28.705] Invocation finished in 1h17m27.4716446s with status SUCCEEDED