[15:05:01.216] New invocation is queued and will start shortly
[15:05:02.495] Starting the invocation (attempt 1)
[15:05:02.533] Popped buildset tag "buildset:commit/gitiles/gnu.googlesource.com/gcc/+/80f7f229883f28d11da18c75c9a97f89ce00a1ab"
[15:05:02.533] Popped gitiles commit info from properties and tags
[15:05:02.533] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:05:02.533] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:05:02.534] Buildbucket request:
{
"requestId": "8873248419748409968",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873248419748409968",
"job": "fuchsia/prod-gcc-prod-trigger-ea383322",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/releases/gcc-15",
"repo": "https://gnu.googlesource.com/gcc",
"revision": "35be043e4d2d47a99ff81b0651bc57566b4d11f9"
},
"id": "https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-15@35be043e4d2d47a99ff81b0651bc57566b4d11f9",
"title": "35be043e4d2d47a99ff81b0651bc57566b4d11f9",
"url": "https://gnu.googlesource.com/gcc/+/35be043e4d2d47a99ff81b0651bc57566b4d11f9"
},
{
"gitiles": {
"ref": "refs/heads/releases/gcc-15",
"repo": "https://gnu.googlesource.com/gcc",
"revision": "121235441d072c2f5fd4d2cc0c342d45d6ac481f"
},
"id": "https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-15@121235441d072c2f5fd4d2cc0c342d45d6ac481f",
"title": "121235441d072c2f5fd4d2cc0c342d45d6ac481f",
"url": "https://gnu.googlesource.com/gcc/+/121235441d072c2f5fd4d2cc0c342d45d6ac481f"
},
{
"gitiles": {
"ref": "refs/heads/releases/gcc-15",
"repo": "https://gnu.googlesource.com/gcc",
"revision": "9e84a4552dd90ad2d15bd56ea168d945b4b71b98"
},
"id": "https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-15@9e84a4552dd90ad2d15bd56ea168d945b4b71b98",
"title": "9e84a4552dd90ad2d15bd56ea168d945b4b71b98",
"url": "https://gnu.googlesource.com/gcc/+/9e84a4552dd90ad2d15bd56ea168d945b4b71b98"
},
{
"gitiles": {
"ref": "refs/heads/releases/gcc-15",
"repo": "https://gnu.googlesource.com/gcc",
"revision": "b3da1801bef08c75f69f4376ffa05f1de2591ca8"
},
"id": "https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-15@b3da1801bef08c75f69f4376ffa05f1de2591ca8",
"title": "b3da1801bef08c75f69f4376ffa05f1de2591ca8",
"url": "https://gnu.googlesource.com/gcc/+/b3da1801bef08c75f69f4376ffa05f1de2591ca8"
},
{
"gitiles": {
"ref": "refs/heads/releases/gcc-15",
"repo": "https://gnu.googlesource.com/gcc",
"revision": "80f7f229883f28d11da18c75c9a97f89ce00a1ab"
},
"id": "https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-15@80f7f229883f28d11da18c75c9a97f89ce00a1ab",
"title": "80f7f229883f28d11da18c75c9a97f89ce00a1ab",
"url": "https://gnu.googlesource.com/gcc/+/80f7f229883f28d11da18c75c9a97f89ce00a1ab"
}
]
}
},
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "gcc",
"id": "80f7f229883f28d11da18c75c9a97f89ce00a1ab",
"ref": "refs/heads/releases/gcc-15"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873248419748409968"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-gcc-prod-trigger-ea383322"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:05:03.084] Scheduled build:
{
"id": "8707818357640134417",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-31T15:05:02.595201839Z",
"updateTime": "2025-07-31T15:05:02.595201839Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "gcc",
"id": "80f7f229883f28d11da18c75c9a97f89ce00a1ab",
"ref": "refs/heads/releases/gcc-15"
}
}
}
[15:05:03.084] Task URL: https://cr-buildbucket.appspot.com/build/8707818357640134417
[15:05:03.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:2:0) after 1m34s
[15:05:03.942] Received PubSub notification, asking Buildbucket for the build status
[15:05:03.976] Build status: SCHEDULED
[15:06:06.752] Received PubSub notification, asking Buildbucket for the build status
[15:06:06.813] Build status: STARTED
[15:06:37.164] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:2:0)
[15:06:37.191] Build status: STARTED
[15:06:37.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:5:0) after 6m21s
[15:12:58.297] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:5:0)
[15:12:58.426] Build status: STARTED
[15:12:58.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:6:0) after 6m54s
[15:19:52.525] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:6:0)
[15:19:52.553] Build status: STARTED
[15:19:52.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:7:0) after 4m9s
[15:24:01.619] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:7:0)
[15:24:01.636] Build status: STARTED
[15:24:01.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:8:0) after 2m30s
[15:26:31.821] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:8:0)
[15:26:31.847] Build status: STARTED
[15:26:31.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:9:0) after 7m42s
[15:34:13.874] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:9:0)
[15:34:13.910] Build status: STARTED
[15:34:13.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:10:0) after 2m50s
[15:37:04.004] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:10:0)
[15:37:04.038] Build status: STARTED
[15:37:04.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:11:0) after 6m49s
[15:43:53.064] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:11:0)
[15:43:53.142] Build status: STARTED
[15:43:53.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:12:0) after 9m55s
[15:53:48.233] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:12:0)
[15:53:48.263] Build status: STARTED
[15:53:48.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:13:0) after 9m6s
[16:02:54.295] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:13:0)
[16:02:54.314] Build status: STARTED
[16:02:54.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-prod-trigger-ea383322:8873248419748409968:14:0) after 9m29s
[16:05:54.182] Received PubSub notification, asking Buildbucket for the build status
[16:05:54.373] Build:
{
"id": "8707818357640134417",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-31T15:05:02.595201839Z",
"startTime": "2025-07-31T15:06:05.956174101Z",
"endTime": "2025-07-31T16:05:53.814961341Z",
"updateTime": "2025-07-31T16:05:53.814961341Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "gcc",
"id": "80f7f229883f28d11da18c75c9a97f89ce00a1ab",
"ref": "refs/heads/releases/gcc-15"
}
}
}
[16:05:54.373] Invocation finished in 1h0m53.171882763s with status SUCCEEDED