buildbucket: < server: "cr-buildbucket-dev.appspot.com" bucket: "ci" builder: "mac-arm-rel-dev" >
{
"branch": "refs/heads/main",
"repository": "https://chromium.googlesource.com/chromium/src",
"revision": "9aa26e36976b6e0291943486fa197dccad340806"
}
[03:19:18.052] New invocation is queued and will start shortly
[03:19:19.131] Starting the invocation (attempt 1)
[03:19:19.168] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:19:19.168] Popped gitiles commit info from properties and tags
[03:19:19.168] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:19:23.458] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:19:23.458] The invocation will be retried
[03:19:28.530] Starting the invocation (attempt 2)
[03:19:28.558] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:19:28.558] Popped gitiles commit info from properties and tags
[03:19:28.558] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:19:33.062] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:19:33.062] The invocation will be retried
[03:19:43.206] Starting the invocation (attempt 3)
[03:19:43.237] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:19:43.237] Popped gitiles commit info from properties and tags
[03:19:43.237] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:19:50.636] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:19:50.636] The invocation will be retried
[03:20:10.703] Starting the invocation (attempt 4)
[03:20:10.729] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:20:10.729] Popped gitiles commit info from properties and tags
[03:20:10.729] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:20:16.149] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:20:16.149] The invocation will be retried
[03:20:57.120] Starting the invocation (attempt 5)
[03:20:57.148] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:20:57.148] Popped gitiles commit info from properties and tags
[03:20:57.148] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:21:01.434] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:21:01.434] The invocation will be retried
[03:22:21.526] Starting the invocation (attempt 6)
[03:22:21.554] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:22:21.554] Popped gitiles commit info from properties and tags
[03:22:21.554] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:22:26.058] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:22:26.058] The invocation will be retried
[03:25:06.107] Starting the invocation (attempt 7)
[03:25:06.131] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:25:06.131] Popped gitiles commit info from properties and tags
[03:25:06.131] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:25:10.845] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:25:10.846] The invocation will be retried
[03:30:30.895] Starting the invocation (attempt 8)
[03:30:30.921] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:30:30.922] Popped gitiles commit info from properties and tags
[03:30:30.922] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:30:35.493] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:30:35.493] The invocation will be retried
[03:40:35.552] Starting the invocation (attempt 9)
[03:40:35.581] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:40:35.581] Popped gitiles commit info from properties and tags
[03:40:35.581] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:40:39.385] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:40:39.386] The invocation will be retried
[03:50:39.457] Starting the invocation (attempt 10)
[03:50:39.495] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[03:50:39.495] Popped gitiles commit info from properties and tags
[03:50:39.495] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:50:44.177] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:50:44.177] The invocation will be retried
[04:00:44.238] Starting the invocation (attempt 11)
[04:00:44.274] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:00:44.274] Popped gitiles commit info from properties and tags
[04:00:44.274] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:00:49.339] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:00:49.339] The invocation will be retried
[04:10:49.392] Starting the invocation (attempt 12)
[04:10:49.432] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:10:49.432] Popped gitiles commit info from properties and tags
[04:10:49.432] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:10:54.253] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:10:54.253] The invocation will be retried
[04:20:54.314] Starting the invocation (attempt 13)
[04:20:54.342] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:20:54.342] Popped gitiles commit info from properties and tags
[04:20:54.342] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:20:58.894] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:20:58.895] The invocation will be retried
[04:30:58.968] Starting the invocation (attempt 14)
[04:30:58.996] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:30:58.996] Popped gitiles commit info from properties and tags
[04:30:58.996] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:31:03.669] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:31:03.670] The invocation will be retried
[04:41:03.722] Starting the invocation (attempt 15)
[04:41:03.749] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:41:03.749] Popped gitiles commit info from properties and tags
[04:41:03.749] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:41:08.539] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:41:08.539] The invocation will be retried
[04:51:08.672] Starting the invocation (attempt 16)
[04:51:08.696] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[04:51:08.696] Popped gitiles commit info from properties and tags
[04:51:08.696] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:51:13.086] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:51:13.086] The invocation will be retried
[05:01:13.140] Starting the invocation (attempt 17)
[05:01:13.169] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:01:13.169] Popped gitiles commit info from properties and tags
[05:01:13.169] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:01:18.398] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:01:18.398] The invocation will be retried
[05:11:18.465] Starting the invocation (attempt 18)
[05:11:18.492] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:11:18.492] Popped gitiles commit info from properties and tags
[05:11:18.492] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:11:23.073] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:11:23.073] The invocation will be retried
[05:21:23.141] Starting the invocation (attempt 19)
[05:21:23.171] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:21:23.171] Popped gitiles commit info from properties and tags
[05:21:23.171] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:21:27.754] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:21:27.754] The invocation will be retried
[05:31:27.832] Starting the invocation (attempt 20)
[05:31:27.859] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:31:27.859] Popped gitiles commit info from properties and tags
[05:31:27.859] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:31:32.568] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:31:32.568] The invocation will be retried
[05:41:32.623] Starting the invocation (attempt 21)
[05:41:32.653] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:41:32.653] Popped gitiles commit info from properties and tags
[05:41:32.653] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:41:37.159] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:41:37.159] The invocation will be retried
[05:51:37.219] Starting the invocation (attempt 22)
[05:51:37.251] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[05:51:37.251] Popped gitiles commit info from properties and tags
[05:51:37.251] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:51:42.461] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:51:42.462] The invocation will be retried
[06:01:42.529] Starting the invocation (attempt 23)
[06:01:42.555] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:01:42.555] Popped gitiles commit info from properties and tags
[06:01:42.555] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:01:46.975] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:01:46.975] The invocation will be retried
[06:11:47.041] Starting the invocation (attempt 24)
[06:11:47.067] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:11:47.067] Popped gitiles commit info from properties and tags
[06:11:47.067] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:11:52.071] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:11:52.071] The invocation will be retried
[06:21:52.123] Starting the invocation (attempt 25)
[06:21:52.151] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:21:52.151] Popped gitiles commit info from properties and tags
[06:21:52.151] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:21:56.543] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:21:56.543] The invocation will be retried
[06:31:56.607] Starting the invocation (attempt 26)
[06:31:56.632] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:31:56.632] Popped gitiles commit info from properties and tags
[06:31:56.632] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:32:01.157] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:32:01.157] The invocation will be retried
[06:42:01.223] Starting the invocation (attempt 27)
[06:42:01.258] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:42:01.258] Popped gitiles commit info from properties and tags
[06:42:01.258] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:42:05.952] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:42:05.952] The invocation will be retried
[06:52:06.027] Starting the invocation (attempt 28)
[06:52:06.057] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[06:52:06.057] Popped gitiles commit info from properties and tags
[06:52:06.057] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:52:10.555] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:52:10.556] The invocation will be retried
[07:02:10.620] Starting the invocation (attempt 29)
[07:02:10.647] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[07:02:10.647] Popped gitiles commit info from properties and tags
[07:02:10.647] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:02:15.180] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:02:15.180] The invocation will be retried
[07:12:15.233] Starting the invocation (attempt 30)
[07:12:15.258] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[07:12:15.258] Popped gitiles commit info from properties and tags
[07:12:15.258] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:12:19.857] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:12:19.857] The invocation will be retried
[07:22:19.982] Starting the invocation (attempt 31)
[07:22:20.021] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[07:22:20.021] Popped gitiles commit info from properties and tags
[07:22:20.021] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:22:24.540] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:22:24.540] The invocation will be retried
[07:32:24.591] Starting the invocation (attempt 32)
[07:32:24.615] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9aa26e36976b6e0291943486fa197dccad340806"
[07:32:24.615] Popped gitiles commit info from properties and tags
[07:32:24.615] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:32:24.618] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[07:32:24.618] Buildbucket request:
{
"requestId": "8905001758002542320",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-arm-rel-dev"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9aa26e36976b6e0291943486fa197dccad340806",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905001758002542320"
},
{
"key": "scheduler_job_id",
"value": "chromium/mac-arm-rel-dev"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[07:32:25.463] Received PubSub notification, asking Buildbucket for the build status
[07:32:25.463] Fatal error when handling PubSub notification, aborting invocation - unexpected invocation status "RETRYING", expecting "RUNNING"
[07:32:25.463] Invocation finished in 4h13m7.415546146s with status FAILED