[07:41:50.320] New invocation is queued and will start shortly
[07:41:51.415] Starting the invocation (attempt 1)
[07:41:51.444] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/cc5ee50fff9dbac0aac32cd892a7163c7babcca1"
[07:41:51.444] Popped gitiles commit info from properties and tags
[07:41:51.444] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:41:51.444] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:41:51.445] Buildbucket request:
{
"requestId": "8948018799604962912",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948018799604962912",
"job": "fuchsia/ci-qemu-mac-x64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "ec5ffa0056389c3c10ea2de1e78366f66f4e5abc"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@ec5ffa0056389c3c10ea2de1e78366f66f4e5abc",
"title": "ec5ffa0056389c3c10ea2de1e78366f66f4e5abc",
"url": "https://qemu.googlesource.com/qemu/+/ec5ffa0056389c3c10ea2de1e78366f66f4e5abc"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "fa6ecc9bc0ce95079440e476fbe433dfcf8b18bf"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@fa6ecc9bc0ce95079440e476fbe433dfcf8b18bf",
"title": "fa6ecc9bc0ce95079440e476fbe433dfcf8b18bf",
"url": "https://qemu.googlesource.com/qemu/+/fa6ecc9bc0ce95079440e476fbe433dfcf8b18bf"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a0d201b8c9abe520883cb3d1117c11bf4336309d"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a0d201b8c9abe520883cb3d1117c11bf4336309d",
"title": "a0d201b8c9abe520883cb3d1117c11bf4336309d",
"url": "https://qemu.googlesource.com/qemu/+/a0d201b8c9abe520883cb3d1117c11bf4336309d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4d3bd91b26a69b39a178744d3d6e5f23050afb23"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4d3bd91b26a69b39a178744d3d6e5f23050afb23",
"title": "4d3bd91b26a69b39a178744d3d6e5f23050afb23",
"url": "https://qemu.googlesource.com/qemu/+/4d3bd91b26a69b39a178744d3d6e5f23050afb23"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8b869aa59109d238fd684e1ade204b6942202120"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8b869aa59109d238fd684e1ade204b6942202120",
"title": "8b869aa59109d238fd684e1ade204b6942202120",
"url": "https://qemu.googlesource.com/qemu/+/8b869aa59109d238fd684e1ade204b6942202120"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "c1654c3e37c31fb638597efedcd07d071837b78b"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@c1654c3e37c31fb638597efedcd07d071837b78b",
"title": "c1654c3e37c31fb638597efedcd07d071837b78b",
"url": "https://qemu.googlesource.com/qemu/+/c1654c3e37c31fb638597efedcd07d071837b78b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "df1f50c3c427a6143826fc420aa62bfa0b83b1ba"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@df1f50c3c427a6143826fc420aa62bfa0b83b1ba",
"title": "df1f50c3c427a6143826fc420aa62bfa0b83b1ba",
"url": "https://qemu.googlesource.com/qemu/+/df1f50c3c427a6143826fc420aa62bfa0b83b1ba"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "ca3b0dc3d7450fb5b2eaff4de584ef3eb10466ff"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@ca3b0dc3d7450fb5b2eaff4de584ef3eb10466ff",
"title": "ca3b0dc3d7450fb5b2eaff4de584ef3eb10466ff",
"url": "https://qemu.googlesource.com/qemu/+/ca3b0dc3d7450fb5b2eaff4de584ef3eb10466ff"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "dd562bbfd73cbd937a6fc393887efa804b2fad08"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@dd562bbfd73cbd937a6fc393887efa804b2fad08",
"title": "dd562bbfd73cbd937a6fc393887efa804b2fad08",
"url": "https://qemu.googlesource.com/qemu/+/dd562bbfd73cbd937a6fc393887efa804b2fad08"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e354d99afc5dacb8f823cc40032af22f641cf4ea"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e354d99afc5dacb8f823cc40032af22f641cf4ea",
"title": "e354d99afc5dacb8f823cc40032af22f641cf4ea",
"url": "https://qemu.googlesource.com/qemu/+/e354d99afc5dacb8f823cc40032af22f641cf4ea"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "ab8eff7c1c4d95b841b1a318e1b406b8cf759936"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@ab8eff7c1c4d95b841b1a318e1b406b8cf759936",
"title": "ab8eff7c1c4d95b841b1a318e1b406b8cf759936",
"url": "https://qemu.googlesource.com/qemu/+/ab8eff7c1c4d95b841b1a318e1b406b8cf759936"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6ee362423609738f64d6efcecf53265dc78ff5f1"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6ee362423609738f64d6efcecf53265dc78ff5f1",
"title": "6ee362423609738f64d6efcecf53265dc78ff5f1",
"url": "https://qemu.googlesource.com/qemu/+/6ee362423609738f64d6efcecf53265dc78ff5f1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "d044b7c33a564e50e0a6b156d71b3262f1faf0a7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@d044b7c33a564e50e0a6b156d71b3262f1faf0a7",
"title": "d044b7c33a564e50e0a6b156d71b3262f1faf0a7",
"url": "https://qemu.googlesource.com/qemu/+/d044b7c33a564e50e0a6b156d71b3262f1faf0a7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4f513984edba8bf7e615ad08d54987e47d94a0be"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4f513984edba8bf7e615ad08d54987e47d94a0be",
"title": "4f513984edba8bf7e615ad08d54987e47d94a0be",
"url": "https://qemu.googlesource.com/qemu/+/4f513984edba8bf7e615ad08d54987e47d94a0be"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "d035fb106f9de71ad5caaa3a615104c6793107e8"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@d035fb106f9de71ad5caaa3a615104c6793107e8",
"title": "d035fb106f9de71ad5caaa3a615104c6793107e8",
"url": "https://qemu.googlesource.com/qemu/+/d035fb106f9de71ad5caaa3a615104c6793107e8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6a0057aa22fedf4d6d39b749923e1d6046803fd8"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6a0057aa22fedf4d6d39b749923e1d6046803fd8",
"title": "6a0057aa22fedf4d6d39b749923e1d6046803fd8",
"url": "https://qemu.googlesource.com/qemu/+/6a0057aa22fedf4d6d39b749923e1d6046803fd8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "067109a11c83e0b461d7a1a9b531b4c738323477"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@067109a11c83e0b461d7a1a9b531b4c738323477",
"title": "067109a11c83e0b461d7a1a9b531b4c738323477",
"url": "https://qemu.googlesource.com/qemu/+/067109a11c83e0b461d7a1a9b531b4c738323477"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "ef46ae67ba9a785cf0cce58b5fc5a36ed3c6c7b9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@ef46ae67ba9a785cf0cce58b5fc5a36ed3c6c7b9",
"title": "ef46ae67ba9a785cf0cce58b5fc5a36ed3c6c7b9",
"url": "https://qemu.googlesource.com/qemu/+/ef46ae67ba9a785cf0cce58b5fc5a36ed3c6c7b9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "cc5ee50fff9dbac0aac32cd892a7163c7babcca1"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@cc5ee50fff9dbac0aac32cd892a7163c7babcca1",
"title": "cc5ee50fff9dbac0aac32cd892a7163c7babcca1",
"url": "https://qemu.googlesource.com/qemu/+/cc5ee50fff9dbac0aac32cd892a7163c7babcca1"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cc5ee50fff9dbac0aac32cd892a7163c7babcca1",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948018799604962912"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/ci-qemu-mac-x64-74eaa511"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:41:51.816] Scheduled build:
{
"id": "8782588737685238225",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-28T07:41:51.518855862Z",
"updateTime": "2023-04-28T07:41:51.518855862Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cc5ee50fff9dbac0aac32cd892a7163c7babcca1",
"ref": "refs/heads/master"
}
}
}
[07:41:51.816] Task URL: https://cr-buildbucket.appspot.com/build/8782588737685238225
[07:41:51.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:2:0) after 5m57s
[07:47:49.463] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:2:0)
[07:47:49.485] Build status: SCHEDULED
[07:47:49.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:3:0) after 5m3s
[07:52:52.593] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:3:0)
[07:52:52.629] Build status: SCHEDULED
[07:52:52.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:4:0) after 6m39s
[07:59:31.647] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:4:0)
[07:59:31.669] Build status: SCHEDULED
[07:59:31.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:5:0) after 9m26s
[08:02:54.696] Received PubSub notification, asking Buildbucket for the build status
[08:02:54.719] Build status: STARTED
[08:08:58.189] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:5:0)
[08:08:58.212] Build status: STARTED
[08:08:58.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:7:0) after 1m59s
[08:10:57.231] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:7:0)
[08:10:57.253] Build status: STARTED
[08:10:57.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:8:0) after 8m30s
[08:19:27.280] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:8:0)
[08:19:27.317] Build status: STARTED
[08:19:27.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:9:0) after 6m49s
[08:26:16.436] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:9:0)
[08:26:16.499] Build status: STARTED
[08:26:16.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:10:0) after 6m19s
[08:32:35.634] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:10:0)
[08:32:35.667] Build status: STARTED
[08:32:35.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:11:0) after 7m34s
[08:40:09.692] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:11:0)
[08:40:09.715] Build status: STARTED
[08:40:09.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8948018799604962912:12:0) after 9m13s
[08:48:22.247] Received PubSub notification, asking Buildbucket for the build status
[08:48:22.271] Build:
{
"id": "8782588737685238225",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-28T07:41:51.518855862Z",
"startTime": "2023-04-28T08:02:54.016566Z",
"endTime": "2023-04-28T08:48:21.869379596Z",
"updateTime": "2023-04-28T08:48:21.869379596Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cc5ee50fff9dbac0aac32cd892a7163c7babcca1",
"ref": "refs/heads/master"
}
}
}
[08:48:22.271] Invocation finished in 1h6m31.966874129s with status SUCCEEDED