[02:48:30.828] New invocation is queued and will start shortly
[02:48:31.946] Starting the invocation (attempt 1)
[02:48:31.982] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/96f941bde9f6444a1d3d0195a97d870fa14e26dd"
[02:48:31.982] Popped gitiles commit info from properties and tags
[02:48:31.982] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:48:31.982] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:48:31.983] Buildbucket request:
{
"requestId": "8894132058990745792",
"builder": {
"project": "pigweed",
"bucket": "pigweed.ci",
"builder": "pigweed-mac-x86-gn-compatibility-main"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894132058990745792",
"job": "pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "737e613feaf6c0afed3ff7505f0bc6588bf12d7e"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@737e613feaf6c0afed3ff7505f0bc6588bf12d7e",
"title": "737e613feaf6c0afed3ff7505f0bc6588bf12d7e",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/737e613feaf6c0afed3ff7505f0bc6588bf12d7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "df92f9fde67779d5a3af2ca653de572ea27576ad"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@df92f9fde67779d5a3af2ca653de572ea27576ad",
"title": "df92f9fde67779d5a3af2ca653de572ea27576ad",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/df92f9fde67779d5a3af2ca653de572ea27576ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "f58927a7721bf50d5485d2971b8c9e41495fdb17"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@f58927a7721bf50d5485d2971b8c9e41495fdb17",
"title": "f58927a7721bf50d5485d2971b8c9e41495fdb17",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/f58927a7721bf50d5485d2971b8c9e41495fdb17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "046c562b277b608273e46355f76d90b46e7ec2e7"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@046c562b277b608273e46355f76d90b46e7ec2e7",
"title": "046c562b277b608273e46355f76d90b46e7ec2e7",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/046c562b277b608273e46355f76d90b46e7ec2e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "3e465753b64807b0c9623509ed67678314dc76e5"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@3e465753b64807b0c9623509ed67678314dc76e5",
"title": "3e465753b64807b0c9623509ed67678314dc76e5",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/3e465753b64807b0c9623509ed67678314dc76e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "2592257b5ef66154fb4740791dd3d5afce4c27c0"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@2592257b5ef66154fb4740791dd3d5afce4c27c0",
"title": "2592257b5ef66154fb4740791dd3d5afce4c27c0",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/2592257b5ef66154fb4740791dd3d5afce4c27c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "5fc83027332ca8f6009a98522465dc685606ca5b"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@5fc83027332ca8f6009a98522465dc685606ca5b",
"title": "5fc83027332ca8f6009a98522465dc685606ca5b",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/5fc83027332ca8f6009a98522465dc685606ca5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "aa9a4e865876aee0e120d6bf0e08d15c0eb71f63"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@aa9a4e865876aee0e120d6bf0e08d15c0eb71f63",
"title": "aa9a4e865876aee0e120d6bf0e08d15c0eb71f63",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/aa9a4e865876aee0e120d6bf0e08d15c0eb71f63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "9cda022cf16cda41306868f38a3fe0791cc0738a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@9cda022cf16cda41306868f38a3fe0791cc0738a",
"title": "9cda022cf16cda41306868f38a3fe0791cc0738a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/9cda022cf16cda41306868f38a3fe0791cc0738a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "96f941bde9f6444a1d3d0195a97d870fa14e26dd"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@96f941bde9f6444a1d3d0195a97d870fa14e26dd",
"title": "96f941bde9f6444a1d3d0195a97d870fa14e26dd",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/96f941bde9f6444a1d3d0195a97d870fa14e26dd"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "96f941bde9f6444a1d3d0195a97d870fa14e26dd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894132058990745792"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:48:32.336] Scheduled build:
{
"id": "8728701997055723345",
"builder": {
"project": "pigweed",
"bucket": "pigweed.ci",
"builder": "pigweed-mac-x86-gn-compatibility-main"
},
"createdBy": "project:pigweed",
"createTime": "2024-12-13T02:48:32.052202721Z",
"updateTime": "2024-12-13T02:48:32.052202721Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "96f941bde9f6444a1d3d0195a97d870fa14e26dd",
"ref": "refs/heads/main"
}
}
}
[02:48:32.336] Task URL: https://cr-buildbucket.appspot.com/build/8728701997055723345
[02:48:32.336] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:2:0) after 3m25s
[02:48:33.365] Received PubSub notification, asking Buildbucket for the build status
[02:48:33.400] Build status: SCHEDULED
[02:51:57.352] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:2:0)
[02:51:57.375] Build status: SCHEDULED
[02:51:57.375] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:4:0) after 9m6s
[03:01:03.356] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:4:0)
[03:01:03.374] Build status: SCHEDULED
[03:01:03.374] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:5:0) after 3m44s
[03:04:47.466] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:5:0)
[03:04:47.490] Build status: SCHEDULED
[03:04:47.490] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:6:0) after 5m0s
[03:09:47.510] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:6:0)
[03:09:47.530] Build status: SCHEDULED
[03:09:47.530] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:7:0) after 2m27s
[03:12:14.546] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:7:0)
[03:12:14.600] Build status: SCHEDULED
[03:12:14.600] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:8:0) after 4m47s
[03:17:01.601] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:8:0)
[03:17:01.662] Build status: SCHEDULED
[03:17:01.662] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:9:0) after 7m30s
[03:24:31.681] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:9:0)
[03:24:31.707] Build status: SCHEDULED
[03:24:31.707] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:10:0) after 5m23s
[03:29:54.780] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:10:0)
[03:29:54.798] Build status: SCHEDULED
[03:29:54.798] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:11:0) after 4m25s
[03:34:19.819] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:11:0)
[03:34:19.841] Build status: SCHEDULED
[03:34:19.841] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:12:0) after 3m26s
[03:37:45.964] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:12:0)
[03:37:45.987] Build status: SCHEDULED
[03:37:45.987] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:13:0) after 1m5s
[03:38:51.119] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:13:0)
[03:38:51.137] Build status: SCHEDULED
[03:38:51.137] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:14:0) after 4m53s
[03:43:44.412] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:14:0)
[03:43:44.444] Build status: SCHEDULED
[03:43:44.444] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:15:0) after 4m35s
[03:48:19.578] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:15:0)
[03:48:19.604] Build status: SCHEDULED
[03:48:19.604] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:16:0) after 1m21s
[03:49:40.621] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:16:0)
[03:49:40.693] Build status: SCHEDULED
[03:49:40.693] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:17:0) after 4m53s
[03:54:33.711] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:17:0)
[03:54:33.730] Build status: SCHEDULED
[03:54:33.730] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:18:0) after 7m16s
[04:01:49.746] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:18:0)
[04:01:49.773] Build status: SCHEDULED
[04:01:49.773] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:19:0) after 2m52s
[04:03:38.707] Received PubSub notification, asking Buildbucket for the build status
[04:03:38.725] Build status: STARTED
[04:04:41.789] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:19:0)
[04:04:41.813] Build status: STARTED
[04:04:41.813] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:21:0) after 1m58s
[04:06:39.881] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:21:0)
[04:06:39.965] Build status: STARTED
[04:06:39.966] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:22:0) after 5m14s
[04:11:54.087] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:22:0)
[04:11:54.269] Build status: STARTED
[04:11:54.269] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:23:0) after 4m45s
[04:16:39.399] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:23:0)
[04:16:39.424] Build status: STARTED
[04:16:39.424] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:24:0) after 5m6s
[04:21:45.494] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:24:0)
[04:21:45.527] Build status: STARTED
[04:21:45.527] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:25:0) after 2m51s
[04:24:36.629] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:25:0)
[04:24:36.649] Build status: STARTED
[04:24:36.649] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:26:0) after 5m16s
[04:29:52.677] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:26:0)
[04:29:52.696] Build status: STARTED
[04:29:52.696] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:27:0) after 7m32s
[04:37:24.765] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:27:0)
[04:37:24.783] Build status: STARTED
[04:37:24.783] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:28:0) after 6m8s
[04:43:33.168] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:28:0)
[04:43:33.188] Build status: STARTED
[04:43:33.188] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:29:0) after 5m23s
[04:48:56.307] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:29:0)
[04:48:56.333] Build status: STARTED
[04:48:56.333] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.ci-pigweed-mac-x86-gn-compatibility-main:8894132058990745792:30:0) after 9m37s
[04:54:42.727] Received PubSub notification, asking Buildbucket for the build status
[04:54:42.748] Build:
{
"id": "8728701997055723345",
"builder": {
"project": "pigweed",
"bucket": "pigweed.ci",
"builder": "pigweed-mac-x86-gn-compatibility-main"
},
"createdBy": "project:pigweed",
"createTime": "2024-12-13T02:48:32.052202721Z",
"startTime": "2024-12-13T04:03:31.142735418Z",
"endTime": "2024-12-13T04:54:42.242785259Z",
"updateTime": "2024-12-13T04:54:42.242785259Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "96f941bde9f6444a1d3d0195a97d870fa14e26dd",
"ref": "refs/heads/main"
}
}
}
[04:54:42.748] Invocation finished in 2h6m11.924311432s with status SUCCEEDED