[03:37:00.655] New invocation is queued and will start shortly
[03:37:01.832] Starting the invocation (attempt 1)
[03:37:01.863] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/3bdd8b5395de3915d7b9f033d8d21af8dec5028f"
[03:37:01.863] Popped gitiles commit info from properties and tags
[03:37:01.863] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:37:01.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:37:01.864] Buildbucket request:
{
"requestId": "8915328697962386048",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8915328697962386048",
"job": "fuchsia/fuchsia-coverage-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5aef85ce1d7c2ada32582371bb6743d2867fc81e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5aef85ce1d7c2ada32582371bb6743d2867fc81e",
"title": "5aef85ce1d7c2ada32582371bb6743d2867fc81e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5aef85ce1d7c2ada32582371bb6743d2867fc81e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0a21e745139d30486a9e09752a67ca94ac328867"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0a21e745139d30486a9e09752a67ca94ac328867",
"title": "0a21e745139d30486a9e09752a67ca94ac328867",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0a21e745139d30486a9e09752a67ca94ac328867"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "20dfbe9a8f856b446dbe1006f4d49dcc1dee7623"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@20dfbe9a8f856b446dbe1006f4d49dcc1dee7623",
"title": "20dfbe9a8f856b446dbe1006f4d49dcc1dee7623",
"url": "https://fuchsia.googlesource.com/fuchsia/+/20dfbe9a8f856b446dbe1006f4d49dcc1dee7623"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "fff0a015f50d0e6d083af1b348316ef3c061b344"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@fff0a015f50d0e6d083af1b348316ef3c061b344",
"title": "fff0a015f50d0e6d083af1b348316ef3c061b344",
"url": "https://fuchsia.googlesource.com/fuchsia/+/fff0a015f50d0e6d083af1b348316ef3c061b344"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "b42e3d34ea8659207edf64fd16cd0a1a4fd4d655"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@b42e3d34ea8659207edf64fd16cd0a1a4fd4d655",
"title": "b42e3d34ea8659207edf64fd16cd0a1a4fd4d655",
"url": "https://fuchsia.googlesource.com/fuchsia/+/b42e3d34ea8659207edf64fd16cd0a1a4fd4d655"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "928dadd49b3c91d4331063aa8f54a93759ef6084"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@928dadd49b3c91d4331063aa8f54a93759ef6084",
"title": "928dadd49b3c91d4331063aa8f54a93759ef6084",
"url": "https://fuchsia.googlesource.com/fuchsia/+/928dadd49b3c91d4331063aa8f54a93759ef6084"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4705972dd4ca356d94a7d53a4b32f770a8be175e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4705972dd4ca356d94a7d53a4b32f770a8be175e",
"title": "4705972dd4ca356d94a7d53a4b32f770a8be175e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4705972dd4ca356d94a7d53a4b32f770a8be175e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "d5c66c9166a334155ba55325f359078d657c4c95"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@d5c66c9166a334155ba55325f359078d657c4c95",
"title": "d5c66c9166a334155ba55325f359078d657c4c95",
"url": "https://fuchsia.googlesource.com/fuchsia/+/d5c66c9166a334155ba55325f359078d657c4c95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "3622f0bcf2119be155809129c00ff0950bbcc67c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@3622f0bcf2119be155809129c00ff0950bbcc67c",
"title": "3622f0bcf2119be155809129c00ff0950bbcc67c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/3622f0bcf2119be155809129c00ff0950bbcc67c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "6b0cb4926f14c23b1099b49d284460d67fd072cd"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@6b0cb4926f14c23b1099b49d284460d67fd072cd",
"title": "6b0cb4926f14c23b1099b49d284460d67fd072cd",
"url": "https://fuchsia.googlesource.com/fuchsia/+/6b0cb4926f14c23b1099b49d284460d67fd072cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "43d3cae0ad8678d84e83b9925ef0d33b9e233818"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@43d3cae0ad8678d84e83b9925ef0d33b9e233818",
"title": "43d3cae0ad8678d84e83b9925ef0d33b9e233818",
"url": "https://fuchsia.googlesource.com/fuchsia/+/43d3cae0ad8678d84e83b9925ef0d33b9e233818"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0f4b1ca6add8113e0872217dd72010ec00f98a2b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0f4b1ca6add8113e0872217dd72010ec00f98a2b",
"title": "0f4b1ca6add8113e0872217dd72010ec00f98a2b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0f4b1ca6add8113e0872217dd72010ec00f98a2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f2fd79f41e28c496a2df60751460f413e41646c1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f2fd79f41e28c496a2df60751460f413e41646c1",
"title": "f2fd79f41e28c496a2df60751460f413e41646c1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f2fd79f41e28c496a2df60751460f413e41646c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "6fb78314dca398779e3e71fb7910cd909a172c2f"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@6fb78314dca398779e3e71fb7910cd909a172c2f",
"title": "6fb78314dca398779e3e71fb7910cd909a172c2f",
"url": "https://fuchsia.googlesource.com/fuchsia/+/6fb78314dca398779e3e71fb7910cd909a172c2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "80ef663aac81ba29dc7f87c3da89aeb262d478ba"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@80ef663aac81ba29dc7f87c3da89aeb262d478ba",
"title": "80ef663aac81ba29dc7f87c3da89aeb262d478ba",
"url": "https://fuchsia.googlesource.com/fuchsia/+/80ef663aac81ba29dc7f87c3da89aeb262d478ba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "bce010cc69b2823b13f2b3b059fed96a9da5f41e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@bce010cc69b2823b13f2b3b059fed96a9da5f41e",
"title": "bce010cc69b2823b13f2b3b059fed96a9da5f41e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/bce010cc69b2823b13f2b3b059fed96a9da5f41e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4650a9aa13d2c6338513b0cd01fd90100852bf1c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4650a9aa13d2c6338513b0cd01fd90100852bf1c",
"title": "4650a9aa13d2c6338513b0cd01fd90100852bf1c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4650a9aa13d2c6338513b0cd01fd90100852bf1c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "448e3f5e3b7f16f423093f2ad8f4a7fd6c38e635"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@448e3f5e3b7f16f423093f2ad8f4a7fd6c38e635",
"title": "448e3f5e3b7f16f423093f2ad8f4a7fd6c38e635",
"url": "https://fuchsia.googlesource.com/fuchsia/+/448e3f5e3b7f16f423093f2ad8f4a7fd6c38e635"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "40bb1a14bf925baeed00b827e121d7988d34a661"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@40bb1a14bf925baeed00b827e121d7988d34a661",
"title": "40bb1a14bf925baeed00b827e121d7988d34a661",
"url": "https://fuchsia.googlesource.com/fuchsia/+/40bb1a14bf925baeed00b827e121d7988d34a661"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "3c519960582183555881cddf51e94f1b4c8be91c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@3c519960582183555881cddf51e94f1b4c8be91c",
"title": "3c519960582183555881cddf51e94f1b4c8be91c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/3c519960582183555881cddf51e94f1b4c8be91c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "95762481c03e8822fe9f8ae2df51be74487487fc"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@95762481c03e8822fe9f8ae2df51be74487487fc",
"title": "95762481c03e8822fe9f8ae2df51be74487487fc",
"url": "https://fuchsia.googlesource.com/fuchsia/+/95762481c03e8822fe9f8ae2df51be74487487fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1fe8a3f2a2d55fb2f1ad29854c6636bf18858db1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1fe8a3f2a2d55fb2f1ad29854c6636bf18858db1",
"title": "1fe8a3f2a2d55fb2f1ad29854c6636bf18858db1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1fe8a3f2a2d55fb2f1ad29854c6636bf18858db1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "d65767b9d4042809d072a708bf134c6d371b6eec"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@d65767b9d4042809d072a708bf134c6d371b6eec",
"title": "d65767b9d4042809d072a708bf134c6d371b6eec",
"url": "https://fuchsia.googlesource.com/fuchsia/+/d65767b9d4042809d072a708bf134c6d371b6eec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "d5daabd409f0c23c7a9c00b545b60f8f7a8b105e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@d5daabd409f0c23c7a9c00b545b60f8f7a8b105e",
"title": "d5daabd409f0c23c7a9c00b545b60f8f7a8b105e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/d5daabd409f0c23c7a9c00b545b60f8f7a8b105e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "939437ce3cc95bda23528b86a05096c7363e73cf"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@939437ce3cc95bda23528b86a05096c7363e73cf",
"title": "939437ce3cc95bda23528b86a05096c7363e73cf",
"url": "https://fuchsia.googlesource.com/fuchsia/+/939437ce3cc95bda23528b86a05096c7363e73cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "c08ec8f41459bfdd5ef6f1269af64e79a0e7df93"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@c08ec8f41459bfdd5ef6f1269af64e79a0e7df93",
"title": "c08ec8f41459bfdd5ef6f1269af64e79a0e7df93",
"url": "https://fuchsia.googlesource.com/fuchsia/+/c08ec8f41459bfdd5ef6f1269af64e79a0e7df93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "dd69a3e9689a7b3e8f3c1d7089d0edb2c73bbc5b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@dd69a3e9689a7b3e8f3c1d7089d0edb2c73bbc5b",
"title": "dd69a3e9689a7b3e8f3c1d7089d0edb2c73bbc5b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/dd69a3e9689a7b3e8f3c1d7089d0edb2c73bbc5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "3bdd8b5395de3915d7b9f033d8d21af8dec5028f"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@3bdd8b5395de3915d7b9f033d8d21af8dec5028f",
"title": "3bdd8b5395de3915d7b9f033d8d21af8dec5028f",
"url": "https://fuchsia.googlesource.com/fuchsia/+/3bdd8b5395de3915d7b9f033d8d21af8dec5028f"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "3bdd8b5395de3915d7b9f033d8d21af8dec5028f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915328697962386048"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-coverage-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:37:02.502] Scheduled build:
{
"id": "8749898635969839681",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-23T03:37:01.925483208Z",
"updateTime": "2024-04-23T03:37:01.925483208Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "3bdd8b5395de3915d7b9f033d8d21af8dec5028f",
"ref": "refs/heads/main"
}
}
}
[03:37:02.502] Task URL: https://cr-buildbucket.appspot.com/build/8749898635969839681
[03:37:02.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:2:0) after 1m13s
[03:37:03.368] Received PubSub notification, asking Buildbucket for the build status
[03:37:03.407] Build status: SCHEDULED
[03:38:15.522] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:2:0)
[03:38:15.581] Build status: SCHEDULED
[03:38:15.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:4:0) after 5m13s
[03:39:12.477] Received PubSub notification, asking Buildbucket for the build status
[03:39:12.551] Build status: STARTED
[03:43:28.663] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:4:0)
[03:43:28.722] Build status: STARTED
[03:43:28.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:6:0) after 4m12s
[03:47:40.709] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:6:0)
[03:47:40.734] Build status: STARTED
[03:47:40.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:7:0) after 1m46s
[03:49:26.750] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:7:0)
[03:49:26.820] Build status: STARTED
[03:49:26.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:8:0) after 9m3s
[03:58:29.842] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:8:0)
[03:58:29.871] Build status: STARTED
[03:58:29.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:9:0) after 5m33s
[04:04:03.080] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:9:0)
[04:04:03.109] Build status: STARTED
[04:04:03.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:10:0) after 7m15s
[04:11:18.807] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:10:0)
[04:11:18.852] Build status: STARTED
[04:11:18.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:11:0) after 5m53s
[04:17:11.872] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:11:0)
[04:17:11.896] Build status: STARTED
[04:17:11.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:12:0) after 2m39s
[04:19:51.048] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:12:0)
[04:19:51.100] Build status: STARTED
[04:19:51.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:13:0) after 2m52s
[04:22:43.122] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:13:0)
[04:22:43.141] Build status: STARTED
[04:22:43.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:14:0) after 6m33s
[04:29:16.173] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:14:0)
[04:29:16.194] Build status: STARTED
[04:29:16.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:15:0) after 7m21s
[04:36:37.217] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:15:0)
[04:36:37.235] Build status: STARTED
[04:36:37.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:16:0) after 5m33s
[04:42:10.468] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:16:0)
[04:42:10.487] Build status: STARTED
[04:42:10.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:17:0) after 9m55s
[04:52:05.505] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:17:0)
[04:52:05.543] Build status: STARTED
[04:52:05.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:18:0) after 5m58s
[04:58:03.956] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:18:0)
[04:58:04.133] Build status: STARTED
[04:58:04.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:19:0) after 9m57s
[05:08:01.153] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:19:0)
[05:08:01.183] Build status: STARTED
[05:08:01.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:20:0) after 2m37s
[05:10:38.205] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:20:0)
[05:10:38.278] Build status: STARTED
[05:10:38.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:21:0) after 9m50s
[05:20:28.298] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:21:0)
[05:20:28.319] Build status: STARTED
[05:20:28.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:22:0) after 1m17s
[05:21:45.618] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:22:0)
[05:21:45.684] Build status: STARTED
[05:21:45.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:23:0) after 2m32s
[05:24:17.926] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:23:0)
[05:24:17.959] Build status: STARTED
[05:24:17.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:24:0) after 1m2s
[05:25:20.092] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:24:0)
[05:25:20.162] Build status: STARTED
[05:25:20.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:25:0) after 5m18s
[05:30:38.195] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:25:0)
[05:30:38.219] Build status: STARTED
[05:30:38.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:26:0) after 1m21s
[05:31:59.338] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:26:0)
[05:31:59.360] Build status: STARTED
[05:31:59.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:27:0) after 6m31s
[05:38:30.491] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:27:0)
[05:38:30.519] Build status: STARTED
[05:38:30.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:28:0) after 2m47s
[05:41:17.579] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:28:0)
[05:41:17.603] Build status: STARTED
[05:41:17.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:29:0) after 4m24s
[05:45:41.581] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:29:0)
[05:45:41.601] Build status: STARTED
[05:45:41.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:30:0) after 9m52s
[05:55:33.719] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:30:0)
[05:55:33.747] Build status: STARTED
[05:55:33.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:31:0) after 3m41s
[05:59:14.748] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:31:0)
[05:59:14.788] Build status: STARTED
[05:59:14.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:32:0) after 6m51s
[06:06:05.814] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:32:0)
[06:06:05.834] Build status: STARTED
[06:06:05.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:33:0) after 8m1s
[06:14:06.861] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:33:0)
[06:14:06.883] Build status: STARTED
[06:14:06.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:34:0) after 7m19s
[06:21:25.906] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:34:0)
[06:21:25.929] Build status: STARTED
[06:21:25.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:35:0) after 3m37s
[06:25:02.946] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:35:0)
[06:25:02.974] Build status: STARTED
[06:25:02.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:36:0) after 7m34s
[06:32:36.999] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:36:0)
[06:32:37.031] Build status: STARTED
[06:32:37.031] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:37:0) after 5m58s
[06:38:35.233] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:37:0)
[06:38:35.252] Build status: STARTED
[06:38:35.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:38:0) after 2m24s
[06:40:59.273] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:38:0)
[06:40:59.290] Build status: STARTED
[06:40:59.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:39:0) after 2m2s
[06:43:01.311] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:39:0)
[06:43:01.351] Build status: STARTED
[06:43:01.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:40:0) after 3m53s
[06:46:54.402] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:40:0)
[06:46:54.423] Build status: STARTED
[06:46:54.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:41:0) after 3m29s
[06:50:23.537] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:41:0)
[06:50:23.611] Build status: STARTED
[06:50:23.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:42:0) after 4m0s
[06:54:23.879] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:42:0)
[06:54:23.902] Build status: STARTED
[06:54:23.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:43:0) after 9m21s
[07:03:45.036] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:43:0)
[07:03:45.057] Build status: STARTED
[07:03:45.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:44:0) after 8m30s
[07:12:15.164] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:44:0)
[07:12:15.187] Build status: STARTED
[07:12:15.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:45:0) after 5m42s
[07:17:57.319] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:45:0)
[07:17:57.349] Build status: STARTED
[07:17:57.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:46:0) after 3m18s
[07:21:15.957] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:46:0)
[07:21:15.979] Build status: STARTED
[07:21:15.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:47:0) after 7m11s
[07:28:27.146] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:47:0)
[07:28:27.173] Build status: STARTED
[07:28:27.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:48:0) after 3m14s
[07:31:41.282] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:48:0)
[07:31:41.301] Build status: STARTED
[07:31:41.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:49:0) after 9m45s
[07:41:26.329] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:49:0)
[07:41:26.354] Build status: STARTED
[07:41:26.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:50:0) after 5m15s
[07:46:41.427] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:50:0)
[07:46:41.459] Build status: STARTED
[07:46:41.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:51:0) after 7m55s
[07:54:36.450] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:51:0)
[07:54:36.469] Build status: STARTED
[07:54:36.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:52:0) after 8m4s
[08:02:40.500] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:52:0)
[08:02:40.549] Build status: STARTED
[08:02:40.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:53:0) after 7m32s
[08:10:12.752] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:53:0)
[08:10:12.833] Build status: STARTED
[08:10:12.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:54:0) after 4m48s
[08:15:01.186] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:54:0)
[08:15:01.378] Build status: STARTED
[08:15:01.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:55:0) after 1m22s
[08:16:23.561] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:55:0)
[08:16:23.593] Build status: STARTED
[08:16:23.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:56:0) after 7m59s
[08:24:22.662] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:56:0)
[08:24:22.691] Build status: STARTED
[08:24:22.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:57:0) after 3m59s
[08:28:21.793] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:57:0)
[08:28:21.835] Build status: STARTED
[08:28:21.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:58:0) after 2m30s
[08:30:51.855] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:58:0)
[08:30:51.935] Build status: STARTED
[08:30:51.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:59:0) after 3m39s
[08:34:31.013] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:59:0)
[08:34:31.035] Build status: STARTED
[08:34:31.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:60:0) after 2m52s
[08:37:23.057] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:60:0)
[08:37:23.079] Build status: STARTED
[08:37:23.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8915328697962386048:61:0) after 8m53s
[08:42:17.146] Received PubSub notification, asking Buildbucket for the build status
[08:42:17.164] Build:
{
"id": "8749898635969839681",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-23T03:37:01.925483208Z",
"startTime": "2024-04-23T03:39:11.981883857Z",
"endTime": "2024-04-23T08:40:25.134825037Z",
"updateTime": "2024-04-23T08:40:25.134825037Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "3bdd8b5395de3915d7b9f033d8d21af8dec5028f",
"ref": "refs/heads/main"
}
}
}
[08:42:17.164] Invocation finished in 5h5m16.522850452s with status SUCCEEDED