[17:15:20.596] New invocation is queued and will start shortly
[17:15:21.689] Starting the invocation (attempt 1)
[17:15:21.716] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/4d7e54d1f0affce74b6115ea7ab152018ef63e03"
[17:15:21.716] Popped gitiles commit info from properties and tags
[17:15:21.716] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:15:21.716] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:15:21.717] Buildbucket request:
{
"requestId": "8915186615969649856",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8915186615969649856",
"job": "fuchsia/core.x64-full_determinism-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd9d5bd5f4bfdbf8c0a5dc7634a3a15174f57824"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd9d5bd5f4bfdbf8c0a5dc7634a3a15174f57824",
"title": "cd9d5bd5f4bfdbf8c0a5dc7634a3a15174f57824",
"url": "https://fuchsia.googlesource.com/integration/+/cd9d5bd5f4bfdbf8c0a5dc7634a3a15174f57824"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ffed0d406cbaee31d5aeba3c0c14fe24ad281b57"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ffed0d406cbaee31d5aeba3c0c14fe24ad281b57",
"title": "ffed0d406cbaee31d5aeba3c0c14fe24ad281b57",
"url": "https://fuchsia.googlesource.com/integration/+/ffed0d406cbaee31d5aeba3c0c14fe24ad281b57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ddd0243c34b05db2f037706af5bc3234bf84b678"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ddd0243c34b05db2f037706af5bc3234bf84b678",
"title": "ddd0243c34b05db2f037706af5bc3234bf84b678",
"url": "https://fuchsia.googlesource.com/integration/+/ddd0243c34b05db2f037706af5bc3234bf84b678"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "91ecb5defaaf109390c22e10e60bec1794fa0584"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@91ecb5defaaf109390c22e10e60bec1794fa0584",
"title": "91ecb5defaaf109390c22e10e60bec1794fa0584",
"url": "https://fuchsia.googlesource.com/integration/+/91ecb5defaaf109390c22e10e60bec1794fa0584"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd44895e77070cf596d5925bd9de05715e21184c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd44895e77070cf596d5925bd9de05715e21184c",
"title": "dd44895e77070cf596d5925bd9de05715e21184c",
"url": "https://fuchsia.googlesource.com/integration/+/dd44895e77070cf596d5925bd9de05715e21184c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6fdf68b894b02e0d6e12670967fa53bbfd5be321"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6fdf68b894b02e0d6e12670967fa53bbfd5be321",
"title": "6fdf68b894b02e0d6e12670967fa53bbfd5be321",
"url": "https://fuchsia.googlesource.com/integration/+/6fdf68b894b02e0d6e12670967fa53bbfd5be321"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36206e6af599b6ac332706bcd01186589a02a775"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36206e6af599b6ac332706bcd01186589a02a775",
"title": "36206e6af599b6ac332706bcd01186589a02a775",
"url": "https://fuchsia.googlesource.com/integration/+/36206e6af599b6ac332706bcd01186589a02a775"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "46ccdce6291adfecd8fdbd3e2b0878c385690cd2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@46ccdce6291adfecd8fdbd3e2b0878c385690cd2",
"title": "46ccdce6291adfecd8fdbd3e2b0878c385690cd2",
"url": "https://fuchsia.googlesource.com/integration/+/46ccdce6291adfecd8fdbd3e2b0878c385690cd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "607f8379284443f4fd876644c35eaa44b5deea93"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@607f8379284443f4fd876644c35eaa44b5deea93",
"title": "607f8379284443f4fd876644c35eaa44b5deea93",
"url": "https://fuchsia.googlesource.com/integration/+/607f8379284443f4fd876644c35eaa44b5deea93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a133162040d1b00819f3670ddd54dd7d8d868898"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a133162040d1b00819f3670ddd54dd7d8d868898",
"title": "a133162040d1b00819f3670ddd54dd7d8d868898",
"url": "https://fuchsia.googlesource.com/integration/+/a133162040d1b00819f3670ddd54dd7d8d868898"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4a5c67d5e710160d8ea6eac9216be2ce670653b0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4a5c67d5e710160d8ea6eac9216be2ce670653b0",
"title": "4a5c67d5e710160d8ea6eac9216be2ce670653b0",
"url": "https://fuchsia.googlesource.com/integration/+/4a5c67d5e710160d8ea6eac9216be2ce670653b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "47189db0b29f0d8de549c4bc18c5c55aa7dc6f15"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@47189db0b29f0d8de549c4bc18c5c55aa7dc6f15",
"title": "47189db0b29f0d8de549c4bc18c5c55aa7dc6f15",
"url": "https://fuchsia.googlesource.com/integration/+/47189db0b29f0d8de549c4bc18c5c55aa7dc6f15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1bc71c45bce841bfc99384a735ea9c0b44163e9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1bc71c45bce841bfc99384a735ea9c0b44163e9e",
"title": "1bc71c45bce841bfc99384a735ea9c0b44163e9e",
"url": "https://fuchsia.googlesource.com/integration/+/1bc71c45bce841bfc99384a735ea9c0b44163e9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4d7e54d1f0affce74b6115ea7ab152018ef63e03"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4d7e54d1f0affce74b6115ea7ab152018ef63e03",
"title": "4d7e54d1f0affce74b6115ea7ab152018ef63e03",
"url": "https://fuchsia.googlesource.com/integration/+/4d7e54d1f0affce74b6115ea7ab152018ef63e03"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4d7e54d1f0affce74b6115ea7ab152018ef63e03",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915186615969649856"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-full_determinism-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:15:22.213] Scheduled build:
{
"id": "8749756554058823569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-24T17:15:21.794018630Z",
"updateTime": "2024-04-24T17:15:21.794018630Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4d7e54d1f0affce74b6115ea7ab152018ef63e03",
"ref": "refs/heads/main"
}
}
}
[17:15:22.213] Task URL: https://cr-buildbucket.appspot.com/build/8749756554058823569
[17:15:22.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:2:0) after 1m16s
[17:15:22.404] Received PubSub notification, asking Buildbucket for the build status
[17:15:22.438] Build status: SCHEDULED
[17:15:29.156] Received PubSub notification, asking Buildbucket for the build status
[17:15:29.186] Build status: STARTED
[17:16:38.234] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:2:0)
[17:16:38.285] Build status: STARTED
[17:16:38.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:5:0) after 2m29s
[17:19:07.348] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:5:0)
[17:19:07.365] Build status: STARTED
[17:19:07.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:6:0) after 8m7s
[17:27:14.433] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:6:0)
[17:27:14.455] Build status: STARTED
[17:27:14.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:7:0) after 1m57s
[17:29:11.506] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:7:0)
[17:29:11.534] Build status: STARTED
[17:29:11.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:8:0) after 5m43s
[17:34:54.582] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:8:0)
[17:34:54.664] Build status: STARTED
[17:34:54.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:9:0) after 3m54s
[17:38:48.756] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:9:0)
[17:38:48.778] Build status: STARTED
[17:38:48.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:10:0) after 7m54s
[17:46:42.818] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:10:0)
[17:46:42.872] Build status: STARTED
[17:46:42.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:11:0) after 1m1s
[17:47:43.890] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:11:0)
[17:47:44.016] Build status: STARTED
[17:47:44.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:12:0) after 5m7s
[17:52:51.035] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:12:0)
[17:52:51.052] Build status: STARTED
[17:52:51.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:13:0) after 7m3s
[17:59:54.080] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:13:0)
[17:59:54.133] Build status: STARTED
[17:59:54.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:14:0) after 9m32s
[18:09:26.149] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:14:0)
[18:09:26.199] Build status: STARTED
[18:09:26.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:15:0) after 8m2s
[18:17:28.253] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:15:0)
[18:17:28.275] Build status: STARTED
[18:17:28.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:16:0) after 4m42s
[18:22:10.294] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:16:0)
[18:22:10.333] Build status: STARTED
[18:22:10.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:17:0) after 4m56s
[18:27:06.387] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:17:0)
[18:27:06.412] Build status: STARTED
[18:27:06.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:18:0) after 1m48s
[18:28:54.479] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:18:0)
[18:28:54.496] Build status: STARTED
[18:28:54.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:19:0) after 1m31s
[18:30:25.546] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:19:0)
[18:30:25.575] Build status: STARTED
[18:30:25.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:20:0) after 2m7s
[18:32:32.596] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:20:0)
[18:32:32.657] Build status: STARTED
[18:32:32.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:21:0) after 6m15s
[18:38:47.627] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:21:0)
[18:38:47.707] Build status: STARTED
[18:38:47.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:22:0) after 3m33s
[18:42:20.841] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:22:0)
[18:42:20.885] Build status: STARTED
[18:42:20.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:23:0) after 3m44s
[18:46:04.958] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:23:0)
[18:46:04.984] Build status: STARTED
[18:46:04.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:24:0) after 7m51s
[18:53:56.083] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:24:0)
[18:53:56.101] Build status: STARTED
[18:53:56.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:25:0) after 3m14s
[18:57:10.144] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:25:0)
[18:57:10.236] Build status: STARTED
[18:57:10.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:26:0) after 2m20s
[18:59:30.433] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:26:0)
[18:59:30.455] Build status: STARTED
[18:59:30.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:27:0) after 5m34s
[19:05:04.755] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:27:0)
[19:05:04.803] Build status: STARTED
[19:05:04.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:28:0) after 7m13s
[19:12:17.830] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:28:0)
[19:12:17.848] Build status: STARTED
[19:12:17.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:29:0) after 5m43s
[19:18:01.158] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:29:0)
[19:18:01.175] Build status: STARTED
[19:18:01.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:30:0) after 4m34s
[19:22:35.358] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:30:0)
[19:22:35.401] Build status: STARTED
[19:22:35.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:31:0) after 2m53s
[19:25:28.594] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:31:0)
[19:25:28.617] Build status: STARTED
[19:25:28.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:32:0) after 4m34s
[19:30:02.659] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:32:0)
[19:30:02.678] Build status: STARTED
[19:30:02.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:33:0) after 5m9s
[19:35:11.818] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:33:0)
[19:35:11.841] Build status: STARTED
[19:35:11.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:34:0) after 4m27s
[19:39:38.948] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:34:0)
[19:39:38.979] Build status: STARTED
[19:39:38.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:35:0) after 2m45s
[19:42:24.418] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:35:0)
[19:42:24.459] Build status: STARTED
[19:42:24.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:36:0) after 8m4s
[19:50:28.578] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:36:0)
[19:50:28.610] Build status: STARTED
[19:50:28.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:37:0) after 8m59s
[19:59:27.927] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:37:0)
[19:59:27.945] Build status: STARTED
[19:59:27.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:38:0) after 3m15s
[20:02:43.027] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:38:0)
[20:02:43.079] Build status: STARTED
[20:02:43.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:39:0) after 4m22s
[20:07:05.290] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:39:0)
[20:07:05.328] Build status: STARTED
[20:07:05.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:40:0) after 6m43s
[20:13:48.532] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:40:0)
[20:13:48.640] Build status: STARTED
[20:13:48.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:41:0) after 4m59s
[20:18:47.758] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:41:0)
[20:18:47.779] Build status: STARTED
[20:18:47.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:42:0) after 3m0s
[20:21:48.065] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:42:0)
[20:21:48.092] Build status: STARTED
[20:21:48.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:43:0) after 4m45s
[20:26:33.113] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:43:0)
[20:26:33.131] Build status: STARTED
[20:26:33.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:44:0) after 1m55s
[20:28:28.158] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:44:0)
[20:28:28.182] Build status: STARTED
[20:28:28.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:45:0) after 7m46s
[20:36:14.209] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:45:0)
[20:36:14.231] Build status: STARTED
[20:36:14.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:46:0) after 7m33s
[20:43:47.245] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:46:0)
[20:43:47.264] Build status: STARTED
[20:43:47.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:47:0) after 6m48s
[20:50:35.317] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:47:0)
[20:50:35.382] Build status: STARTED
[20:50:35.382] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:48:0) after 2m3s
[20:52:38.402] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:48:0)
[20:52:38.443] Build status: STARTED
[20:52:38.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:49:0) after 3m58s
[20:56:36.460] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:49:0)
[20:56:36.476] Build status: STARTED
[20:56:36.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:50:0) after 4m15s
[21:00:51.544] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:50:0)
[21:00:51.575] Build status: STARTED
[21:00:51.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:51:0) after 9m18s
[21:10:09.630] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:51:0)
[21:10:09.648] Build status: STARTED
[21:10:09.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:52:0) after 3m28s
[21:13:37.691] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:52:0)
[21:13:37.712] Build status: STARTED
[21:13:37.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-full_determinism-e5a0ec7f:8915186615969649856:53:0) after 8m41s
[21:20:11.330] Received PubSub notification, asking Buildbucket for the build status
[21:20:11.401] Build:
{
"id": "8749756554058823569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-full_determinism"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-24T17:15:21.794018630Z",
"startTime": "2024-04-24T17:15:28.680251507Z",
"endTime": "2024-04-24T21:20:10.824659077Z",
"updateTime": "2024-04-24T21:20:10.824659077Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4d7e54d1f0affce74b6115ea7ab152018ef63e03",
"ref": "refs/heads/main"
}
}
}
[21:20:11.401] Invocation finished in 4h4m50.813110084s with status FAILED