[17:42:01.432] New invocation is queued and will start shortly
[17:42:02.676] Starting the invocation (attempt 1)
[17:42:02.712] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/284c52eec2d0a1b9c47f06c3eee46762c5fc0915"
[17:42:02.712] Popped gitiles commit info from properties and tags
[17:42:02.712] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:42:02.712] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:42:02.713] Buildbucket request:
{
"requestId": "8952148499686366320",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952148499686366320",
"job": "fuchsia/ci-qemu-mac-x64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8278e30c459e21db93c17d2182ad8352ec2dd4f9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8278e30c459e21db93c17d2182ad8352ec2dd4f9",
"title": "8278e30c459e21db93c17d2182ad8352ec2dd4f9",
"url": "https://qemu.googlesource.com/qemu/+/8278e30c459e21db93c17d2182ad8352ec2dd4f9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a59100a9b0733149484d52af61db69f1bf4db60e"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a59100a9b0733149484d52af61db69f1bf4db60e",
"title": "a59100a9b0733149484d52af61db69f1bf4db60e",
"url": "https://qemu.googlesource.com/qemu/+/a59100a9b0733149484d52af61db69f1bf4db60e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "651ccdfa8e31fb06c1f589126db42fa756055a7a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@651ccdfa8e31fb06c1f589126db42fa756055a7a",
"title": "651ccdfa8e31fb06c1f589126db42fa756055a7a",
"url": "https://qemu.googlesource.com/qemu/+/651ccdfa8e31fb06c1f589126db42fa756055a7a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6bbee5dbaae1bebf5e37d3d2083584673d439631"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6bbee5dbaae1bebf5e37d3d2083584673d439631",
"title": "6bbee5dbaae1bebf5e37d3d2083584673d439631",
"url": "https://qemu.googlesource.com/qemu/+/6bbee5dbaae1bebf5e37d3d2083584673d439631"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "3ffef1a55ca3b55fa64d43cd35af5adb2c260463"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@3ffef1a55ca3b55fa64d43cd35af5adb2c260463",
"title": "3ffef1a55ca3b55fa64d43cd35af5adb2c260463",
"url": "https://qemu.googlesource.com/qemu/+/3ffef1a55ca3b55fa64d43cd35af5adb2c260463"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "f5fd677ae7cf7cfb07b12adbfd479c460ddc3ac5"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@f5fd677ae7cf7cfb07b12adbfd479c460ddc3ac5",
"title": "f5fd677ae7cf7cfb07b12adbfd479c460ddc3ac5",
"url": "https://qemu.googlesource.com/qemu/+/f5fd677ae7cf7cfb07b12adbfd479c460ddc3ac5"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "a4aafea26152b58c61c8105ffc574661cdfeb17b"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@a4aafea26152b58c61c8105ffc574661cdfeb17b",
"title": "a4aafea26152b58c61c8105ffc574661cdfeb17b",
"url": "https://qemu.googlesource.com/qemu/+/a4aafea26152b58c61c8105ffc574661cdfeb17b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6eeef4477a8588f44a15458ab560c68d373d1033"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6eeef4477a8588f44a15458ab560c68d373d1033",
"title": "6eeef4477a8588f44a15458ab560c68d373d1033",
"url": "https://qemu.googlesource.com/qemu/+/6eeef4477a8588f44a15458ab560c68d373d1033"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e2a3a2193ef2d252a1b3553e90895189a248bd22"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e2a3a2193ef2d252a1b3553e90895189a248bd22",
"title": "e2a3a2193ef2d252a1b3553e90895189a248bd22",
"url": "https://qemu.googlesource.com/qemu/+/e2a3a2193ef2d252a1b3553e90895189a248bd22"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "faa4ec16419c62d616fcc2dfc02d74d7fcc513d7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@faa4ec16419c62d616fcc2dfc02d74d7fcc513d7",
"title": "faa4ec16419c62d616fcc2dfc02d74d7fcc513d7",
"url": "https://qemu.googlesource.com/qemu/+/faa4ec16419c62d616fcc2dfc02d74d7fcc513d7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "21ac728498c1d529dd0abde1054703946be163da"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@21ac728498c1d529dd0abde1054703946be163da",
"title": "21ac728498c1d529dd0abde1054703946be163da",
"url": "https://qemu.googlesource.com/qemu/+/21ac728498c1d529dd0abde1054703946be163da"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "fd3c3333157a8121e4ba9485677ef5860f8fb2db"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@fd3c3333157a8121e4ba9485677ef5860f8fb2db",
"title": "fd3c3333157a8121e4ba9485677ef5860f8fb2db",
"url": "https://qemu.googlesource.com/qemu/+/fd3c3333157a8121e4ba9485677ef5860f8fb2db"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "abe34282b088499f4e86fff9bb6d6dafd57ae1d0"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@abe34282b088499f4e86fff9bb6d6dafd57ae1d0",
"title": "abe34282b088499f4e86fff9bb6d6dafd57ae1d0",
"url": "https://qemu.googlesource.com/qemu/+/abe34282b088499f4e86fff9bb6d6dafd57ae1d0"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "b7e5374637daffa49657be2c559a0566836a172f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@b7e5374637daffa49657be2c559a0566836a172f",
"title": "b7e5374637daffa49657be2c559a0566836a172f",
"url": "https://qemu.googlesource.com/qemu/+/b7e5374637daffa49657be2c559a0566836a172f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "25657fc6c1b693096e2ceadaa53cd10c1e81c8d9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@25657fc6c1b693096e2ceadaa53cd10c1e81c8d9",
"title": "25657fc6c1b693096e2ceadaa53cd10c1e81c8d9",
"url": "https://qemu.googlesource.com/qemu/+/25657fc6c1b693096e2ceadaa53cd10c1e81c8d9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "6d3b418a4e8d7e74b98ddf3862f8b04e1b198b51"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@6d3b418a4e8d7e74b98ddf3862f8b04e1b198b51",
"title": "6d3b418a4e8d7e74b98ddf3862f8b04e1b198b51",
"url": "https://qemu.googlesource.com/qemu/+/6d3b418a4e8d7e74b98ddf3862f8b04e1b198b51"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8467936e3df3484b4931576a72ae760a1610f022"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8467936e3df3484b4931576a72ae760a1610f022",
"title": "8467936e3df3484b4931576a72ae760a1610f022",
"url": "https://qemu.googlesource.com/qemu/+/8467936e3df3484b4931576a72ae760a1610f022"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "e387ef472f661657df67574e337f0558424f836a"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@e387ef472f661657df67574e337f0558424f836a",
"title": "e387ef472f661657df67574e337f0558424f836a",
"url": "https://qemu.googlesource.com/qemu/+/e387ef472f661657df67574e337f0558424f836a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0a237f4de45b8addbc35a316ee1c0bc7a4887da7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0a237f4de45b8addbc35a316ee1c0bc7a4887da7",
"title": "0a237f4de45b8addbc35a316ee1c0bc7a4887da7",
"url": "https://qemu.googlesource.com/qemu/+/0a237f4de45b8addbc35a316ee1c0bc7a4887da7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "bf5de8c5d66552721fefe08de849c115ca366b56"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@bf5de8c5d66552721fefe08de849c115ca366b56",
"title": "bf5de8c5d66552721fefe08de849c115ca366b56",
"url": "https://qemu.googlesource.com/qemu/+/bf5de8c5d66552721fefe08de849c115ca366b56"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "78ae0e2613831909f1e553d45fae7925ade6c7f7"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@78ae0e2613831909f1e553d45fae7925ade6c7f7",
"title": "78ae0e2613831909f1e553d45fae7925ade6c7f7",
"url": "https://qemu.googlesource.com/qemu/+/78ae0e2613831909f1e553d45fae7925ade6c7f7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4cda177c6016565dda1f1c3f6cff8ab85ef0d016"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4cda177c6016565dda1f1c3f6cff8ab85ef0d016",
"title": "4cda177c6016565dda1f1c3f6cff8ab85ef0d016",
"url": "https://qemu.googlesource.com/qemu/+/4cda177c6016565dda1f1c3f6cff8ab85ef0d016"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "61683d278be8614ba4d5e9cc21226ac50f4f46d0"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@61683d278be8614ba4d5e9cc21226ac50f4f46d0",
"title": "61683d278be8614ba4d5e9cc21226ac50f4f46d0",
"url": "https://qemu.googlesource.com/qemu/+/61683d278be8614ba4d5e9cc21226ac50f4f46d0"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "f02b2c19174e3b5e0823e55cfb50d1b3153a485e"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@f02b2c19174e3b5e0823e55cfb50d1b3153a485e",
"title": "f02b2c19174e3b5e0823e55cfb50d1b3153a485e",
"url": "https://qemu.googlesource.com/qemu/+/f02b2c19174e3b5e0823e55cfb50d1b3153a485e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4bf21c7f748bee42b6f4692f8c37a11d1033b2d1"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4bf21c7f748bee42b6f4692f8c37a11d1033b2d1",
"title": "4bf21c7f748bee42b6f4692f8c37a11d1033b2d1",
"url": "https://qemu.googlesource.com/qemu/+/4bf21c7f748bee42b6f4692f8c37a11d1033b2d1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "284c52eec2d0a1b9c47f06c3eee46762c5fc0915"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@284c52eec2d0a1b9c47f06c3eee46762c5fc0915",
"title": "284c52eec2d0a1b9c47f06c3eee46762c5fc0915",
"url": "https://qemu.googlesource.com/qemu/+/284c52eec2d0a1b9c47f06c3eee46762c5fc0915"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "284c52eec2d0a1b9c47f06c3eee46762c5fc0915",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952148499686366320"
},
{
"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"
}
}
[17:42:03.101] Scheduled build:
{
"id": "8786718437589043057",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-13T17:42:02.786050112Z",
"updateTime": "2023-03-13T17:42:02.786050112Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "284c52eec2d0a1b9c47f06c3eee46762c5fc0915",
"ref": "refs/heads/master"
}
}
}
[17:42:03.101] Task URL: https://cr-buildbucket.appspot.com/build/8786718437589043057
[17:42:03.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:2:0) after 1m33s
[17:43:36.579] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:2:0)
[17:43:36.613] Build status: SCHEDULED
[17:43:36.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:3:0) after 7m42s
[17:51:18.653] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:3:0)
[17:51:18.720] Build status: SCHEDULED
[17:51:18.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:4:0) after 7m51s
[17:59:09.748] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:4:0)
[17:59:09.793] Build status: SCHEDULED
[17:59:09.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:5:0) after 5m55s
[17:59:31.531] Received PubSub notification, asking Buildbucket for the build status
[17:59:31.612] Build status: STARTED
[18:05:04.932] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:5:0)
[18:05:04.956] Build status: STARTED
[18:05:04.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:7:0) after 4m55s
[18:10:00.001] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:7:0)
[18:10:00.041] Build status: STARTED
[18:10:00.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:8:0) after 6m22s
[18:16:22.067] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:8:0)
[18:16:22.102] Build status: STARTED
[18:16:22.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:9:0) after 4m35s
[18:20:57.128] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:9:0)
[18:20:57.164] Build status: STARTED
[18:20:57.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:10:0) after 5m24s
[18:26:21.193] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:10:0)
[18:26:21.214] Build status: STARTED
[18:26:21.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:11:0) after 1m25s
[18:27:46.284] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:11:0)
[18:27:46.321] Build status: STARTED
[18:27:46.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:12:0) after 1m10s
[18:28:56.348] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:12:0)
[18:28:56.375] Build status: STARTED
[18:28:56.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:13:0) after 1m10s
[18:30:06.681] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:13:0)
[18:30:06.712] Build status: STARTED
[18:30:06.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:14:0) after 8m12s
[18:38:18.975] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:14:0)
[18:38:19.008] Build status: STARTED
[18:38:19.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:15:0) after 7m19s
[18:45:38.119] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:15:0)
[18:45:38.164] Build status: STARTED
[18:45:38.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:16:0) after 3m5s
[18:48:43.404] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:16:0)
[18:48:43.429] Build status: STARTED
[18:48:43.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:17:0) after 1m24s
[18:50:07.466] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:17:0)
[18:50:07.493] Build status: STARTED
[18:50:07.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:18:0) after 3m9s
[18:53:16.614] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:18:0)
[18:53:16.643] Build status: STARTED
[18:53:16.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:19:0) after 4m5s
[18:57:21.727] Handling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:19:0)
[18:57:21.841] Build status: STARTED
[18:57:21.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-qemu-mac-x64-74eaa511:8952148499686366320:20:0) after 2m52s
[18:58:00.915] Received PubSub notification, asking Buildbucket for the build status
[18:58:00.947] Build:
{
"id": "8786718437589043057",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-13T17:42:02.786050112Z",
"startTime": "2023-03-13T17:59:30.362743Z",
"endTime": "2023-03-13T18:58:00.668466821Z",
"updateTime": "2023-03-13T18:58:00.668466821Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "284c52eec2d0a1b9c47f06c3eee46762c5fc0915",
"ref": "refs/heads/master"
}
}
}
[18:58:00.947] Invocation finished in 1h15m59.545286719s with status SUCCEEDED