[21:48:06.557] New invocation is queued and will start shortly
[21:48:07.618] Starting the invocation (attempt 1)
[21:48:07.644] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/16964f093818b7f21452258825848d6b56dbc091"
[21:48:07.644] Popped gitiles commit info from properties and tags
[21:48:07.644] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:48:07.645] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:48:07.645] Buildbucket request:
{
"requestId": "8926584672780928960",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8926584672780928960",
"job": "fuchsia/core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "075b1ee9004f92796a740dd7c295bdb05185d504"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@075b1ee9004f92796a740dd7c295bdb05185d504",
"title": "075b1ee9004f92796a740dd7c295bdb05185d504",
"url": "https://fuchsia.googlesource.com/integration/+/075b1ee9004f92796a740dd7c295bdb05185d504"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d0154a31ff05b3b70da03b1ee04531e4847bc950"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d0154a31ff05b3b70da03b1ee04531e4847bc950",
"title": "d0154a31ff05b3b70da03b1ee04531e4847bc950",
"url": "https://fuchsia.googlesource.com/integration/+/d0154a31ff05b3b70da03b1ee04531e4847bc950"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7c96662688bb415deb5467d86ebf739caf36ef27"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7c96662688bb415deb5467d86ebf739caf36ef27",
"title": "7c96662688bb415deb5467d86ebf739caf36ef27",
"url": "https://fuchsia.googlesource.com/integration/+/7c96662688bb415deb5467d86ebf739caf36ef27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cfcceedd338e90b4598f62c0439bef228d0d4ce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cfcceedd338e90b4598f62c0439bef228d0d4ce",
"title": "1cfcceedd338e90b4598f62c0439bef228d0d4ce",
"url": "https://fuchsia.googlesource.com/integration/+/1cfcceedd338e90b4598f62c0439bef228d0d4ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "515d3fd31c31271a9364cbcb4fbb6e4eef611b04"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@515d3fd31c31271a9364cbcb4fbb6e4eef611b04",
"title": "515d3fd31c31271a9364cbcb4fbb6e4eef611b04",
"url": "https://fuchsia.googlesource.com/integration/+/515d3fd31c31271a9364cbcb4fbb6e4eef611b04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3abb1bb03dc634f6890ce1356a51ac74a2baaf67"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3abb1bb03dc634f6890ce1356a51ac74a2baaf67",
"title": "3abb1bb03dc634f6890ce1356a51ac74a2baaf67",
"url": "https://fuchsia.googlesource.com/integration/+/3abb1bb03dc634f6890ce1356a51ac74a2baaf67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a3f6b05537fa2200b9304af75440a3ff363dac3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a3f6b05537fa2200b9304af75440a3ff363dac3",
"title": "8a3f6b05537fa2200b9304af75440a3ff363dac3",
"url": "https://fuchsia.googlesource.com/integration/+/8a3f6b05537fa2200b9304af75440a3ff363dac3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c01655e7162d52e4d48de5305aaee46d94497f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c01655e7162d52e4d48de5305aaee46d94497f6",
"title": "5c01655e7162d52e4d48de5305aaee46d94497f6",
"url": "https://fuchsia.googlesource.com/integration/+/5c01655e7162d52e4d48de5305aaee46d94497f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ab8110732f803d6eb598867345e05388cdecab24"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ab8110732f803d6eb598867345e05388cdecab24",
"title": "ab8110732f803d6eb598867345e05388cdecab24",
"url": "https://fuchsia.googlesource.com/integration/+/ab8110732f803d6eb598867345e05388cdecab24"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f4dcfe0036c7f96a97a6ce95f3c0248ed2830d58"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f4dcfe0036c7f96a97a6ce95f3c0248ed2830d58",
"title": "f4dcfe0036c7f96a97a6ce95f3c0248ed2830d58",
"url": "https://fuchsia.googlesource.com/integration/+/f4dcfe0036c7f96a97a6ce95f3c0248ed2830d58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a20b93825bc1ac091f0b9f83804b4ec479ef2857"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a20b93825bc1ac091f0b9f83804b4ec479ef2857",
"title": "a20b93825bc1ac091f0b9f83804b4ec479ef2857",
"url": "https://fuchsia.googlesource.com/integration/+/a20b93825bc1ac091f0b9f83804b4ec479ef2857"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "792f781e14b4e225dd981e3368c542a3390f3f76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@792f781e14b4e225dd981e3368c542a3390f3f76",
"title": "792f781e14b4e225dd981e3368c542a3390f3f76",
"url": "https://fuchsia.googlesource.com/integration/+/792f781e14b4e225dd981e3368c542a3390f3f76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7619a03d0908bbd86ff198255cbbab212a88b87a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7619a03d0908bbd86ff198255cbbab212a88b87a",
"title": "7619a03d0908bbd86ff198255cbbab212a88b87a",
"url": "https://fuchsia.googlesource.com/integration/+/7619a03d0908bbd86ff198255cbbab212a88b87a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "814825d628a3f289bbf880cda0cdd64a436b6a9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@814825d628a3f289bbf880cda0cdd64a436b6a9e",
"title": "814825d628a3f289bbf880cda0cdd64a436b6a9e",
"url": "https://fuchsia.googlesource.com/integration/+/814825d628a3f289bbf880cda0cdd64a436b6a9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "046e9d5dcd628dbf1eba2f1e02ea8dd57a08bc45"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@046e9d5dcd628dbf1eba2f1e02ea8dd57a08bc45",
"title": "046e9d5dcd628dbf1eba2f1e02ea8dd57a08bc45",
"url": "https://fuchsia.googlesource.com/integration/+/046e9d5dcd628dbf1eba2f1e02ea8dd57a08bc45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b6b3e4aa48250ebab5ef02acb270f7fc9a7b4887"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b6b3e4aa48250ebab5ef02acb270f7fc9a7b4887",
"title": "b6b3e4aa48250ebab5ef02acb270f7fc9a7b4887",
"url": "https://fuchsia.googlesource.com/integration/+/b6b3e4aa48250ebab5ef02acb270f7fc9a7b4887"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e53cf1a3b40f41b79f69bc1db2a51ad11ae65900"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e53cf1a3b40f41b79f69bc1db2a51ad11ae65900",
"title": "e53cf1a3b40f41b79f69bc1db2a51ad11ae65900",
"url": "https://fuchsia.googlesource.com/integration/+/e53cf1a3b40f41b79f69bc1db2a51ad11ae65900"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0ea172a83b4d33557e3639754d714d27e02c9ed2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0ea172a83b4d33557e3639754d714d27e02c9ed2",
"title": "0ea172a83b4d33557e3639754d714d27e02c9ed2",
"url": "https://fuchsia.googlesource.com/integration/+/0ea172a83b4d33557e3639754d714d27e02c9ed2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "be568dce1992bea578f59ac3440f6915b82f3989"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@be568dce1992bea578f59ac3440f6915b82f3989",
"title": "be568dce1992bea578f59ac3440f6915b82f3989",
"url": "https://fuchsia.googlesource.com/integration/+/be568dce1992bea578f59ac3440f6915b82f3989"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0ed34150fb32330b34af578a9ba6602e8cba43ff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0ed34150fb32330b34af578a9ba6602e8cba43ff",
"title": "0ed34150fb32330b34af578a9ba6602e8cba43ff",
"url": "https://fuchsia.googlesource.com/integration/+/0ed34150fb32330b34af578a9ba6602e8cba43ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74fbeca81a49552138c1b9da64a4c1686e8b59da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74fbeca81a49552138c1b9da64a4c1686e8b59da",
"title": "74fbeca81a49552138c1b9da64a4c1686e8b59da",
"url": "https://fuchsia.googlesource.com/integration/+/74fbeca81a49552138c1b9da64a4c1686e8b59da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e23b175e088e42779e684d366b11c67bba0d45c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e23b175e088e42779e684d366b11c67bba0d45c8",
"title": "e23b175e088e42779e684d366b11c67bba0d45c8",
"url": "https://fuchsia.googlesource.com/integration/+/e23b175e088e42779e684d366b11c67bba0d45c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "16964f093818b7f21452258825848d6b56dbc091"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@16964f093818b7f21452258825848d6b56dbc091",
"title": "16964f093818b7f21452258825848d6b56dbc091",
"url": "https://fuchsia.googlesource.com/integration/+/16964f093818b7f21452258825848d6b56dbc091"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "16964f093818b7f21452258825848d6b56dbc091",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8926584672780928960"
},
{
"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"
}
}
[21:48:08.166] Scheduled build:
{
"id": "8761154610934762721",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-20T21:48:07.695524153Z",
"updateTime": "2023-12-20T21:48:07.695524153Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "16964f093818b7f21452258825848d6b56dbc091",
"ref": "refs/heads/main"
}
}
}
[21:48:08.166] Task URL: https://cr-buildbucket.appspot.com/build/8761154610934762721
[21:48:08.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:2:0) after 8m45s
[21:56:53.346] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:2:0)
[21:56:53.377] Build status: STARTED
[21:56:53.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:3:0) after 1m8s
[21:58:01.511] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:3:0)
[21:58:01.760] Build status: STARTED
[21:58:01.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:4:0) after 4m3s
[22:02:04.879] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:4:0)
[22:02:04.925] Build status: STARTED
[22:02:04.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:5:0) after 6m37s
[22:08:42.435] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:5:0)
[22:08:42.451] Build status: STARTED
[22:08:42.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:6:0) after 7m11s
[22:15:53.469] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:6:0)
[22:15:53.487] Build status: STARTED
[22:15:53.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:7:0) after 5m3s
[22:20:56.668] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:7:0)
[22:20:56.695] Build status: STARTED
[22:20:56.695] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:8:0) after 4m14s
[22:23:36.872] Received PubSub notification, asking Buildbucket for the build status
[22:23:36.889] Build status: STARTED
[22:25:10.908] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:8:0)
[22:25:10.936] Build status: STARTED
[22:25:10.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:10:0) after 9m6s
[22:25:26.502] Received PubSub notification, asking Buildbucket for the build status
[22:25:26.527] Build status: STARTED
[22:34:17.096] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:10:0)
[22:34:17.123] Build status: STARTED
[22:34:17.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:12:0) after 2m46s
[22:37:03.145] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:12:0)
[22:37:03.247] Build status: STARTED
[22:37:03.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:13:0) after 7m2s
[22:44:05.266] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:13:0)
[22:44:05.314] Build status: STARTED
[22:44:05.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:14:0) after 4m6s
[22:48:11.433] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:14:0)
[22:48:11.457] Build status: STARTED
[22:48:11.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:15:0) after 7m32s
[22:55:43.771] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:15:0)
[22:55:43.812] Build status: STARTED
[22:55:43.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:16:0) after 3m30s
[22:59:13.926] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:16:0)
[22:59:13.950] Build status: STARTED
[22:59:13.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:17:0) after 5m23s
[23:04:37.024] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:17:0)
[23:04:37.049] Build status: STARTED
[23:04:37.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:18:0) after 2m9s
[23:06:46.258] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:18:0)
[23:06:46.274] Build status: STARTED
[23:06:46.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:19:0) after 7m19s
[23:14:05.448] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8926584672780928960:19:0)
[23:14:05.475] Build:
{
"id": "8761154610934762721",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-20T21:48:07.695524153Z",
"startTime": "2023-12-20T21:49:52.786998Z",
"endTime": "2023-12-20T23:13:08.190016Z",
"updateTime": "2023-12-20T23:13:08.190016Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "16964f093818b7f21452258825848d6b56dbc091",
"ref": "refs/heads/main"
}
}
}
[23:14:05.475] Invocation finished in 1h25m58.923177499s with status SUCCEEDED