[05:04:48.594] New invocation is queued and will start shortly
[05:04:49.728] Starting the invocation (attempt 1)
[05:04:49.753] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5f89bf52381d549cc9b732aa411a5e09701063fd"
[05:04:49.753] Popped gitiles commit info from properties and tags
[05:04:49.753] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:04:49.754] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:04:49.755] Buildbucket request:
{
"requestId": "8918494067948195360",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918494067948195360",
"job": "fuchsia/core.x64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "15417511c4f67acbbfcf24a658842bc80c0b28b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@15417511c4f67acbbfcf24a658842bc80c0b28b5",
"title": "15417511c4f67acbbfcf24a658842bc80c0b28b5",
"url": "https://fuchsia.googlesource.com/integration/+/15417511c4f67acbbfcf24a658842bc80c0b28b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "25423ad85f3aa0ee13ad9156cbdc5db45de27087"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@25423ad85f3aa0ee13ad9156cbdc5db45de27087",
"title": "25423ad85f3aa0ee13ad9156cbdc5db45de27087",
"url": "https://fuchsia.googlesource.com/integration/+/25423ad85f3aa0ee13ad9156cbdc5db45de27087"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d5b39cf4106c11f4f51afe29e4fd96c5e1ec9844"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d5b39cf4106c11f4f51afe29e4fd96c5e1ec9844",
"title": "d5b39cf4106c11f4f51afe29e4fd96c5e1ec9844",
"url": "https://fuchsia.googlesource.com/integration/+/d5b39cf4106c11f4f51afe29e4fd96c5e1ec9844"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4e9b88d5f7bc74f4edaa589d01234c68bda97bb3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4e9b88d5f7bc74f4edaa589d01234c68bda97bb3",
"title": "4e9b88d5f7bc74f4edaa589d01234c68bda97bb3",
"url": "https://fuchsia.googlesource.com/integration/+/4e9b88d5f7bc74f4edaa589d01234c68bda97bb3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f851fbbaebc4a401634411cbdf9fec7e93d2fe4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f851fbbaebc4a401634411cbdf9fec7e93d2fe4",
"title": "3f851fbbaebc4a401634411cbdf9fec7e93d2fe4",
"url": "https://fuchsia.googlesource.com/integration/+/3f851fbbaebc4a401634411cbdf9fec7e93d2fe4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "767e69a33ec246583ab00134fd01b70ab2ef224a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@767e69a33ec246583ab00134fd01b70ab2ef224a",
"title": "767e69a33ec246583ab00134fd01b70ab2ef224a",
"url": "https://fuchsia.googlesource.com/integration/+/767e69a33ec246583ab00134fd01b70ab2ef224a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c42ff1266223efa638a1b57abf680629fd508b4c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c42ff1266223efa638a1b57abf680629fd508b4c",
"title": "c42ff1266223efa638a1b57abf680629fd508b4c",
"url": "https://fuchsia.googlesource.com/integration/+/c42ff1266223efa638a1b57abf680629fd508b4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b6d93f19c803d2448e98d7b4fc8e335d2abeac41"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b6d93f19c803d2448e98d7b4fc8e335d2abeac41",
"title": "b6d93f19c803d2448e98d7b4fc8e335d2abeac41",
"url": "https://fuchsia.googlesource.com/integration/+/b6d93f19c803d2448e98d7b4fc8e335d2abeac41"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e8a16c094e69ead132a01477f79ee0ae957cd2e0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e8a16c094e69ead132a01477f79ee0ae957cd2e0",
"title": "e8a16c094e69ead132a01477f79ee0ae957cd2e0",
"url": "https://fuchsia.googlesource.com/integration/+/e8a16c094e69ead132a01477f79ee0ae957cd2e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78aecb4dcab5ee7fcd7b7a3a172a02f707305553"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78aecb4dcab5ee7fcd7b7a3a172a02f707305553",
"title": "78aecb4dcab5ee7fcd7b7a3a172a02f707305553",
"url": "https://fuchsia.googlesource.com/integration/+/78aecb4dcab5ee7fcd7b7a3a172a02f707305553"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5006828c61814c9558a7f1a480e8ccc846370ff8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5006828c61814c9558a7f1a480e8ccc846370ff8",
"title": "5006828c61814c9558a7f1a480e8ccc846370ff8",
"url": "https://fuchsia.googlesource.com/integration/+/5006828c61814c9558a7f1a480e8ccc846370ff8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3cc7d2b228894a83ed46101700a404716d3e0e4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3cc7d2b228894a83ed46101700a404716d3e0e4a",
"title": "3cc7d2b228894a83ed46101700a404716d3e0e4a",
"url": "https://fuchsia.googlesource.com/integration/+/3cc7d2b228894a83ed46101700a404716d3e0e4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3eff288b0c18004df53a7f44e804afcc56520639"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3eff288b0c18004df53a7f44e804afcc56520639",
"title": "3eff288b0c18004df53a7f44e804afcc56520639",
"url": "https://fuchsia.googlesource.com/integration/+/3eff288b0c18004df53a7f44e804afcc56520639"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "725ba1cde60cc18ee797439231ff25f8c2eda4fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@725ba1cde60cc18ee797439231ff25f8c2eda4fa",
"title": "725ba1cde60cc18ee797439231ff25f8c2eda4fa",
"url": "https://fuchsia.googlesource.com/integration/+/725ba1cde60cc18ee797439231ff25f8c2eda4fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6da61fb15acb8c0e949644ce7617f4eedeaf19a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6da61fb15acb8c0e949644ce7617f4eedeaf19a6",
"title": "6da61fb15acb8c0e949644ce7617f4eedeaf19a6",
"url": "https://fuchsia.googlesource.com/integration/+/6da61fb15acb8c0e949644ce7617f4eedeaf19a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2744a34362c253779b9432348a6afa79ae040cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2744a34362c253779b9432348a6afa79ae040cc",
"title": "b2744a34362c253779b9432348a6afa79ae040cc",
"url": "https://fuchsia.googlesource.com/integration/+/b2744a34362c253779b9432348a6afa79ae040cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2c2ba24e945ca1b74c55de0e8b6c4dcbf113bdf0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2c2ba24e945ca1b74c55de0e8b6c4dcbf113bdf0",
"title": "2c2ba24e945ca1b74c55de0e8b6c4dcbf113bdf0",
"url": "https://fuchsia.googlesource.com/integration/+/2c2ba24e945ca1b74c55de0e8b6c4dcbf113bdf0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5f89bf52381d549cc9b732aa411a5e09701063fd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5f89bf52381d549cc9b732aa411a5e09701063fd",
"title": "5f89bf52381d549cc9b732aa411a5e09701063fd",
"url": "https://fuchsia.googlesource.com/integration/+/5f89bf52381d549cc9b732aa411a5e09701063fd"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5f89bf52381d549cc9b732aa411a5e09701063fd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918494067948195360"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:04:50.253] Scheduled build:
{
"id": "8753064006012178289",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T05:04:49.814934317Z",
"updateTime": "2024-03-19T05:04:49.814934317Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5f89bf52381d549cc9b732aa411a5e09701063fd",
"ref": "refs/heads/main"
}
}
}
[05:04:50.253] Task URL: https://cr-buildbucket.appspot.com/build/8753064006012178289
[05:04:50.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:2:0) after 8m27s
[05:04:51.131] Received PubSub notification, asking Buildbucket for the build status
[05:04:51.169] Build status: SCHEDULED
[05:06:26.172] Received PubSub notification, asking Buildbucket for the build status
[05:06:26.204] Build status: STARTED
[05:13:17.371] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:2:0)
[05:13:17.478] Build status: STARTED
[05:13:17.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:5:0) after 1m54s
[05:15:11.600] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:5:0)
[05:15:11.693] Build status: STARTED
[05:15:11.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:6:0) after 1m10s
[05:16:21.843] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:6:0)
[05:16:21.898] Build status: STARTED
[05:16:21.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:7:0) after 7m28s
[05:23:50.078] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:7:0)
[05:23:50.181] Build status: STARTED
[05:23:50.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:8:0) after 8m1s
[05:31:51.298] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:8:0)
[05:31:51.336] Build status: STARTED
[05:31:51.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:9:0) after 5m18s
[05:37:09.498] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:9:0)
[05:37:09.516] Build status: STARTED
[05:37:09.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:10:0) after 1m44s
[05:38:53.990] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:10:0)
[05:38:54.019] Build status: STARTED
[05:38:54.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:11:0) after 9m58s
[05:48:52.113] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:11:0)
[05:48:52.164] Build status: STARTED
[05:48:52.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:12:0) after 3m19s
[05:52:11.242] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:12:0)
[05:52:11.283] Build status: STARTED
[05:52:11.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:13:0) after 1m26s
[05:53:37.509] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:13:0)
[05:53:37.709] Build status: STARTED
[05:53:37.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:14:0) after 4m18s
[05:57:55.787] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:14:0)
[05:57:55.804] Build status: STARTED
[05:57:55.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:15:0) after 5m27s
[06:03:22.834] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:15:0)
[06:03:22.860] Build status: STARTED
[06:03:22.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:16:0) after 4m37s
[06:08:00.816] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:16:0)
[06:08:00.835] Build status: STARTED
[06:08:00.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:17:0) after 7m52s
[06:15:53.031] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:17:0)
[06:15:53.059] Build status: STARTED
[06:15:53.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:18:0) after 6m22s
[06:22:15.132] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:18:0)
[06:22:15.155] Build status: STARTED
[06:22:15.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8918494067948195360:19:0) after 8m14s
[06:24:54.758] Received PubSub notification, asking Buildbucket for the build status
[06:24:54.779] Build:
{
"id": "8753064006012178289",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T05:04:49.814934317Z",
"startTime": "2024-03-19T05:06:25.628943Z",
"endTime": "2024-03-19T06:24:53.536840Z",
"updateTime": "2024-03-19T06:24:53.536840Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5f89bf52381d549cc9b732aa411a5e09701063fd",
"ref": "refs/heads/main"
}
}
}
[06:24:54.779] Invocation finished in 1h20m6.194474838s with status FAILED