[16:42:57.014] New invocation is queued and will start shortly
[16:42:58.085] Starting the invocation (attempt 1)
[16:42:58.112] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/e3debd5e7d0ce031356024878a0a18b9d109354a"
[16:42:58.113] Popped gitiles commit info from properties and tags
[16:42:58.113] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:42:58.113] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:42:58.113] Buildbucket request:
{
"requestId": "8951065052656783136",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951065052656783136",
"job": "fuchsia/ci-qemu-mac-x64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0fcd574b025fccdf14d5140687cafe2bc30b634f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0fcd574b025fccdf14d5140687cafe2bc30b634f",
"title": "0fcd574b025fccdf14d5140687cafe2bc30b634f",
"url": "https://qemu.googlesource.com/qemu/+/0fcd574b025fccdf14d5140687cafe2bc30b634f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "f75e4f2234e7339c16c1dba048bf131a2a948f84"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@f75e4f2234e7339c16c1dba048bf131a2a948f84",
"title": "f75e4f2234e7339c16c1dba048bf131a2a948f84",
"url": "https://qemu.googlesource.com/qemu/+/f75e4f2234e7339c16c1dba048bf131a2a948f84"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0030b244a7dc8411b534854167c62817511c5f0e"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0030b244a7dc8411b534854167c62817511c5f0e",
"title": "0030b244a7dc8411b534854167c62817511c5f0e",
"url": "https://qemu.googlesource.com/qemu/+/0030b244a7dc8411b534854167c62817511c5f0e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "d091b5b442ea0b28bea2d108dad5dfe1ee2ac7cc"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@d091b5b442ea0b28bea2d108dad5dfe1ee2ac7cc",
"title": "d091b5b442ea0b28bea2d108dad5dfe1ee2ac7cc",
"url": "https://qemu.googlesource.com/qemu/+/d091b5b442ea0b28bea2d108dad5dfe1ee2ac7cc"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "f79283fdb8efca0cd6e818bebad12f367e83f6e6"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@f79283fdb8efca0cd6e818bebad12f367e83f6e6",
"title": "f79283fdb8efca0cd6e818bebad12f367e83f6e6",
"url": "https://qemu.googlesource.com/qemu/+/f79283fdb8efca0cd6e818bebad12f367e83f6e6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "07e4804fcde1559aaa335fd680487ba308d86fb3"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@07e4804fcde1559aaa335fd680487ba308d86fb3",
"title": "07e4804fcde1559aaa335fd680487ba308d86fb3",
"url": "https://qemu.googlesource.com/qemu/+/07e4804fcde1559aaa335fd680487ba308d86fb3"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "7b1bde956096ff13d97ee38b5340d6a977b848dc"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@7b1bde956096ff13d97ee38b5340d6a977b848dc",
"title": "7b1bde956096ff13d97ee38b5340d6a977b848dc",
"url": "https://qemu.googlesource.com/qemu/+/7b1bde956096ff13d97ee38b5340d6a977b848dc"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8f03c08506b5a20e1dd003cf3cd0198c867cfe85"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8f03c08506b5a20e1dd003cf3cd0198c867cfe85",
"title": "8f03c08506b5a20e1dd003cf3cd0198c867cfe85",
"url": "https://qemu.googlesource.com/qemu/+/8f03c08506b5a20e1dd003cf3cd0198c867cfe85"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "da80f11efeea451eaa00e347f722d867ed9ac5be"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@da80f11efeea451eaa00e347f722d867ed9ac5be",
"title": "da80f11efeea451eaa00e347f722d867ed9ac5be",
"url": "https://qemu.googlesource.com/qemu/+/da80f11efeea451eaa00e347f722d867ed9ac5be"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8635a3a153da3a6712c4ee249c2bf3513cbfdbf7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8635a3a153da3a6712c4ee249c2bf3513cbfdbf7",
"title": "8635a3a153da3a6712c4ee249c2bf3513cbfdbf7",
"url": "https://qemu.googlesource.com/qemu/+/8635a3a153da3a6712c4ee249c2bf3513cbfdbf7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "670d8c6ebf7a2c425575bbd6fbaeb27d21edd6c6"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@670d8c6ebf7a2c425575bbd6fbaeb27d21edd6c6",
"title": "670d8c6ebf7a2c425575bbd6fbaeb27d21edd6c6",
"url": "https://qemu.googlesource.com/qemu/+/670d8c6ebf7a2c425575bbd6fbaeb27d21edd6c6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a219645ce36db9fd3e574e5ef475cad0457c6264"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a219645ce36db9fd3e574e5ef475cad0457c6264",
"title": "a219645ce36db9fd3e574e5ef475cad0457c6264",
"url": "https://qemu.googlesource.com/qemu/+/a219645ce36db9fd3e574e5ef475cad0457c6264"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "d82e2e76358dec42ba42b7e54bdc7ae61493fc9a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@d82e2e76358dec42ba42b7e54bdc7ae61493fc9a",
"title": "d82e2e76358dec42ba42b7e54bdc7ae61493fc9a",
"url": "https://qemu.googlesource.com/qemu/+/d82e2e76358dec42ba42b7e54bdc7ae61493fc9a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e3debd5e7d0ce031356024878a0a18b9d109354a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e3debd5e7d0ce031356024878a0a18b9d109354a",
"title": "e3debd5e7d0ce031356024878a0a18b9d109354a",
"url": "https://qemu.googlesource.com/qemu/+/e3debd5e7d0ce031356024878a0a18b9d109354a"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "e3debd5e7d0ce031356024878a0a18b9d109354a",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951065052656783136"
},
{
"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"
}
}
[16:42:58.440] Scheduled build:
{
"id": "8785634990777590193",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-25T16:42:58.183369771Z",
"updateTime": "2023-03-25T16:42:58.183369771Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "e3debd5e7d0ce031356024878a0a18b9d109354a",
"ref": "refs/heads/master"
}
},
"canary": true
}
[16:42:58.440] Task URL: https://cr-buildbucket.appspot.com/build/8785634990777590193
[16:42:58.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:2:0) after 5m38s
[16:43:46.366] Received PubSub notification, asking Buildbucket for the build status
[16:43:46.392] Build status: STARTED
[16:48:36.474] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:2:0)
[16:48:36.493] Build status: STARTED
[16:48:36.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:4:0) after 2m49s
[16:51:25.523] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:4:0)
[16:51:25.551] Build status: STARTED
[16:51:25.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:5:0) after 7m28s
[16:58:53.568] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:5:0)
[16:58:53.603] Build status: STARTED
[16:58:53.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:6:0) after 2m26s
[17:01:19.868] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:6:0)
[17:01:19.897] Build status: STARTED
[17:01:19.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:7:0) after 1m39s
[17:02:58.930] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:7:0)
[17:02:58.951] Build status: STARTED
[17:02:58.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:8:0) after 3m46s
[17:06:44.968] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:8:0)
[17:06:44.991] Build status: STARTED
[17:06:44.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:9:0) after 2m42s
[17:09:27.016] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:9:0)
[17:09:27.039] Build status: STARTED
[17:09:27.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:10:0) after 4m39s
[17:14:06.088] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:10:0)
[17:14:06.116] Build status: STARTED
[17:14:06.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:11:0) after 3m8s
[17:17:14.156] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:11:0)
[17:17:14.191] Build status: STARTED
[17:17:14.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:12:0) after 2m15s
[17:19:29.222] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:12:0)
[17:19:29.241] Build status: STARTED
[17:19:29.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:13:0) after 6m43s
[17:26:12.285] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:13:0)
[17:26:12.306] Build status: STARTED
[17:26:12.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8951065052656783136:14:0) after 8m48s
[17:33:04.890] Received PubSub notification, asking Buildbucket for the build status
[17:33:04.924] Build:
{
"id": "8785634990777590193",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-25T16:42:58.183369771Z",
"startTime": "2023-03-25T16:43:45.817950Z",
"endTime": "2023-03-25T17:33:04.572789485Z",
"updateTime": "2023-03-25T17:33:04.572789485Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "e3debd5e7d0ce031356024878a0a18b9d109354a",
"ref": "refs/heads/master"
}
},
"canary": true
}
[17:33:04.924] Invocation finished in 50m7.917260691s with status SUCCEEDED