[18:33:53.015] New invocation is queued and will start shortly
[18:33:54.988] Starting the invocation (attempt 1)
[18:33:55.022] Popped buildset tag "buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/db77748be8aaa4926946d75b74947fff3775edcf"
[18:33:55.022] Popped gitiles commit info from properties and tags
[18:33:55.022] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:55.022] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:55.022] Buildbucket request:
{
"requestId": "9010127295434877712",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "f64b9b13ce4bb927f47a1fe0257c3794c6357c8c"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f64b9b13ce4bb927f47a1fe0257c3794c6357c8c",
"title": "f64b9b13ce4bb927f47a1fe0257c3794c6357c8c",
"url": "https://gnu.googlesource.com/binutils-gdb/+/f64b9b13ce4bb927f47a1fe0257c3794c6357c8c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "4de91c10cdd9f5818599578667802320df305d72"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@4de91c10cdd9f5818599578667802320df305d72",
"title": "4de91c10cdd9f5818599578667802320df305d72",
"url": "https://gnu.googlesource.com/binutils-gdb/+/4de91c10cdd9f5818599578667802320df305d72"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "066f8fbede55e781c6241c445e0940f8368d0ef9"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@066f8fbede55e781c6241c445e0940f8368d0ef9",
"title": "066f8fbede55e781c6241c445e0940f8368d0ef9",
"url": "https://gnu.googlesource.com/binutils-gdb/+/066f8fbede55e781c6241c445e0940f8368d0ef9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "28b2963ffb4b55cbe720538040623f5c7ccb0a1b"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@28b2963ffb4b55cbe720538040623f5c7ccb0a1b",
"title": "28b2963ffb4b55cbe720538040623f5c7ccb0a1b",
"url": "https://gnu.googlesource.com/binutils-gdb/+/28b2963ffb4b55cbe720538040623f5c7ccb0a1b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "2748c1b17e37c5acfae9d5dbcc627350c3d38167"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@2748c1b17e37c5acfae9d5dbcc627350c3d38167",
"title": "2748c1b17e37c5acfae9d5dbcc627350c3d38167",
"url": "https://gnu.googlesource.com/binutils-gdb/+/2748c1b17e37c5acfae9d5dbcc627350c3d38167"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "48ec4c05c68bfec4b79e95807bd82e0df4634a6c"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@48ec4c05c68bfec4b79e95807bd82e0df4634a6c",
"title": "48ec4c05c68bfec4b79e95807bd82e0df4634a6c",
"url": "https://gnu.googlesource.com/binutils-gdb/+/48ec4c05c68bfec4b79e95807bd82e0df4634a6c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "db77748be8aaa4926946d75b74947fff3775edcf"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@db77748be8aaa4926946d75b74947fff3775edcf",
"title": "db77748be8aaa4926946d75b74947fff3775edcf",
"url": "https://gnu.googlesource.com/binutils-gdb/+/db77748be8aaa4926946d75b74947fff3775edcf"
}
]
}
},
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "db77748be8aaa4926946d75b74947fff3775edcf",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9010127295434877712"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/gcc-prod-trigger-3e002780"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:33:55.681] Scheduled build:
{
"id": "8844697232566319057",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2021-06-11T18:33:55.120519586Z",
"updateTime": "2021-06-11T18:33:55.387432324Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "db77748be8aaa4926946d75b74947fff3775edcf",
"ref": "refs/heads/master"
}
}
}
[18:33:55.681] Task URL: https://cr-buildbucket.appspot.com/build/8844697232566319057
[18:33:55.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:2:0) after 1m7s
[18:35:02.911] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:2:0)
[18:35:02.946] Build status: STARTED
[18:35:02.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:3:0) after 4m10s
[18:39:12.969] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:3:0)
[18:39:12.998] Build status: STARTED
[18:39:12.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:4:0) after 6m38s
[18:45:51.117] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:4:0)
[18:45:51.235] Build status: STARTED
[18:45:51.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:5:0) after 3m26s
[18:49:17.263] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:5:0)
[18:49:17.299] Build status: STARTED
[18:49:17.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:6:0) after 2m57s
[18:52:14.648] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:6:0)
[18:52:14.693] Build status: STARTED
[18:52:14.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:7:0) after 7m20s
[18:59:34.714] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:7:0)
[18:59:34.742] Build status: STARTED
[18:59:34.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:8:0) after 1m24s
[19:00:58.949] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:8:0)
[19:00:58.986] Build status: STARTED
[19:00:58.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:9:0) after 4m24s
[19:05:23.116] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:9:0)
[19:05:23.154] Build status: STARTED
[19:05:23.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:10:0) after 1m18s
[19:06:41.493] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:10:0)
[19:06:41.614] Build status: STARTED
[19:06:41.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:11:0) after 4m24s
[19:11:05.834] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:11:0)
[19:11:05.941] Build status: STARTED
[19:11:05.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:12:0) after 1m50s
[19:12:56.014] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:12:0)
[19:12:56.950] Build status: STARTED
[19:12:56.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:13:0) after 8m47s
[19:21:43.970] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:13:0)
[19:21:43.998] Build status: STARTED
[19:21:43.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:14:0) after 8m15s
[19:29:59.024] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:14:0)
[19:29:59.059] Build status: STARTED
[19:29:59.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:15:0) after 1m16s
[19:31:15.078] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:15:0)
[19:31:15.118] Build status: STARTED
[19:31:15.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:16:0) after 9m52s
[19:41:07.320] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:16:0)
[19:41:07.370] Build status: STARTED
[19:41:07.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:17:0) after 5m57s
[19:47:04.515] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:9010127295434877712:17:0)
[19:47:04.556] Build:
{
"id": "8844697232566319057",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2021-06-11T18:33:55.120519586Z",
"startTime": "2021-06-11T18:33:56.731686Z",
"endTime": "2021-06-11T19:45:43.061162788Z",
"updateTime": "2021-06-11T19:45:43.061695596Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "db77748be8aaa4926946d75b74947fff3775edcf",
"ref": "refs/heads/master"
}
}
}
[19:47:04.556] Invocation finished in 1h13m11.556609603s with status SUCCEEDED