[19:41:53.044] New invocation is queued and will start shortly
[19:41:54.295] Starting the invocation (attempt 1)
[19:41:54.324] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80"
[19:41:54.324] Popped gitiles commit info from properties and tags
[19:41:54.324] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:41:54.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:41:54.325] Buildbucket request:
{
"requestId": "8912006502596265328",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912006502596265328",
"job": "fuchsia/prod-qemu-mac-arm64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a6a33760a33e5f6b73b139e1e6c87fb6663c76ea"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a6a33760a33e5f6b73b139e1e6c87fb6663c76ea",
"title": "a6a33760a33e5f6b73b139e1e6c87fb6663c76ea",
"url": "https://qemu.googlesource.com/qemu/+/a6a33760a33e5f6b73b139e1e6c87fb6663c76ea"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "36db37af3499589dace9edbf29e9000182efe808"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@36db37af3499589dace9edbf29e9000182efe808",
"title": "36db37af3499589dace9edbf29e9000182efe808",
"url": "https://qemu.googlesource.com/qemu/+/36db37af3499589dace9edbf29e9000182efe808"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "51a1718b14a57c619d9897c25a59fab75cc980cc"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@51a1718b14a57c619d9897c25a59fab75cc980cc",
"title": "51a1718b14a57c619d9897c25a59fab75cc980cc",
"url": "https://qemu.googlesource.com/qemu/+/51a1718b14a57c619d9897c25a59fab75cc980cc"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "62613ca07382cb7a2d5f442d8a21e340c384a392"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@62613ca07382cb7a2d5f442d8a21e340c384a392",
"title": "62613ca07382cb7a2d5f442d8a21e340c384a392",
"url": "https://qemu.googlesource.com/qemu/+/62613ca07382cb7a2d5f442d8a21e340c384a392"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a90e319569547ac7477606301b93491f3b886569"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a90e319569547ac7477606301b93491f3b886569",
"title": "a90e319569547ac7477606301b93491f3b886569",
"url": "https://qemu.googlesource.com/qemu/+/a90e319569547ac7477606301b93491f3b886569"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "9bbbcf5ddb5ae6e006ca394a9ec01492ac6d8122"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@9bbbcf5ddb5ae6e006ca394a9ec01492ac6d8122",
"title": "9bbbcf5ddb5ae6e006ca394a9ec01492ac6d8122",
"url": "https://qemu.googlesource.com/qemu/+/9bbbcf5ddb5ae6e006ca394a9ec01492ac6d8122"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e64054552385aced493969af6f8341d944e150a8"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e64054552385aced493969af6f8341d944e150a8",
"title": "e64054552385aced493969af6f8341d944e150a8",
"url": "https://qemu.googlesource.com/qemu/+/e64054552385aced493969af6f8341d944e150a8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "619f6891ffb252ae1a4ca0e13a630bd3c13d198c"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@619f6891ffb252ae1a4ca0e13a630bd3c13d198c",
"title": "619f6891ffb252ae1a4ca0e13a630bd3c13d198c",
"url": "https://qemu.googlesource.com/qemu/+/619f6891ffb252ae1a4ca0e13a630bd3c13d198c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "5331339651dbf081cb78c219f000dab243022de9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@5331339651dbf081cb78c219f000dab243022de9",
"title": "5331339651dbf081cb78c219f000dab243022de9",
"url": "https://qemu.googlesource.com/qemu/+/5331339651dbf081cb78c219f000dab243022de9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "31b2d4a1b3136f727866326b2cee5e993ea36e8a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@31b2d4a1b3136f727866326b2cee5e993ea36e8a",
"title": "31b2d4a1b3136f727866326b2cee5e993ea36e8a",
"url": "https://qemu.googlesource.com/qemu/+/31b2d4a1b3136f727866326b2cee5e993ea36e8a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "67b765d3f3f1430abfc97915063740d12f2f7dba"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@67b765d3f3f1430abfc97915063740d12f2f7dba",
"title": "67b765d3f3f1430abfc97915063740d12f2f7dba",
"url": "https://qemu.googlesource.com/qemu/+/67b765d3f3f1430abfc97915063740d12f2f7dba"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a47d08ee0d45f98284806b2ddeda83bb33a2b351"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a47d08ee0d45f98284806b2ddeda83bb33a2b351",
"title": "a47d08ee0d45f98284806b2ddeda83bb33a2b351",
"url": "https://qemu.googlesource.com/qemu/+/a47d08ee0d45f98284806b2ddeda83bb33a2b351"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "be0fcbc462bb97605cc5d37b5f13a3a28c1417ac"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@be0fcbc462bb97605cc5d37b5f13a3a28c1417ac",
"title": "be0fcbc462bb97605cc5d37b5f13a3a28c1417ac",
"url": "https://qemu.googlesource.com/qemu/+/be0fcbc462bb97605cc5d37b5f13a3a28c1417ac"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "fa8718c76681105b55895aa189e3f6f6e0358b2a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@fa8718c76681105b55895aa189e3f6f6e0358b2a",
"title": "fa8718c76681105b55895aa189e3f6f6e0358b2a",
"url": "https://qemu.googlesource.com/qemu/+/fa8718c76681105b55895aa189e3f6f6e0358b2a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e7fca81e170530104c36bd8f3e1d7e7c11011481"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e7fca81e170530104c36bd8f3e1d7e7c11011481",
"title": "e7fca81e170530104c36bd8f3e1d7e7c11011481",
"url": "https://qemu.googlesource.com/qemu/+/e7fca81e170530104c36bd8f3e1d7e7c11011481"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "3e964275d65b92075249201c49b39dfb06d08ad4"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@3e964275d65b92075249201c49b39dfb06d08ad4",
"title": "3e964275d65b92075249201c49b39dfb06d08ad4",
"url": "https://qemu.googlesource.com/qemu/+/3e964275d65b92075249201c49b39dfb06d08ad4"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "84aacddd808b87824bca68006da0f73a1d0905f1"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@84aacddd808b87824bca68006da0f73a1d0905f1",
"title": "84aacddd808b87824bca68006da0f73a1d0905f1",
"url": "https://qemu.googlesource.com/qemu/+/84aacddd808b87824bca68006da0f73a1d0905f1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "3efc75ad9d9317e5709861bbebb2c29390f8e7a2"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@3efc75ad9d9317e5709861bbebb2c29390f8e7a2",
"title": "3efc75ad9d9317e5709861bbebb2c29390f8e7a2",
"url": "https://qemu.googlesource.com/qemu/+/3efc75ad9d9317e5709861bbebb2c29390f8e7a2"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "bde26d90ae9f7551cac90e117fc7216c807a3bfe"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@bde26d90ae9f7551cac90e117fc7216c807a3bfe",
"title": "bde26d90ae9f7551cac90e117fc7216c807a3bfe",
"url": "https://qemu.googlesource.com/qemu/+/bde26d90ae9f7551cac90e117fc7216c807a3bfe"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "2523baf7fb4ddca900647be7ac39bce31eae2d42"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@2523baf7fb4ddca900647be7ac39bce31eae2d42",
"title": "2523baf7fb4ddca900647be7ac39bce31eae2d42",
"url": "https://qemu.googlesource.com/qemu/+/2523baf7fb4ddca900647be7ac39bce31eae2d42"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a3b3ad72e81072321a7ea996d722c1eabaca7031"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a3b3ad72e81072321a7ea996d722c1eabaca7031",
"title": "a3b3ad72e81072321a7ea996d722c1eabaca7031",
"url": "https://qemu.googlesource.com/qemu/+/a3b3ad72e81072321a7ea996d722c1eabaca7031"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "b04091393e6a71065aee6c91b2566f2dec95a4c9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@b04091393e6a71065aee6c91b2566f2dec95a4c9",
"title": "b04091393e6a71065aee6c91b2566f2dec95a4c9",
"url": "https://qemu.googlesource.com/qemu/+/b04091393e6a71065aee6c91b2566f2dec95a4c9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80",
"title": "3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80",
"url": "https://qemu.googlesource.com/qemu/+/3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912006502596265328"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-qemu-mac-arm64-74eaa511"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:41:54.776] Scheduled build:
{
"id": "8746576440530074113",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-29T19:41:54.390572057Z",
"updateTime": "2024-05-29T19:41:54.390572057Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80",
"ref": "refs/heads/master"
}
},
"canary": true
}
[19:41:54.776] Task URL: https://cr-buildbucket.appspot.com/build/8746576440530074113
[19:41:54.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:2:0) after 7m57s
[19:41:55.769] Received PubSub notification, asking Buildbucket for the build status
[19:41:55.790] Build status: SCHEDULED
[19:49:51.797] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:2:0)
[19:49:52.067] Build status: SCHEDULED
[19:49:52.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:4:0) after 3m41s
[19:53:33.085] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:4:0)
[19:53:33.110] Build status: SCHEDULED
[19:53:33.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:5:0) after 7m8s
[20:00:41.185] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:5:0)
[20:00:41.206] Build status: SCHEDULED
[20:00:41.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:6:0) after 1m33s
[20:02:14.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:6:0)
[20:02:14.296] Build status: SCHEDULED
[20:02:14.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:7:0) after 4m16s
[20:06:30.313] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:7:0)
[20:06:30.353] Build status: SCHEDULED
[20:06:30.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:8:0) after 3m16s
[20:09:46.370] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:8:0)
[20:09:46.387] Build status: SCHEDULED
[20:09:46.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:9:0) after 3m4s
[20:12:50.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:9:0)
[20:12:50.429] Build status: SCHEDULED
[20:12:50.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:10:0) after 9m41s
[20:22:31.531] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:10:0)
[20:22:31.549] Build status: SCHEDULED
[20:22:31.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:11:0) after 3m40s
[20:26:11.569] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:11:0)
[20:26:11.589] Build status: SCHEDULED
[20:26:11.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:12:0) after 2m1s
[20:28:12.591] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:12:0)
[20:28:12.613] Build status: SCHEDULED
[20:28:12.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:13:0) after 6m59s
[20:35:11.708] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:13:0)
[20:35:11.729] Build status: SCHEDULED
[20:35:11.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:14:0) after 7m45s
[20:42:56.725] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:14:0)
[20:42:56.742] Build status: SCHEDULED
[20:42:56.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:15:0) after 5m18s
[20:48:14.819] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:15:0)
[20:48:14.835] Build status: SCHEDULED
[20:48:14.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:16:0) after 8m45s
[20:56:59.906] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:16:0)
[20:56:59.924] Build status: SCHEDULED
[20:56:59.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:17:0) after 5m50s
[21:02:50.036] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:17:0)
[21:02:50.065] Build status: SCHEDULED
[21:02:50.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:18:0) after 9m13s
[21:12:03.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:18:0)
[21:12:03.216] Build status: SCHEDULED
[21:12:03.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:19:0) after 9m39s
[21:21:42.281] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:19:0)
[21:21:42.353] Build status: SCHEDULED
[21:21:42.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:20:0) after 1m21s
[21:23:03.370] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:20:0)
[21:23:03.403] Build status: SCHEDULED
[21:23:03.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:21:0) after 9m35s
[21:24:13.514] Received PubSub notification, asking Buildbucket for the build status
[21:24:13.578] Build status: STARTED
[21:32:38.441] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:21:0)
[21:32:38.461] Build status: STARTED
[21:32:38.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8912006502596265328:23:0) after 5m25s
[21:37:14.593] Received PubSub notification, asking Buildbucket for the build status
[21:37:14.615] Build:
{
"id": "8746576440530074113",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-29T19:41:54.390572057Z",
"startTime": "2024-05-29T21:24:13.272508428Z",
"endTime": "2024-05-29T21:37:14.311917406Z",
"updateTime": "2024-05-29T21:37:14.311917406Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "3b2fe44bb7f605f179e5e7feb2c13c2eb3abbb80",
"ref": "refs/heads/master"
}
},
"canary": true
}
[21:37:14.615] Invocation finished in 1h55m21.579179264s with status SUCCEEDED