[18:33:42.141] New invocation is queued and will start shortly
[18:33:44.886] Starting the invocation (attempt 1)
[18:33:44.930] Popped buildset tag "buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/8f0212acb19da47fa9d9feeaae42e71c8817cafc"
[18:33:44.930] Popped gitiles commit info from properties and tags
[18:33:44.930] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:44.930] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:44.931] Buildbucket request:
{
"requestId": "8964194644866250576",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8964194644866250576",
"job": "fuchsia/gcc-prod-trigger-3e002780",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "18bf56434d1adabbd82fa6a33d08a60ef2d71001"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@18bf56434d1adabbd82fa6a33d08a60ef2d71001",
"title": "18bf56434d1adabbd82fa6a33d08a60ef2d71001",
"url": "https://gnu.googlesource.com/binutils-gdb/+/18bf56434d1adabbd82fa6a33d08a60ef2d71001"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "de1fbe7889eb4f363b979c14735b8fd51131621b"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@de1fbe7889eb4f363b979c14735b8fd51131621b",
"title": "de1fbe7889eb4f363b979c14735b8fd51131621b",
"url": "https://gnu.googlesource.com/binutils-gdb/+/de1fbe7889eb4f363b979c14735b8fd51131621b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "ef07be453e0edf2f43034fcbc0581f61e630993e"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ef07be453e0edf2f43034fcbc0581f61e630993e",
"title": "ef07be453e0edf2f43034fcbc0581f61e630993e",
"url": "https://gnu.googlesource.com/binutils-gdb/+/ef07be453e0edf2f43034fcbc0581f61e630993e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "1bf074fb6b5474f94e315d7047c0500535f0a2ef"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@1bf074fb6b5474f94e315d7047c0500535f0a2ef",
"title": "1bf074fb6b5474f94e315d7047c0500535f0a2ef",
"url": "https://gnu.googlesource.com/binutils-gdb/+/1bf074fb6b5474f94e315d7047c0500535f0a2ef"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "5b94c3808140206d3b5204a3780f294d590cc458"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5b94c3808140206d3b5204a3780f294d590cc458",
"title": "5b94c3808140206d3b5204a3780f294d590cc458",
"url": "https://gnu.googlesource.com/binutils-gdb/+/5b94c3808140206d3b5204a3780f294d590cc458"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "ead2618501e8ba696bf29de635a9a5f6a1ba1b0e"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ead2618501e8ba696bf29de635a9a5f6a1ba1b0e",
"title": "ead2618501e8ba696bf29de635a9a5f6a1ba1b0e",
"url": "https://gnu.googlesource.com/binutils-gdb/+/ead2618501e8ba696bf29de635a9a5f6a1ba1b0e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "ed60d3edd51f6c33fb0f3f09400094a1b1c2ceb2"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@ed60d3edd51f6c33fb0f3f09400094a1b1c2ceb2",
"title": "ed60d3edd51f6c33fb0f3f09400094a1b1c2ceb2",
"url": "https://gnu.googlesource.com/binutils-gdb/+/ed60d3edd51f6c33fb0f3f09400094a1b1c2ceb2"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "5bab16fdf1775c8abd16376458c5843fbe1d4314"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@5bab16fdf1775c8abd16376458c5843fbe1d4314",
"title": "5bab16fdf1775c8abd16376458c5843fbe1d4314",
"url": "https://gnu.googlesource.com/binutils-gdb/+/5bab16fdf1775c8abd16376458c5843fbe1d4314"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "f2462532e24ebfc137598d73ee6541948121f040"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@f2462532e24ebfc137598d73ee6541948121f040",
"title": "f2462532e24ebfc137598d73ee6541948121f040",
"url": "https://gnu.googlesource.com/binutils-gdb/+/f2462532e24ebfc137598d73ee6541948121f040"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "8f0212acb19da47fa9d9feeaae42e71c8817cafc"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@8f0212acb19da47fa9d9feeaae42e71c8817cafc",
"title": "8f0212acb19da47fa9d9feeaae42e71c8817cafc",
"url": "https://gnu.googlesource.com/binutils-gdb/+/8f0212acb19da47fa9d9feeaae42e71c8817cafc"
}
]
}
},
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "8f0212acb19da47fa9d9feeaae42e71c8817cafc",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8964194644866250576"
},
{
"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:45.294] Scheduled build:
{
"id": "8798764581194879905",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-31T18:33:45.017475852Z",
"updateTime": "2022-10-31T18:33:45.017475852Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "8f0212acb19da47fa9d9feeaae42e71c8817cafc",
"ref": "refs/heads/master"
}
},
"canary": true
}
[18:33:45.294] Task URL: https://cr-buildbucket.appspot.com/build/8798764581194879905
[18:33:45.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:2:0) after 4m23s
[18:33:46.528] Received PubSub notification, asking Buildbucket for the build status
[18:33:46.550] Build status: STARTED
[18:38:08.321] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:2:0)
[18:38:08.347] Build status: STARTED
[18:38:08.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:4:0) after 4m43s
[18:42:51.372] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:4:0)
[18:42:51.578] Build status: STARTED
[18:42:51.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:5:0) after 9m5s
[18:51:56.606] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:5:0)
[18:51:56.630] Build status: STARTED
[18:51:56.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:6:0) after 9m45s
[19:01:41.703] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:6:0)
[19:01:41.728] Build status: STARTED
[19:01:41.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:7:0) after 7m58s
[19:09:39.764] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:7:0)
[19:09:39.804] Build status: STARTED
[19:09:39.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:8:0) after 1m38s
[19:11:17.878] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:8:0)
[19:11:17.910] Build status: STARTED
[19:11:17.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:9:0) after 9m40s
[19:20:57.937] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:9:0)
[19:20:57.960] Build status: STARTED
[19:20:57.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:10:0) after 2m43s
[19:23:41.238] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:10:0)
[19:23:41.267] Build status: STARTED
[19:23:41.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:11:0) after 2m44s
[19:26:25.544] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:11:0)
[19:26:25.598] Build status: STARTED
[19:26:25.598] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:12:0) after 5m47s
[19:32:12.622] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:12:0)
[19:32:12.653] Build status: STARTED
[19:32:12.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:13:0) after 6m21s
[19:38:33.660] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:13:0)
[19:38:33.692] Build status: STARTED
[19:38:33.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:14:0) after 3m8s
[19:41:42.885] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:14:0)
[19:41:42.923] Build status: STARTED
[19:41:42.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:15:0) after 9m51s
[19:51:33.947] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:15:0)
[19:51:33.972] Build status: STARTED
[19:51:33.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:16:0) after 7m7s
[19:58:41.422] Handling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:16:0)
[19:58:41.452] Build status: STARTED
[19:58:41.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/gcc-prod-trigger-3e002780:8964194644866250576:17:0) after 1m45s
[19:59:25.649] Received PubSub notification, asking Buildbucket for the build status
[19:59:25.703] Build:
{
"id": "8798764581194879905",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "gcc-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-31T18:33:45.017475852Z",
"startTime": "2022-10-31T18:33:45.726947Z",
"endTime": "2022-10-31T19:59:25.362704573Z",
"updateTime": "2022-10-31T19:59:25.362704573Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "8f0212acb19da47fa9d9feeaae42e71c8817cafc",
"ref": "refs/heads/master"
}
},
"canary": true
}
[19:59:25.703] Invocation finished in 1h25m43.57125733s with status SUCCEEDED