[00:11:03.105] New invocation is queued and will start shortly
[00:11:04.321] Starting the invocation (attempt 1)
[00:11:04.374] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/0033b99231647a2697cab68cf0ce6ffb4a454a63"
[00:11:04.374] Popped gitiles commit info from properties and tags
[00:11:04.374] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:11:04.374] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:11:04.375] Buildbucket request:
{
"requestId": "8919146728377255536",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8919146728377255536",
"job": "fuchsia/core.x64-cxx20-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1288a93dbb9ed2c05163ea84f1b9402f7e88d9f3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1288a93dbb9ed2c05163ea84f1b9402f7e88d9f3",
"title": "1288a93dbb9ed2c05163ea84f1b9402f7e88d9f3",
"url": "https://fuchsia.googlesource.com/integration/+/1288a93dbb9ed2c05163ea84f1b9402f7e88d9f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "61945fc98d0c1ab3c2b4ed3b15796ae28d431759"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@61945fc98d0c1ab3c2b4ed3b15796ae28d431759",
"title": "61945fc98d0c1ab3c2b4ed3b15796ae28d431759",
"url": "https://fuchsia.googlesource.com/integration/+/61945fc98d0c1ab3c2b4ed3b15796ae28d431759"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c4ce68a8e2883f732c913bda15af0a8b84109bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c4ce68a8e2883f732c913bda15af0a8b84109bb",
"title": "4c4ce68a8e2883f732c913bda15af0a8b84109bb",
"url": "https://fuchsia.googlesource.com/integration/+/4c4ce68a8e2883f732c913bda15af0a8b84109bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "521146b649ac84b19d4d8a118d6a97af5c803789"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@521146b649ac84b19d4d8a118d6a97af5c803789",
"title": "521146b649ac84b19d4d8a118d6a97af5c803789",
"url": "https://fuchsia.googlesource.com/integration/+/521146b649ac84b19d4d8a118d6a97af5c803789"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e1e6725f7b2e0e728b71df41bd17faadb2e2fe81"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e1e6725f7b2e0e728b71df41bd17faadb2e2fe81",
"title": "e1e6725f7b2e0e728b71df41bd17faadb2e2fe81",
"url": "https://fuchsia.googlesource.com/integration/+/e1e6725f7b2e0e728b71df41bd17faadb2e2fe81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5db3271b88ef59b93731c11d90b39e549ccbc879"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5db3271b88ef59b93731c11d90b39e549ccbc879",
"title": "5db3271b88ef59b93731c11d90b39e549ccbc879",
"url": "https://fuchsia.googlesource.com/integration/+/5db3271b88ef59b93731c11d90b39e549ccbc879"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f87cbb3245ad117c24a10f18d2692969ed54677"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f87cbb3245ad117c24a10f18d2692969ed54677",
"title": "3f87cbb3245ad117c24a10f18d2692969ed54677",
"url": "https://fuchsia.googlesource.com/integration/+/3f87cbb3245ad117c24a10f18d2692969ed54677"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c5e2f39b1f5ed6b6b29fb6d1a320e0045a28ac2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c5e2f39b1f5ed6b6b29fb6d1a320e0045a28ac2e",
"title": "c5e2f39b1f5ed6b6b29fb6d1a320e0045a28ac2e",
"url": "https://fuchsia.googlesource.com/integration/+/c5e2f39b1f5ed6b6b29fb6d1a320e0045a28ac2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "900d9bdef0f765aaee237ea00a956df7dc5858db"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@900d9bdef0f765aaee237ea00a956df7dc5858db",
"title": "900d9bdef0f765aaee237ea00a956df7dc5858db",
"url": "https://fuchsia.googlesource.com/integration/+/900d9bdef0f765aaee237ea00a956df7dc5858db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc9e638ab8db220409195b154475e6dd96d504ce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc9e638ab8db220409195b154475e6dd96d504ce",
"title": "fc9e638ab8db220409195b154475e6dd96d504ce",
"url": "https://fuchsia.googlesource.com/integration/+/fc9e638ab8db220409195b154475e6dd96d504ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1516521ffce4c4308e2769226703948e7387d349"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1516521ffce4c4308e2769226703948e7387d349",
"title": "1516521ffce4c4308e2769226703948e7387d349",
"url": "https://fuchsia.googlesource.com/integration/+/1516521ffce4c4308e2769226703948e7387d349"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1bc3cef34be41232bcb34b8ea455bd1702bcee66"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1bc3cef34be41232bcb34b8ea455bd1702bcee66",
"title": "1bc3cef34be41232bcb34b8ea455bd1702bcee66",
"url": "https://fuchsia.googlesource.com/integration/+/1bc3cef34be41232bcb34b8ea455bd1702bcee66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0dc995e3b9eafa43613a8d592432386143be757f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0dc995e3b9eafa43613a8d592432386143be757f",
"title": "0dc995e3b9eafa43613a8d592432386143be757f",
"url": "https://fuchsia.googlesource.com/integration/+/0dc995e3b9eafa43613a8d592432386143be757f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a4710963767e48127776e638c835f40ec0a13ce0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a4710963767e48127776e638c835f40ec0a13ce0",
"title": "a4710963767e48127776e638c835f40ec0a13ce0",
"url": "https://fuchsia.googlesource.com/integration/+/a4710963767e48127776e638c835f40ec0a13ce0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "97bae94ff4fd3b64c8e3d2487e7065f92f824757"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@97bae94ff4fd3b64c8e3d2487e7065f92f824757",
"title": "97bae94ff4fd3b64c8e3d2487e7065f92f824757",
"url": "https://fuchsia.googlesource.com/integration/+/97bae94ff4fd3b64c8e3d2487e7065f92f824757"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "81ebceadfdf8fe21312d94f6f13dd7f6e594aa8a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@81ebceadfdf8fe21312d94f6f13dd7f6e594aa8a",
"title": "81ebceadfdf8fe21312d94f6f13dd7f6e594aa8a",
"url": "https://fuchsia.googlesource.com/integration/+/81ebceadfdf8fe21312d94f6f13dd7f6e594aa8a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b4f69b10e459ffdbc584ad41ab196f6c953afad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b4f69b10e459ffdbc584ad41ab196f6c953afad",
"title": "8b4f69b10e459ffdbc584ad41ab196f6c953afad",
"url": "https://fuchsia.googlesource.com/integration/+/8b4f69b10e459ffdbc584ad41ab196f6c953afad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ea4196eee98193fb5c8bf0ee907e79cbac1f169"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ea4196eee98193fb5c8bf0ee907e79cbac1f169",
"title": "4ea4196eee98193fb5c8bf0ee907e79cbac1f169",
"url": "https://fuchsia.googlesource.com/integration/+/4ea4196eee98193fb5c8bf0ee907e79cbac1f169"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db67fa49616fb76aa1cf6bdb5be4276df54c3626"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db67fa49616fb76aa1cf6bdb5be4276df54c3626",
"title": "db67fa49616fb76aa1cf6bdb5be4276df54c3626",
"url": "https://fuchsia.googlesource.com/integration/+/db67fa49616fb76aa1cf6bdb5be4276df54c3626"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9575355a15b650e27899f83637913da59217f199"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9575355a15b650e27899f83637913da59217f199",
"title": "9575355a15b650e27899f83637913da59217f199",
"url": "https://fuchsia.googlesource.com/integration/+/9575355a15b650e27899f83637913da59217f199"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "90ca811b9abd90b1956414a3f03aad78d8fc88d2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@90ca811b9abd90b1956414a3f03aad78d8fc88d2",
"title": "90ca811b9abd90b1956414a3f03aad78d8fc88d2",
"url": "https://fuchsia.googlesource.com/integration/+/90ca811b9abd90b1956414a3f03aad78d8fc88d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aadaf9d35ee54f5a8c5b5d9d5a346c9c7a3493b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aadaf9d35ee54f5a8c5b5d9d5a346c9c7a3493b5",
"title": "aadaf9d35ee54f5a8c5b5d9d5a346c9c7a3493b5",
"url": "https://fuchsia.googlesource.com/integration/+/aadaf9d35ee54f5a8c5b5d9d5a346c9c7a3493b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "729b88666a34c7f8fba0aff49ba5d3514b43d786"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@729b88666a34c7f8fba0aff49ba5d3514b43d786",
"title": "729b88666a34c7f8fba0aff49ba5d3514b43d786",
"url": "https://fuchsia.googlesource.com/integration/+/729b88666a34c7f8fba0aff49ba5d3514b43d786"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0033b99231647a2697cab68cf0ce6ffb4a454a63"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0033b99231647a2697cab68cf0ce6ffb4a454a63",
"title": "0033b99231647a2697cab68cf0ce6ffb4a454a63",
"url": "https://fuchsia.googlesource.com/integration/+/0033b99231647a2697cab68cf0ce6ffb4a454a63"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0033b99231647a2697cab68cf0ce6ffb4a454a63",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919146728377255536"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-cxx20-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:11:04.897] Scheduled build:
{
"id": "8753716666293296833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-12T00:11:04.466637227Z",
"updateTime": "2024-03-12T00:11:04.466637227Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0033b99231647a2697cab68cf0ce6ffb4a454a63",
"ref": "refs/heads/main"
}
}
}
[00:11:04.897] Task URL: https://cr-buildbucket.appspot.com/build/8753716666293296833
[00:11:04.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:2:0) after 3m43s
[00:11:05.957] Received PubSub notification, asking Buildbucket for the build status
[00:11:06.001] Build status: SCHEDULED
[00:14:08.539] Received PubSub notification, asking Buildbucket for the build status
[00:14:08.572] Build status: STARTED
[00:14:47.943] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:2:0)
[00:14:47.986] Build status: STARTED
[00:14:47.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:5:0) after 3m49s
[00:18:37.044] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:5:0)
[00:18:37.079] Build status: STARTED
[00:18:37.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:6:0) after 2m13s
[00:20:50.092] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:6:0)
[00:20:50.118] Build status: STARTED
[00:20:50.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:7:0) after 6m12s
[00:27:02.146] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:7:0)
[00:27:02.225] Build status: STARTED
[00:27:02.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:8:0) after 7m39s
[00:34:41.394] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:8:0)
[00:34:41.410] Build status: STARTED
[00:34:41.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:9:0) after 1m53s
[00:36:34.480] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:9:0)
[00:36:34.500] Build status: STARTED
[00:36:34.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:10:0) after 8m39s
[00:45:13.604] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:10:0)
[00:45:13.627] Build status: STARTED
[00:45:13.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:11:0) after 9m23s
[00:54:36.765] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:11:0)
[00:54:36.793] Build status: STARTED
[00:54:36.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:12:0) after 1m16s
[00:55:52.772] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:12:0)
[00:55:52.835] Build status: STARTED
[00:55:52.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:13:0) after 4m31s
[01:00:23.864] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:13:0)
[01:00:23.900] Build status: STARTED
[01:00:23.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:14:0) after 9m10s
[01:09:34.064] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:14:0)
[01:09:34.133] Build status: STARTED
[01:09:34.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:15:0) after 8m25s
[01:17:59.181] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:15:0)
[01:17:59.208] Build status: STARTED
[01:17:59.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:16:0) after 8m20s
[01:26:19.207] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:16:0)
[01:26:19.235] Build status: STARTED
[01:26:19.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:17:0) after 3m40s
[01:29:59.361] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:17:0)
[01:29:59.385] Build status: STARTED
[01:29:59.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:18:0) after 9m12s
[01:39:11.529] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:18:0)
[01:39:11.550] Build status: STARTED
[01:39:11.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:19:0) after 5m44s
[01:44:55.595] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:19:0)
[01:44:55.662] Build status: STARTED
[01:44:55.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8919146728377255536:20:0) after 7m8s
[01:48:08.736] Received PubSub notification, asking Buildbucket for the build status
[01:48:08.754] Build:
{
"id": "8753716666293296833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-12T00:11:04.466637227Z",
"startTime": "2024-03-12T00:14:07.475918Z",
"endTime": "2024-03-12T01:48:07.181473Z",
"updateTime": "2024-03-12T01:48:07.181473Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "0033b99231647a2697cab68cf0ce6ffb4a454a63",
"ref": "refs/heads/main"
}
}
}
[01:48:08.754] Invocation finished in 1h37m5.659569474s with status SUCCEEDED