[14:51:00.282] New invocation is queued and will start shortly
[14:51:01.340] Starting the invocation (attempt 1)
[14:51:01.374] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/841d74ea80f79bc8dca83fb4a091a21c34798bc8"
[14:51:01.374] Popped gitiles commit info from properties and tags
[14:51:01.374] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:51:01.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:51:01.376] Buildbucket request:
{
"requestId": "9016664299344058256",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "2178d1ae69ec76d001208c03aec8308138ebdd57"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@2178d1ae69ec76d001208c03aec8308138ebdd57",
"title": "2178d1ae69ec76d001208c03aec8308138ebdd57",
"url": "https://webrtc.googlesource.com/src/+/2178d1ae69ec76d001208c03aec8308138ebdd57"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "b995bb86dfca1787022197571bca72e319d5fb3e"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@b995bb86dfca1787022197571bca72e319d5fb3e",
"title": "b995bb86dfca1787022197571bca72e319d5fb3e",
"url": "https://webrtc.googlesource.com/src/+/b995bb86dfca1787022197571bca72e319d5fb3e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "2e3832e0d04f3931726832b320d3d516cbd8058c"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@2e3832e0d04f3931726832b320d3d516cbd8058c",
"title": "2e3832e0d04f3931726832b320d3d516cbd8058c",
"url": "https://webrtc.googlesource.com/src/+/2e3832e0d04f3931726832b320d3d516cbd8058c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "3dffa81541586aaefbea067b101d4d833bbf14fb"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@3dffa81541586aaefbea067b101d4d833bbf14fb",
"title": "3dffa81541586aaefbea067b101d4d833bbf14fb",
"url": "https://webrtc.googlesource.com/src/+/3dffa81541586aaefbea067b101d4d833bbf14fb"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "b37180fcf2dd64ba0d769a7b8c4abc3135d1c175"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@b37180fcf2dd64ba0d769a7b8c4abc3135d1c175",
"title": "b37180fcf2dd64ba0d769a7b8c4abc3135d1c175",
"url": "https://webrtc.googlesource.com/src/+/b37180fcf2dd64ba0d769a7b8c4abc3135d1c175"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "841d74ea80f79bc8dca83fb4a091a21c34798bc8"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@841d74ea80f79bc8dca83fb4a091a21c34798bc8",
"title": "841d74ea80f79bc8dca83fb4a091a21c34798bc8",
"url": "https://webrtc.googlesource.com/src/+/841d74ea80f79bc8dca83fb4a091a21c34798bc8"
}
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "841d74ea80f79bc8dca83fb4a091a21c34798bc8",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9016664299344058256"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Mac64 Debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:51:03.692] Scheduled build:
{
"id": "8851234237332184144",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Debug"
},
"number": 24255,
"createdBy": "project:webrtc",
"createTime": "2021-03-31T14:51:01.568625Z",
"updateTime": "2021-03-31T14:51:03.469228Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "841d74ea80f79bc8dca83fb4a091a21c34798bc8",
"ref": "refs/heads/master"
}
}
}
[14:51:03.692] Task URL: https://cr-buildbucket.appspot.com/build/8851234237332184144
[14:51:03.692] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:2:0) after 5m19s
[14:56:22.708] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:2:0)
[14:56:22.734] Build status: SCHEDULED
[14:56:22.734] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:3:0) after 8m33s
[15:04:55.840] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:3:0)
[15:04:55.866] Build status: SCHEDULED
[15:04:55.866] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:4:0) after 8m42s
[15:13:37.884] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:4:0)
[15:13:37.920] Build status: SCHEDULED
[15:13:37.920] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:5:0) after 4m51s
[15:18:28.938] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:5:0)
[15:18:28.971] Build status: SCHEDULED
[15:18:28.971] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:6:0) after 5m28s
[15:23:57.168] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:6:0)
[15:23:57.205] Build status: SCHEDULED
[15:23:57.205] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:7:0) after 3m21s
[15:27:18.286] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:7:0)
[15:27:18.315] Build status: SCHEDULED
[15:27:18.315] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:8:0) after 2m32s
[15:29:50.430] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:8:0)
[15:29:50.458] Build status: SCHEDULED
[15:29:50.458] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:9:0) after 8m31s
[15:38:21.475] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:9:0)
[15:38:21.503] Build status: SCHEDULED
[15:38:21.503] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:10:0) after 2m2s
[15:40:23.529] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:10:0)
[15:40:23.552] Build status: SCHEDULED
[15:40:23.552] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:11:0) after 4m29s
[15:44:52.579] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:11:0)
[15:44:52.609] Build status: SCHEDULED
[15:44:52.609] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:12:0) after 6m58s
[15:51:50.642] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:12:0)
[15:51:50.670] Build status: SCHEDULED
[15:51:50.670] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:13:0) after 9m28s
[16:01:18.797] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:13:0)
[16:01:18.825] Build status: SCHEDULED
[16:01:18.825] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:14:0) after 6m0s
[16:07:18.854] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:14:0)
[16:07:18.886] Build status: SCHEDULED
[16:07:18.886] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:15:0) after 3m22s
[16:10:40.949] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:15:0)
[16:10:40.976] Build status: SCHEDULED
[16:10:40.976] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:16:0) after 1m54s
[16:12:35.098] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:16:0)
[16:12:35.138] Build status: SCHEDULED
[16:12:35.138] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:17:0) after 7m13s
[16:19:48.255] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:17:0)
[16:19:48.287] Build status: SCHEDULED
[16:19:48.287] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:18:0) after 4m23s
[16:24:11.308] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:18:0)
[16:24:11.333] Build status: SCHEDULED
[16:24:11.333] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:19:0) after 3m58s
[16:28:09.392] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:19:0)
[16:28:09.439] Build status: SCHEDULED
[16:28:09.439] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:20:0) after 5m14s
[16:33:23.693] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:20:0)
[16:33:23.721] Build status: SCHEDULED
[16:33:23.721] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:21:0) after 8m54s
[16:42:17.777] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:21:0)
[16:42:17.804] Build status: SCHEDULED
[16:42:17.804] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:22:0) after 7m46s
[16:50:04.157] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:22:0)
[16:50:04.201] Build status: SCHEDULED
[16:50:04.201] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:23:0) after 2m47s
[16:52:51.222] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:23:0)
[16:52:51.248] Build status: SCHEDULED
[16:52:51.248] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:24:0) after 3m4s
[16:55:55.269] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:24:0)
[16:55:55.319] Build status: SCHEDULED
[16:55:55.319] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:25:0) after 7m6s
[17:03:01.340] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:25:0)
[17:03:01.372] Build status: SCHEDULED
[17:03:01.372] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:26:0) after 7m1s
[17:10:02.437] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:26:0)
[17:10:02.486] Build status: SCHEDULED
[17:10:02.486] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:27:0) after 2m41s
[17:12:43.555] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:27:0)
[17:12:43.628] Build status: SCHEDULED
[17:12:43.629] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:28:0) after 7m48s
[17:20:31.673] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:28:0)
[17:20:31.733] Build status: SCHEDULED
[17:20:31.733] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:29:0) after 1m24s
[17:21:55.853] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:29:0)
[17:21:55.878] Build status: SCHEDULED
[17:21:55.878] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:30:0) after 8m21s
[17:30:17.057] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:30:0)
[17:30:17.092] Build status: SCHEDULED
[17:30:17.092] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:31:0) after 9m2s
[17:39:19.233] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:31:0)
[17:39:19.290] Build status: SCHEDULED
[17:39:19.290] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:32:0) after 5m30s
[17:44:49.425] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:32:0)
[17:44:49.469] Build status: SCHEDULED
[17:44:49.469] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:33:0) after 5m49s
[17:50:38.558] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:33:0)
[17:50:38.589] Build status: SCHEDULED
[17:50:38.589] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:34:0) after 9m59s
[18:00:37.611] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:34:0)
[18:00:37.644] Build status: SCHEDULED
[18:00:37.644] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:35:0) after 4m13s
[18:04:50.616] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:35:0)
[18:04:50.645] Build status: SCHEDULED
[18:04:50.645] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:36:0) after 2m46s
[18:07:36.763] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:36:0)
[18:07:36.793] Build status: SCHEDULED
[18:07:36.794] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:37:0) after 7m11s
[18:10:23.685] Received PubSub notification, asking Buildbucket for the build status
[18:10:23.716] Build status: STARTED
[18:14:47.982] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:37:0)
[18:14:48.103] Build status: STARTED
[18:14:48.103] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:39:0) after 1m34s
[18:16:22.190] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:39:0)
[18:16:22.217] Build status: STARTED
[18:16:22.217] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9016664299344058256:40:0) after 9m4s
[18:18:57.071] Received PubSub notification, asking Buildbucket for the build status
[18:18:57.105] Build:
{
"id": "8851234237332184144",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Debug"
},
"number": 24255,
"createdBy": "project:webrtc",
"createTime": "2021-03-31T14:51:01.568625Z",
"startTime": "2021-03-31T18:10:19.053358Z",
"endTime": "2021-03-31T18:18:49.418637Z",
"updateTime": "2021-03-31T18:18:49.847898Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "841d74ea80f79bc8dca83fb4a091a21c34798bc8",
"ref": "refs/heads/master"
}
}
}
[18:18:57.105] Invocation finished in 3h27m56.839699511s with status SUCCEEDED