[14:42:14.732] New invocation is queued and will start shortly
[14:42:15.863] Starting the invocation (attempt 1)
[14:42:15.896] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/568992e3440f11897e209bf676aa5b93251385fa"
[14:42:15.896] Popped gitiles commit info from properties and tags
[14:42:15.896] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:42:15.896] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:42:15.896] Buildbucket request:
{
"requestId": "8946905186299435536",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8946905186299435536",
"job": "fuchsia/ci-qemu-mac-x64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0c7811aeb9ba206a74008ca28f5b8ff8e7f74d04"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0c7811aeb9ba206a74008ca28f5b8ff8e7f74d04",
"title": "0c7811aeb9ba206a74008ca28f5b8ff8e7f74d04",
"url": "https://qemu.googlesource.com/qemu/+/0c7811aeb9ba206a74008ca28f5b8ff8e7f74d04"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a2836b32b02a1d774f8c2504cb368c05d74ad492"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a2836b32b02a1d774f8c2504cb368c05d74ad492",
"title": "a2836b32b02a1d774f8c2504cb368c05d74ad492",
"url": "https://qemu.googlesource.com/qemu/+/a2836b32b02a1d774f8c2504cb368c05d74ad492"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "5b5fe0e018891dc08bcce75f064015c42aeb46a4"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@5b5fe0e018891dc08bcce75f064015c42aeb46a4",
"title": "5b5fe0e018891dc08bcce75f064015c42aeb46a4",
"url": "https://qemu.googlesource.com/qemu/+/5b5fe0e018891dc08bcce75f064015c42aeb46a4"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "88d357d2921669a6bbb35493ac67f4707b0144c8"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@88d357d2921669a6bbb35493ac67f4707b0144c8",
"title": "88d357d2921669a6bbb35493ac67f4707b0144c8",
"url": "https://qemu.googlesource.com/qemu/+/88d357d2921669a6bbb35493ac67f4707b0144c8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "b71fd73cc459ce1ef545a40ff8fbce5ff242b103"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@b71fd73cc459ce1ef545a40ff8fbce5ff242b103",
"title": "b71fd73cc459ce1ef545a40ff8fbce5ff242b103",
"url": "https://qemu.googlesource.com/qemu/+/b71fd73cc459ce1ef545a40ff8fbce5ff242b103"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "f57e1d05bfaf2f41f0793280886ebf1db753794f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@f57e1d05bfaf2f41f0793280886ebf1db753794f",
"title": "f57e1d05bfaf2f41f0793280886ebf1db753794f",
"url": "https://qemu.googlesource.com/qemu/+/f57e1d05bfaf2f41f0793280886ebf1db753794f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "56266c6d1eb9a85a44e34b24eb359c6ac84887f5"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@56266c6d1eb9a85a44e34b24eb359c6ac84887f5",
"title": "56266c6d1eb9a85a44e34b24eb359c6ac84887f5",
"url": "https://qemu.googlesource.com/qemu/+/56266c6d1eb9a85a44e34b24eb359c6ac84887f5"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "22bd6e9c152ae49de62a91f295bd9fc670806aca"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@22bd6e9c152ae49de62a91f295bd9fc670806aca",
"title": "22bd6e9c152ae49de62a91f295bd9fc670806aca",
"url": "https://qemu.googlesource.com/qemu/+/22bd6e9c152ae49de62a91f295bd9fc670806aca"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "5962635561d3f6ce2740b2f2fa110ae796184365"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@5962635561d3f6ce2740b2f2fa110ae796184365",
"title": "5962635561d3f6ce2740b2f2fa110ae796184365",
"url": "https://qemu.googlesource.com/qemu/+/5962635561d3f6ce2740b2f2fa110ae796184365"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a87a9b4d4fc4dcfa2925b1b90474f0ec69d59edf"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a87a9b4d4fc4dcfa2925b1b90474f0ec69d59edf",
"title": "a87a9b4d4fc4dcfa2925b1b90474f0ec69d59edf",
"url": "https://qemu.googlesource.com/qemu/+/a87a9b4d4fc4dcfa2925b1b90474f0ec69d59edf"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "9b2c6746d30a44d222e9124faee59eb05703b6ae"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@9b2c6746d30a44d222e9124faee59eb05703b6ae",
"title": "9b2c6746d30a44d222e9124faee59eb05703b6ae",
"url": "https://qemu.googlesource.com/qemu/+/9b2c6746d30a44d222e9124faee59eb05703b6ae"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "3e32dca3f0d1eddcfecf963d94b9ff60e3e08448"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@3e32dca3f0d1eddcfecf963d94b9ff60e3e08448",
"title": "3e32dca3f0d1eddcfecf963d94b9ff60e3e08448",
"url": "https://qemu.googlesource.com/qemu/+/3e32dca3f0d1eddcfecf963d94b9ff60e3e08448"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "08349786c84306863a3b659c8a9b28bb74c405c6"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@08349786c84306863a3b659c8a9b28bb74c405c6",
"title": "08349786c84306863a3b659c8a9b28bb74c405c6",
"url": "https://qemu.googlesource.com/qemu/+/08349786c84306863a3b659c8a9b28bb74c405c6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "eb59cf76285cb54caba246383821cd7ee2b0f539"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@eb59cf76285cb54caba246383821cd7ee2b0f539",
"title": "eb59cf76285cb54caba246383821cd7ee2b0f539",
"url": "https://qemu.googlesource.com/qemu/+/eb59cf76285cb54caba246383821cd7ee2b0f539"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "9d167491cb2577d0d9394624b41a77ef709e4336"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@9d167491cb2577d0d9394624b41a77ef709e4336",
"title": "9d167491cb2577d0d9394624b41a77ef709e4336",
"url": "https://qemu.googlesource.com/qemu/+/9d167491cb2577d0d9394624b41a77ef709e4336"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "059d341a67bb660a7957cb62a6a860c92c2fb64a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@059d341a67bb660a7957cb62a6a860c92c2fb64a",
"title": "059d341a67bb660a7957cb62a6a860c92c2fb64a",
"url": "https://qemu.googlesource.com/qemu/+/059d341a67bb660a7957cb62a6a860c92c2fb64a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a937b6aa739f65f2cae2ad9a7eb65a309ad2a359"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a937b6aa739f65f2cae2ad9a7eb65a309ad2a359",
"title": "a937b6aa739f65f2cae2ad9a7eb65a309ad2a359",
"url": "https://qemu.googlesource.com/qemu/+/a937b6aa739f65f2cae2ad9a7eb65a309ad2a359"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "568992e3440f11897e209bf676aa5b93251385fa"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@568992e3440f11897e209bf676aa5b93251385fa",
"title": "568992e3440f11897e209bf676aa5b93251385fa",
"url": "https://qemu.googlesource.com/qemu/+/568992e3440f11897e209bf676aa5b93251385fa"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "568992e3440f11897e209bf676aa5b93251385fa",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946905186299435536"
},
{
"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:42:16.220] Scheduled build:
{
"id": "8781475124326860833",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-10T14:42:15.977957921Z",
"updateTime": "2023-05-10T14:42:15.977957921Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "568992e3440f11897e209bf676aa5b93251385fa",
"ref": "refs/heads/master"
}
}
}
[14:42:16.220] Task URL: https://cr-buildbucket.appspot.com/build/8781475124326860833
[14:42:16.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:2:0) after 2m12s
[14:44:28.795] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:2:0)
[14:44:28.826] Build status: SCHEDULED
[14:44:28.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:3:0) after 8m44s
[14:53:12.895] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:3:0)
[14:53:12.921] Build status: SCHEDULED
[14:53:12.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:4:0) after 5m56s
[14:59:08.986] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:4:0)
[14:59:09.016] Build status: SCHEDULED
[14:59:09.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:5:0) after 6m3s
[15:04:48.304] Received PubSub notification, asking Buildbucket for the build status
[15:04:48.325] Build status: STARTED
[15:05:12.474] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:5:0)
[15:05:12.517] Build status: STARTED
[15:05:12.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:7:0) after 1m11s
[15:06:23.720] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:7:0)
[15:06:23.741] Build status: STARTED
[15:06:23.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:8:0) after 7m45s
[15:14:09.304] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:8:0)
[15:14:09.326] Build status: STARTED
[15:14:09.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:9:0) after 4m59s
[15:19:08.349] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:9:0)
[15:19:08.392] Build status: STARTED
[15:19:08.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:10:0) after 3m55s
[15:23:03.492] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:10:0)
[15:23:03.553] Build status: STARTED
[15:23:03.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:11:0) after 5m29s
[15:28:32.745] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:11:0)
[15:28:32.761] Build status: STARTED
[15:28:32.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:12:0) after 6m40s
[15:35:13.331] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:12:0)
[15:35:13.355] Build status: STARTED
[15:35:13.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:13:0) after 2m16s
[15:37:29.366] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:13:0)
[15:37:29.386] Build status: STARTED
[15:37:29.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:14:0) after 5m20s
[15:42:49.452] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:14:0)
[15:42:49.478] Build status: STARTED
[15:42:49.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:15:0) after 5m6s
[15:47:55.496] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:15:0)
[15:47:55.517] Build status: STARTED
[15:47:55.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:16:0) after 2m15s
[15:50:10.540] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:16:0)
[15:50:10.561] Build status: STARTED
[15:50:10.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8946905186299435536:17:0) after 8m31s
[15:52:00.911] Received PubSub notification, asking Buildbucket for the build status
[15:52:00.955] Build:
{
"id": "8781475124326860833",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-10T14:42:15.977957921Z",
"startTime": "2023-05-10T15:04:47.052595Z",
"endTime": "2023-05-10T15:52:00.490238949Z",
"updateTime": "2023-05-10T15:52:00.490238949Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "568992e3440f11897e209bf676aa5b93251385fa",
"ref": "refs/heads/master"
}
}
}
[15:52:00.955] Invocation finished in 1h9m46.24238282s with status SUCCEEDED