[14:41:57.360] New invocation is queued and will start shortly
[14:41:58.715] Starting the invocation (attempt 1)
[14:41:58.751] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/cad8db986560668afbaed972e162e3e7a2d3a34c"
[14:41:58.751] Popped gitiles commit info from properties and tags
[14:41:58.751] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:41:58.752] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:41:58.752] Buildbucket request:
{
"requestId": "8952975201258096016",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952975201258096016",
"job": "fuchsia/ci-qemu-mac-x64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "9b29a468bd0ca6994dc3d347a01af743c8fe76a7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@9b29a468bd0ca6994dc3d347a01af743c8fe76a7",
"title": "9b29a468bd0ca6994dc3d347a01af743c8fe76a7",
"url": "https://qemu.googlesource.com/qemu/+/9b29a468bd0ca6994dc3d347a01af743c8fe76a7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "791cb95f23045f2d69364786edf61d289889199d"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@791cb95f23045f2d69364786edf61d289889199d",
"title": "791cb95f23045f2d69364786edf61d289889199d",
"url": "https://qemu.googlesource.com/qemu/+/791cb95f23045f2d69364786edf61d289889199d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "b14037f37f913a21eddadb1e4b53a2f7adf720ad"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@b14037f37f913a21eddadb1e4b53a2f7adf720ad",
"title": "b14037f37f913a21eddadb1e4b53a2f7adf720ad",
"url": "https://qemu.googlesource.com/qemu/+/b14037f37f913a21eddadb1e4b53a2f7adf720ad"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "82e94da587b2c09f5b98dae5265962ae5b24ab5f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@82e94da587b2c09f5b98dae5265962ae5b24ab5f",
"title": "82e94da587b2c09f5b98dae5265962ae5b24ab5f",
"url": "https://qemu.googlesource.com/qemu/+/82e94da587b2c09f5b98dae5265962ae5b24ab5f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "34f73a81e6cb84b2f7fca740887d59504173d2a0"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@34f73a81e6cb84b2f7fca740887d59504173d2a0",
"title": "34f73a81e6cb84b2f7fca740887d59504173d2a0",
"url": "https://qemu.googlesource.com/qemu/+/34f73a81e6cb84b2f7fca740887d59504173d2a0"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6c323aba4096a26a4d7561bb7abfba95a769fd0a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6c323aba4096a26a4d7561bb7abfba95a769fd0a",
"title": "6c323aba4096a26a4d7561bb7abfba95a769fd0a",
"url": "https://qemu.googlesource.com/qemu/+/6c323aba4096a26a4d7561bb7abfba95a769fd0a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "1e001a5a712a41d9acc1bd6cdef0eaf8270c9555"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@1e001a5a712a41d9acc1bd6cdef0eaf8270c9555",
"title": "1e001a5a712a41d9acc1bd6cdef0eaf8270c9555",
"url": "https://qemu.googlesource.com/qemu/+/1e001a5a712a41d9acc1bd6cdef0eaf8270c9555"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "ef0eb67ec96e03e6016c1e72b208f5fcbb455724"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@ef0eb67ec96e03e6016c1e72b208f5fcbb455724",
"title": "ef0eb67ec96e03e6016c1e72b208f5fcbb455724",
"url": "https://qemu.googlesource.com/qemu/+/ef0eb67ec96e03e6016c1e72b208f5fcbb455724"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "5aa281d757960ea79190bcfb25294e2499de165e"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@5aa281d757960ea79190bcfb25294e2499de165e",
"title": "5aa281d757960ea79190bcfb25294e2499de165e",
"url": "https://qemu.googlesource.com/qemu/+/5aa281d757960ea79190bcfb25294e2499de165e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8b744a6a473015a24d528f480b99faf95da50775"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8b744a6a473015a24d528f480b99faf95da50775",
"title": "8b744a6a473015a24d528f480b99faf95da50775",
"url": "https://qemu.googlesource.com/qemu/+/8b744a6a473015a24d528f480b99faf95da50775"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "b22a2d409b1acfdf0d63d1bb3595194ceb3d94da"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@b22a2d409b1acfdf0d63d1bb3595194ceb3d94da",
"title": "b22a2d409b1acfdf0d63d1bb3595194ceb3d94da",
"url": "https://qemu.googlesource.com/qemu/+/b22a2d409b1acfdf0d63d1bb3595194ceb3d94da"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "abe2c4bdb65e8dd9cb2f01c355baa394bf49a8af"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@abe2c4bdb65e8dd9cb2f01c355baa394bf49a8af",
"title": "abe2c4bdb65e8dd9cb2f01c355baa394bf49a8af",
"url": "https://qemu.googlesource.com/qemu/+/abe2c4bdb65e8dd9cb2f01c355baa394bf49a8af"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "c31772ad6883533757d2a7dfe9ce24325e3ec16c"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@c31772ad6883533757d2a7dfe9ce24325e3ec16c",
"title": "c31772ad6883533757d2a7dfe9ce24325e3ec16c",
"url": "https://qemu.googlesource.com/qemu/+/c31772ad6883533757d2a7dfe9ce24325e3ec16c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "456eb81f766b2bdcd2f163fba7107dbdcfbb718a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@456eb81f766b2bdcd2f163fba7107dbdcfbb718a",
"title": "456eb81f766b2bdcd2f163fba7107dbdcfbb718a",
"url": "https://qemu.googlesource.com/qemu/+/456eb81f766b2bdcd2f163fba7107dbdcfbb718a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4934cc5850b66e3282b24e203c507330955601dd"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4934cc5850b66e3282b24e203c507330955601dd",
"title": "4934cc5850b66e3282b24e203c507330955601dd",
"url": "https://qemu.googlesource.com/qemu/+/4934cc5850b66e3282b24e203c507330955601dd"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "5f4c96b779f9b556c3a0e925382a387c222df002"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@5f4c96b779f9b556c3a0e925382a387c222df002",
"title": "5f4c96b779f9b556c3a0e925382a387c222df002",
"url": "https://qemu.googlesource.com/qemu/+/5f4c96b779f9b556c3a0e925382a387c222df002"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "c77432d0efc56273347eb5d8619935052e5ad0a6"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@c77432d0efc56273347eb5d8619935052e5ad0a6",
"title": "c77432d0efc56273347eb5d8619935052e5ad0a6",
"url": "https://qemu.googlesource.com/qemu/+/c77432d0efc56273347eb5d8619935052e5ad0a6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0d588c4f999699a430b32c563fe9ccc1710b8fd7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0d588c4f999699a430b32c563fe9ccc1710b8fd7",
"title": "0d588c4f999699a430b32c563fe9ccc1710b8fd7",
"url": "https://qemu.googlesource.com/qemu/+/0d588c4f999699a430b32c563fe9ccc1710b8fd7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "43b79f3b86c343a8973dc98278ad7f7921bf248d"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@43b79f3b86c343a8973dc98278ad7f7921bf248d",
"title": "43b79f3b86c343a8973dc98278ad7f7921bf248d",
"url": "https://qemu.googlesource.com/qemu/+/43b79f3b86c343a8973dc98278ad7f7921bf248d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "bfbcaae9636260d3b2d997cd958df983298d149d"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@bfbcaae9636260d3b2d997cd958df983298d149d",
"title": "bfbcaae9636260d3b2d997cd958df983298d149d",
"url": "https://qemu.googlesource.com/qemu/+/bfbcaae9636260d3b2d997cd958df983298d149d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "cad8db986560668afbaed972e162e3e7a2d3a34c"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@cad8db986560668afbaed972e162e3e7a2d3a34c",
"title": "cad8db986560668afbaed972e162e3e7a2d3a34c",
"url": "https://qemu.googlesource.com/qemu/+/cad8db986560668afbaed972e162e3e7a2d3a34c"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cad8db986560668afbaed972e162e3e7a2d3a34c",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952975201258096016"
},
{
"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"
}
}
[14:41:59.092] Scheduled build:
{
"id": "8787545139024400449",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-04T14:41:58.859258179Z",
"updateTime": "2023-03-04T14:41:58.859258179Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cad8db986560668afbaed972e162e3e7a2d3a34c",
"ref": "refs/heads/master"
}
}
}
[14:41:59.092] Task URL: https://cr-buildbucket.appspot.com/build/8787545139024400449
[14:41:59.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:2:0) after 3m14s
[14:42:38.227] Received PubSub notification, asking Buildbucket for the build status
[14:42:38.274] Build status: STARTED
[14:45:13.311] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:2:0)
[14:45:13.344] Build status: STARTED
[14:45:13.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:4:0) after 5m56s
[14:51:09.479] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:4:0)
[14:51:09.503] Build status: STARTED
[14:51:09.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:5:0) after 9m42s
[15:00:51.528] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:5:0)
[15:00:51.560] Build status: STARTED
[15:00:51.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:6:0) after 1m49s
[15:02:40.587] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:6:0)
[15:02:40.624] Build status: STARTED
[15:02:40.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:7:0) after 2m31s
[15:05:11.751] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:7:0)
[15:05:11.778] Build status: STARTED
[15:05:11.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:8:0) after 5m32s
[15:10:43.794] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:8:0)
[15:10:43.830] Build status: STARTED
[15:10:43.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:9:0) after 5m18s
[15:16:02.816] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:9:0)
[15:16:02.841] Build status: STARTED
[15:16:02.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:10:0) after 4m0s
[15:20:03.062] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:10:0)
[15:20:03.096] Build status: STARTED
[15:20:03.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:11:0) after 1m11s
[15:21:14.424] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:11:0)
[15:21:14.444] Build status: STARTED
[15:21:14.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:12:0) after 1m31s
[15:22:45.653] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:12:0)
[15:22:45.676] Build status: STARTED
[15:22:45.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:13:0) after 7m55s
[15:30:40.710] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:13:0)
[15:30:40.732] Build status: STARTED
[15:30:40.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:14:0) after 4m50s
[15:35:30.754] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:14:0)
[15:35:30.773] Build status: STARTED
[15:35:30.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952975201258096016:15:0) after 7m37s
[15:38:34.392] Received PubSub notification, asking Buildbucket for the build status
[15:38:34.422] Build:
{
"id": "8787545139024400449",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-04T14:41:58.859258179Z",
"startTime": "2023-03-04T14:42:37.985800180Z",
"endTime": "2023-03-04T15:38:34.175731099Z",
"updateTime": "2023-03-04T15:38:34.175731099Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "cad8db986560668afbaed972e162e3e7a2d3a34c",
"ref": "refs/heads/master"
}
}
}
[15:38:34.422] Invocation finished in 56m37.076570591s with status SUCCEEDED