[20:34:01.028] New invocation is queued and will start shortly
[20:34:03.405] Starting the invocation (attempt 1)
[20:34:03.505] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/880f6e09744ddabd507c3886a05d5e9f44c1fb97"
[20:34:03.505] Popped gitiles commit info from properties and tags
[20:34:03.505] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:34:03.505] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:34:03.509] Buildbucket request:
{
"requestId": "8899500841308376640",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899500841308376640",
"job": "fuchsia/core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8bc1040b5a0e19b4463d531086ce12bbbf581195"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8bc1040b5a0e19b4463d531086ce12bbbf581195",
"title": "8bc1040b5a0e19b4463d531086ce12bbbf581195",
"url": "https://fuchsia.googlesource.com/integration/+/8bc1040b5a0e19b4463d531086ce12bbbf581195"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "85906eca5d2ad51200fd24bd72376b29623d36ee"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@85906eca5d2ad51200fd24bd72376b29623d36ee",
"title": "85906eca5d2ad51200fd24bd72376b29623d36ee",
"url": "https://fuchsia.googlesource.com/integration/+/85906eca5d2ad51200fd24bd72376b29623d36ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7383406ec263c853f400eb9d28ad8b96d925d3ab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7383406ec263c853f400eb9d28ad8b96d925d3ab",
"title": "7383406ec263c853f400eb9d28ad8b96d925d3ab",
"url": "https://fuchsia.googlesource.com/integration/+/7383406ec263c853f400eb9d28ad8b96d925d3ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06613cdcaef7cec10d5eb52f20607efe2d463791"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06613cdcaef7cec10d5eb52f20607efe2d463791",
"title": "06613cdcaef7cec10d5eb52f20607efe2d463791",
"url": "https://fuchsia.googlesource.com/integration/+/06613cdcaef7cec10d5eb52f20607efe2d463791"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b5183ea9808a02d68d1c170e69aaaa9c4a96f1cf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b5183ea9808a02d68d1c170e69aaaa9c4a96f1cf",
"title": "b5183ea9808a02d68d1c170e69aaaa9c4a96f1cf",
"url": "https://fuchsia.googlesource.com/integration/+/b5183ea9808a02d68d1c170e69aaaa9c4a96f1cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a21fd38218939802c32c3a128e72d617c98f1b19"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a21fd38218939802c32c3a128e72d617c98f1b19",
"title": "a21fd38218939802c32c3a128e72d617c98f1b19",
"url": "https://fuchsia.googlesource.com/integration/+/a21fd38218939802c32c3a128e72d617c98f1b19"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92412dcbb34c3121c075eb22f52819d8d8ff2336"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92412dcbb34c3121c075eb22f52819d8d8ff2336",
"title": "92412dcbb34c3121c075eb22f52819d8d8ff2336",
"url": "https://fuchsia.googlesource.com/integration/+/92412dcbb34c3121c075eb22f52819d8d8ff2336"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "73996f742e34f5eaf0edc61c5243394233415e06"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@73996f742e34f5eaf0edc61c5243394233415e06",
"title": "73996f742e34f5eaf0edc61c5243394233415e06",
"url": "https://fuchsia.googlesource.com/integration/+/73996f742e34f5eaf0edc61c5243394233415e06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4790feb3583a172849903fae2b186f005f118b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4790feb3583a172849903fae2b186f005f118b9",
"title": "e4790feb3583a172849903fae2b186f005f118b9",
"url": "https://fuchsia.googlesource.com/integration/+/e4790feb3583a172849903fae2b186f005f118b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "447d3f5d82c06224e0e379a6d2432b59ce76fe73"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@447d3f5d82c06224e0e379a6d2432b59ce76fe73",
"title": "447d3f5d82c06224e0e379a6d2432b59ce76fe73",
"url": "https://fuchsia.googlesource.com/integration/+/447d3f5d82c06224e0e379a6d2432b59ce76fe73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac01813236ac295b37e901a7e87cbb3bdb8b2702"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac01813236ac295b37e901a7e87cbb3bdb8b2702",
"title": "ac01813236ac295b37e901a7e87cbb3bdb8b2702",
"url": "https://fuchsia.googlesource.com/integration/+/ac01813236ac295b37e901a7e87cbb3bdb8b2702"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b69c3d62dc3f7e63bec9239adc35c3dfa856eca0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b69c3d62dc3f7e63bec9239adc35c3dfa856eca0",
"title": "b69c3d62dc3f7e63bec9239adc35c3dfa856eca0",
"url": "https://fuchsia.googlesource.com/integration/+/b69c3d62dc3f7e63bec9239adc35c3dfa856eca0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "526053c299461987dff3c4bff4e6a8a7ea41ecb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@526053c299461987dff3c4bff4e6a8a7ea41ecb1",
"title": "526053c299461987dff3c4bff4e6a8a7ea41ecb1",
"url": "https://fuchsia.googlesource.com/integration/+/526053c299461987dff3c4bff4e6a8a7ea41ecb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98f9cb2c5c8d41f6b878fe708df924a002a2ab45"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98f9cb2c5c8d41f6b878fe708df924a002a2ab45",
"title": "98f9cb2c5c8d41f6b878fe708df924a002a2ab45",
"url": "https://fuchsia.googlesource.com/integration/+/98f9cb2c5c8d41f6b878fe708df924a002a2ab45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b1e7593c1105c40a1854ae1e7e0513d7b273505"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b1e7593c1105c40a1854ae1e7e0513d7b273505",
"title": "2b1e7593c1105c40a1854ae1e7e0513d7b273505",
"url": "https://fuchsia.googlesource.com/integration/+/2b1e7593c1105c40a1854ae1e7e0513d7b273505"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cefe004435f63c556de04ed26689550dce3fc888"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cefe004435f63c556de04ed26689550dce3fc888",
"title": "cefe004435f63c556de04ed26689550dce3fc888",
"url": "https://fuchsia.googlesource.com/integration/+/cefe004435f63c556de04ed26689550dce3fc888"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1251e5d506903b9b8e71d420abca94dc989e141f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1251e5d506903b9b8e71d420abca94dc989e141f",
"title": "1251e5d506903b9b8e71d420abca94dc989e141f",
"url": "https://fuchsia.googlesource.com/integration/+/1251e5d506903b9b8e71d420abca94dc989e141f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "456c11b6a92df7597135c27ad95adf4c9ce38545"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@456c11b6a92df7597135c27ad95adf4c9ce38545",
"title": "456c11b6a92df7597135c27ad95adf4c9ce38545",
"url": "https://fuchsia.googlesource.com/integration/+/456c11b6a92df7597135c27ad95adf4c9ce38545"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58202b3700ce807fa56c69b80e0ca8fbd074ebc8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58202b3700ce807fa56c69b80e0ca8fbd074ebc8",
"title": "58202b3700ce807fa56c69b80e0ca8fbd074ebc8",
"url": "https://fuchsia.googlesource.com/integration/+/58202b3700ce807fa56c69b80e0ca8fbd074ebc8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "559b4782df0a00e1518e487f1b1dd65fb1471e08"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@559b4782df0a00e1518e487f1b1dd65fb1471e08",
"title": "559b4782df0a00e1518e487f1b1dd65fb1471e08",
"url": "https://fuchsia.googlesource.com/integration/+/559b4782df0a00e1518e487f1b1dd65fb1471e08"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dabee8ee1ef51a30aa4474b53dfaa6e79d7eecf0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dabee8ee1ef51a30aa4474b53dfaa6e79d7eecf0",
"title": "dabee8ee1ef51a30aa4474b53dfaa6e79d7eecf0",
"url": "https://fuchsia.googlesource.com/integration/+/dabee8ee1ef51a30aa4474b53dfaa6e79d7eecf0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d61c804bfe2b63a2cb164f740b22eea2bca6f00a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d61c804bfe2b63a2cb164f740b22eea2bca6f00a",
"title": "d61c804bfe2b63a2cb164f740b22eea2bca6f00a",
"url": "https://fuchsia.googlesource.com/integration/+/d61c804bfe2b63a2cb164f740b22eea2bca6f00a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e0acd4dcde66e54d46b8fb9c12e5297fcf577ea3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e0acd4dcde66e54d46b8fb9c12e5297fcf577ea3",
"title": "e0acd4dcde66e54d46b8fb9c12e5297fcf577ea3",
"url": "https://fuchsia.googlesource.com/integration/+/e0acd4dcde66e54d46b8fb9c12e5297fcf577ea3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "880f6e09744ddabd507c3886a05d5e9f44c1fb97"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@880f6e09744ddabd507c3886a05d5e9f44c1fb97",
"title": "880f6e09744ddabd507c3886a05d5e9f44c1fb97",
"url": "https://fuchsia.googlesource.com/integration/+/880f6e09744ddabd507c3886a05d5e9f44c1fb97"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "880f6e09744ddabd507c3886a05d5e9f44c1fb97",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899500841308376640"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:34:04.035] Scheduled build:
{
"id": "8734070777850288945",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-14T20:34:03.697543008Z",
"updateTime": "2024-10-14T20:34:03.697543008Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "880f6e09744ddabd507c3886a05d5e9f44c1fb97",
"ref": "refs/heads/main"
}
}
}
[20:34:04.035] Task URL: https://cr-buildbucket.appspot.com/build/8734070777850288945
[20:34:04.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:2:0) after 7m21s
[20:34:05.051] Received PubSub notification, asking Buildbucket for the build status
[20:34:05.067] Build status: SCHEDULED
[20:34:09.952] Received PubSub notification, asking Buildbucket for the build status
[20:34:10.108] Build status: STARTED
[20:41:25.054] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:2:0)
[20:41:25.078] Build status: STARTED
[20:41:25.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:5:0) after 6m56s
[20:48:21.110] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:5:0)
[20:48:21.129] Build status: STARTED
[20:48:21.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:6:0) after 8m5s
[20:56:26.154] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:6:0)
[20:56:26.192] Build status: STARTED
[20:56:26.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:7:0) after 9m53s
[21:06:19.212] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:7:0)
[21:06:19.237] Build status: STARTED
[21:06:19.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:8:0) after 4m30s
[21:10:49.261] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:8:0)
[21:10:49.282] Build status: STARTED
[21:10:49.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:9:0) after 5m55s
[21:16:44.300] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:9:0)
[21:16:44.319] Build status: STARTED
[21:16:44.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:10:0) after 2m8s
[21:18:52.374] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:10:0)
[21:18:52.392] Build status: STARTED
[21:18:52.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:11:0) after 4m42s
[21:23:34.502] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:11:0)
[21:23:34.522] Build status: STARTED
[21:23:34.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:12:0) after 3m37s
[21:27:11.592] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:12:0)
[21:27:11.616] Build status: STARTED
[21:27:11.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:13:0) after 4m36s
[21:31:47.645] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:13:0)
[21:31:47.738] Build status: STARTED
[21:31:47.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:14:0) after 2m41s
[21:34:28.756] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:14:0)
[21:34:28.778] Build status: STARTED
[21:34:28.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:15:0) after 1m1s
[21:35:29.800] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:15:0)
[21:35:29.820] Build status: STARTED
[21:35:29.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:16:0) after 4m4s
[21:39:33.877] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:16:0)
[21:39:33.898] Build status: STARTED
[21:39:33.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:17:0) after 6m16s
[21:45:49.916] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:17:0)
[21:45:49.973] Build status: STARTED
[21:45:49.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:18:0) after 4m43s
[21:50:33.093] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:18:0)
[21:50:33.173] Build status: STARTED
[21:50:33.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:19:0) after 8m59s
[21:59:32.231] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:19:0)
[21:59:32.252] Build status: STARTED
[21:59:32.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:20:0) after 2m3s
[22:01:35.308] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:20:0)
[22:01:35.328] Build status: STARTED
[22:01:35.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:21:0) after 4m23s
[22:05:58.351] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:21:0)
[22:05:58.367] Build status: STARTED
[22:05:58.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8899500841308376640:22:0) after 5m8s
[22:06:58.487] Received PubSub notification, asking Buildbucket for the build status
[22:06:58.506] Build:
{
"id": "8734070777850288945",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-14T20:34:03.697543008Z",
"startTime": "2024-10-14T20:34:09.600768243Z",
"endTime": "2024-10-14T22:06:49.341668827Z",
"updateTime": "2024-10-14T22:06:49.341668827Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "880f6e09744ddabd507c3886a05d5e9f44c1fb97",
"ref": "refs/heads/main"
}
}
}
[22:06:58.506] Invocation finished in 1h32m57.490630122s with status SUCCEEDED