[20:12:28.871] New invocation is queued and will start shortly
[20:12:29.929] Starting the invocation (attempt 1)
[20:12:29.958] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b0be251b7829217e9c178ce33daee0407d050305"
[20:12:29.958] Popped gitiles commit info from properties and tags
[20:12:29.958] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:12:29.958] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:12:29.959] Buildbucket request:
{
"requestId": "8923963377158687584",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8923963377158687584",
"job": "fuchsia/core.x64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "11d477c959fa558db5f9c02c72ddc614043bc972"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@11d477c959fa558db5f9c02c72ddc614043bc972",
"title": "11d477c959fa558db5f9c02c72ddc614043bc972",
"url": "https://fuchsia.googlesource.com/integration/+/11d477c959fa558db5f9c02c72ddc614043bc972"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f81ca22e92d5ba03840c378ac2c0904c858de38c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f81ca22e92d5ba03840c378ac2c0904c858de38c",
"title": "f81ca22e92d5ba03840c378ac2c0904c858de38c",
"url": "https://fuchsia.googlesource.com/integration/+/f81ca22e92d5ba03840c378ac2c0904c858de38c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "388f69fd45615e0290076333f0e8c99ca64a8e50"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@388f69fd45615e0290076333f0e8c99ca64a8e50",
"title": "388f69fd45615e0290076333f0e8c99ca64a8e50",
"url": "https://fuchsia.googlesource.com/integration/+/388f69fd45615e0290076333f0e8c99ca64a8e50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c16bd75218b416ced92ee43148205bc2250cad7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c16bd75218b416ced92ee43148205bc2250cad7",
"title": "6c16bd75218b416ced92ee43148205bc2250cad7",
"url": "https://fuchsia.googlesource.com/integration/+/6c16bd75218b416ced92ee43148205bc2250cad7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "245166847320047dace47900040b96ad313720d6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@245166847320047dace47900040b96ad313720d6",
"title": "245166847320047dace47900040b96ad313720d6",
"url": "https://fuchsia.googlesource.com/integration/+/245166847320047dace47900040b96ad313720d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd019bc803883e5d8d1b7e7d5d2ea5debdd64c12"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd019bc803883e5d8d1b7e7d5d2ea5debdd64c12",
"title": "bd019bc803883e5d8d1b7e7d5d2ea5debdd64c12",
"url": "https://fuchsia.googlesource.com/integration/+/bd019bc803883e5d8d1b7e7d5d2ea5debdd64c12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f3fd003155205c59c44b9ead46baf00ed18b4b18"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f3fd003155205c59c44b9ead46baf00ed18b4b18",
"title": "f3fd003155205c59c44b9ead46baf00ed18b4b18",
"url": "https://fuchsia.googlesource.com/integration/+/f3fd003155205c59c44b9ead46baf00ed18b4b18"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "07bba9c33ff5a59d7054759bade74b053900ea17"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@07bba9c33ff5a59d7054759bade74b053900ea17",
"title": "07bba9c33ff5a59d7054759bade74b053900ea17",
"url": "https://fuchsia.googlesource.com/integration/+/07bba9c33ff5a59d7054759bade74b053900ea17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "01bac978c6125aab3c92cf52401cd6344f945f9a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@01bac978c6125aab3c92cf52401cd6344f945f9a",
"title": "01bac978c6125aab3c92cf52401cd6344f945f9a",
"url": "https://fuchsia.googlesource.com/integration/+/01bac978c6125aab3c92cf52401cd6344f945f9a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a47d06495c71934dcf7ade9e4344d46f9c3e8682"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a47d06495c71934dcf7ade9e4344d46f9c3e8682",
"title": "a47d06495c71934dcf7ade9e4344d46f9c3e8682",
"url": "https://fuchsia.googlesource.com/integration/+/a47d06495c71934dcf7ade9e4344d46f9c3e8682"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6ad186298d2beb97686ebaad4ce8f13d68fdcbab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6ad186298d2beb97686ebaad4ce8f13d68fdcbab",
"title": "6ad186298d2beb97686ebaad4ce8f13d68fdcbab",
"url": "https://fuchsia.googlesource.com/integration/+/6ad186298d2beb97686ebaad4ce8f13d68fdcbab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b0be251b7829217e9c178ce33daee0407d050305"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b0be251b7829217e9c178ce33daee0407d050305",
"title": "b0be251b7829217e9c178ce33daee0407d050305",
"url": "https://fuchsia.googlesource.com/integration/+/b0be251b7829217e9c178ce33daee0407d050305"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b0be251b7829217e9c178ce33daee0407d050305",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8923963377158687584"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:12:30.523] Scheduled build:
{
"id": "8758533315270201121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T20:12:30.046844846Z",
"updateTime": "2024-01-18T20:12:30.046844846Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b0be251b7829217e9c178ce33daee0407d050305",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:12:30.523] Task URL: https://cr-buildbucket.appspot.com/build/8758533315270201121
[20:12:30.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:2:0) after 5m33s
[20:12:31.395] Received PubSub notification, asking Buildbucket for the build status
[20:12:31.420] Build status: SCHEDULED
[20:13:29.698] Received PubSub notification, asking Buildbucket for the build status
[20:13:29.725] Build status: STARTED
[20:18:03.539] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:2:0)
[20:18:03.599] Build status: STARTED
[20:18:03.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:5:0) after 2m47s
[20:20:51.023] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:5:0)
[20:20:51.039] Build status: STARTED
[20:20:51.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:6:0) after 3m11s
[20:24:02.071] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:6:0)
[20:24:02.087] Build status: STARTED
[20:24:02.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:7:0) after 4m35s
[20:28:37.067] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:7:0)
[20:28:37.102] Build status: STARTED
[20:28:37.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:8:0) after 9m17s
[20:37:54.247] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:8:0)
[20:37:54.277] Build status: STARTED
[20:37:54.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:9:0) after 3m6s
[20:41:00.763] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:9:0)
[20:41:00.829] Build status: STARTED
[20:41:00.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:10:0) after 6m17s
[20:47:18.943] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:10:0)
[20:47:18.961] Build status: STARTED
[20:47:18.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:11:0) after 2m16s
[20:49:35.487] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:11:0)
[20:49:35.505] Build status: STARTED
[20:49:35.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:12:0) after 9m22s
[20:58:57.545] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:12:0)
[20:58:57.628] Build status: STARTED
[20:58:57.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8923963377158687584:13:0) after 4m58s
[20:59:11.779] Received PubSub notification, asking Buildbucket for the build status
[20:59:11.870] Build:
{
"id": "8758533315270201121",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T20:12:30.046844846Z",
"startTime": "2024-01-18T20:13:28.115654086Z",
"endTime": "2024-01-18T20:59:11.064020Z",
"updateTime": "2024-01-18T20:59:11.064020Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b0be251b7829217e9c178ce33daee0407d050305",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:59:11.870] Invocation finished in 46m43.00932846s with status SUCCEEDED