[18:03:02.122] New invocation is queued and will start shortly
[18:03:03.239] Starting the invocation (attempt 1)
[18:03:03.277] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/edc946ea81a457e5d928497e7d3a2e6543e2fb9a"
[18:03:03.277] Popped gitiles commit info from properties and tags
[18:03:03.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:03:03.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:03:03.277] Buildbucket request:
{
"requestId": "9015927442102076640",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "00f4fd9b1a2222383c579dece24ef0997ffbdd4c"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@00f4fd9b1a2222383c579dece24ef0997ffbdd4c",
"title": "00f4fd9b1a2222383c579dece24ef0997ffbdd4c",
"url": "https://webrtc.googlesource.com/src/+/00f4fd9b1a2222383c579dece24ef0997ffbdd4c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "704d6e518aa789a5e76378b7b758d6a77b60312e"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@704d6e518aa789a5e76378b7b758d6a77b60312e",
"title": "704d6e518aa789a5e76378b7b758d6a77b60312e",
"url": "https://webrtc.googlesource.com/src/+/704d6e518aa789a5e76378b7b758d6a77b60312e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "e1c8a43b2a66759d8a83787256118b8213987838"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@e1c8a43b2a66759d8a83787256118b8213987838",
"title": "e1c8a43b2a66759d8a83787256118b8213987838",
"url": "https://webrtc.googlesource.com/src/+/e1c8a43b2a66759d8a83787256118b8213987838"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "6817809e26f7631b1caa3013ee45075b9fef58d3"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@6817809e26f7631b1caa3013ee45075b9fef58d3",
"title": "6817809e26f7631b1caa3013ee45075b9fef58d3",
"url": "https://webrtc.googlesource.com/src/+/6817809e26f7631b1caa3013ee45075b9fef58d3"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "ca7412d9377a14f87ce901163b0b7c25a5a2894a"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@ca7412d9377a14f87ce901163b0b7c25a5a2894a",
"title": "ca7412d9377a14f87ce901163b0b7c25a5a2894a",
"url": "https://webrtc.googlesource.com/src/+/ca7412d9377a14f87ce901163b0b7c25a5a2894a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "58fa1bac0392f58f5060237fbbf8060dafe0f744"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@58fa1bac0392f58f5060237fbbf8060dafe0f744",
"title": "58fa1bac0392f58f5060237fbbf8060dafe0f744",
"url": "https://webrtc.googlesource.com/src/+/58fa1bac0392f58f5060237fbbf8060dafe0f744"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "67b1fa2bd7ac22c689faa9663ab8202c86838e2e"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@67b1fa2bd7ac22c689faa9663ab8202c86838e2e",
"title": "67b1fa2bd7ac22c689faa9663ab8202c86838e2e",
"url": "https://webrtc.googlesource.com/src/+/67b1fa2bd7ac22c689faa9663ab8202c86838e2e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "edc946ea81a457e5d928497e7d3a2e6543e2fb9a"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@edc946ea81a457e5d928497e7d3a2e6543e2fb9a",
"title": "edc946ea81a457e5d928497e7d3a2e6543e2fb9a",
"url": "https://webrtc.googlesource.com/src/+/edc946ea81a457e5d928497e7d3a2e6543e2fb9a"
}
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "edc946ea81a457e5d928497e7d3a2e6543e2fb9a",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9015927442102076640"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Mac64 Release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:03:04.110] Scheduled build:
{
"id": "8850497379990119072",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Release"
},
"number": 26045,
"createdBy": "project:webrtc",
"createTime": "2021-04-08T18:03:03.490673Z",
"updateTime": "2021-04-08T18:03:04.016806Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "edc946ea81a457e5d928497e7d3a2e6543e2fb9a",
"ref": "refs/heads/master"
}
}
}
[18:03:04.110] Task URL: https://cr-buildbucket.appspot.com/build/8850497379990119072
[18:03:04.110] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:2:0) after 5m33s
[18:08:37.237] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:2:0)
[18:08:37.263] Build status: SCHEDULED
[18:08:37.263] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:3:0) after 1m4s
[18:09:41.364] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:3:0)
[18:09:41.394] Build status: SCHEDULED
[18:09:41.394] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:4:0) after 4m27s
[18:14:08.421] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:4:0)
[18:14:08.445] Build status: SCHEDULED
[18:14:08.445] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:5:0) after 3m13s
[18:17:21.457] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:5:0)
[18:17:21.485] Build status: SCHEDULED
[18:17:21.485] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:6:0) after 5m20s
[18:22:41.588] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:6:0)
[18:22:41.622] Build status: SCHEDULED
[18:22:41.622] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:7:0) after 6m56s
[18:29:37.652] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:7:0)
[18:29:37.679] Build status: SCHEDULED
[18:29:37.679] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:8:0) after 8m13s
[18:37:50.696] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:8:0)
[18:37:50.723] Build status: SCHEDULED
[18:37:50.723] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:9:0) after 1m55s
[18:39:45.846] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:9:0)
[18:39:45.877] Build status: SCHEDULED
[18:39:45.877] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:10:0) after 1m18s
[18:41:04.149] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:10:0)
[18:41:04.177] Build status: SCHEDULED
[18:41:04.177] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:11:0) after 5m39s
[18:46:43.206] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:11:0)
[18:46:43.269] Build status: SCHEDULED
[18:46:43.269] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:12:0) after 8m12s
[18:54:55.712] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:12:0)
[18:54:55.757] Build status: SCHEDULED
[18:54:55.757] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:13:0) after 6m31s
[19:01:26.781] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:13:0)
[19:01:26.809] Build status: SCHEDULED
[19:01:26.809] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:14:0) after 9m12s
[19:10:38.926] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:14:0)
[19:10:38.955] Build status: SCHEDULED
[19:10:38.956] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:15:0) after 7m26s
[19:18:04.992] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:15:0)
[19:18:05.029] Build status: SCHEDULED
[19:18:05.029] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:16:0) after 4m9s
[19:22:14.269] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:16:0)
[19:22:14.299] Build status: SCHEDULED
[19:22:14.299] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:17:0) after 1m34s
[19:23:48.322] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:17:0)
[19:23:48.350] Build status: SCHEDULED
[19:23:48.350] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:18:0) after 3m11s
[19:26:59.501] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:18:0)
[19:26:59.541] Build status: SCHEDULED
[19:26:59.541] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:19:0) after 8m24s
[19:35:23.610] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:19:0)
[19:35:23.636] Build status: SCHEDULED
[19:35:23.636] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:20:0) after 9m50s
[19:45:13.662] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:20:0)
[19:45:13.695] Build status: SCHEDULED
[19:45:13.696] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:21:0) after 3m23s
[19:48:36.793] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:21:0)
[19:48:36.836] Build status: SCHEDULED
[19:48:36.836] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:22:0) after 9m43s
[19:58:19.948] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:22:0)
[19:58:19.977] Build status: SCHEDULED
[19:58:19.977] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:23:0) after 6m17s
[20:04:37.327] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:23:0)
[20:04:37.387] Build status: SCHEDULED
[20:04:37.387] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:24:0) after 7m40s
[20:12:17.411] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:24:0)
[20:12:17.464] Build status: SCHEDULED
[20:12:17.464] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:25:0) after 1m27s
[20:13:44.565] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:25:0)
[20:13:44.598] Build status: SCHEDULED
[20:13:44.598] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:26:0) after 1m36s
[20:15:20.618] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:26:0)
[20:15:20.676] Build status: SCHEDULED
[20:15:20.676] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:27:0) after 9m58s
[20:25:18.724] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:27:0)
[20:25:18.757] Build status: SCHEDULED
[20:25:18.757] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:28:0) after 1m10s
[20:26:29.622] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:28:0)
[20:26:29.651] Build status: SCHEDULED
[20:26:29.651] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:29:0) after 8m26s
[20:34:55.677] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:29:0)
[20:34:55.703] Build status: SCHEDULED
[20:34:55.704] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:30:0) after 8m24s
[20:43:20.218] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:30:0)
[20:43:20.294] Build status: SCHEDULED
[20:43:20.294] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:31:0) after 7m3s
[20:50:23.873] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:31:0)
[20:50:23.900] Build status: SCHEDULED
[20:50:23.900] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:32:0) after 2m10s
[20:52:34.040] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:32:0)
[20:52:34.095] Build status: SCHEDULED
[20:52:34.095] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:33:0) after 4m14s
[20:56:48.226] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:33:0)
[20:56:48.255] Build status: SCHEDULED
[20:56:48.255] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:34:0) after 8m32s
[21:05:20.360] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:34:0)
[21:05:20.398] Build status: SCHEDULED
[21:05:20.398] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:35:0) after 5m32s
[21:10:52.417] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:35:0)
[21:10:52.454] Build status: SCHEDULED
[21:10:52.454] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:36:0) after 5m7s
[21:15:59.476] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:36:0)
[21:15:59.504] Build status: SCHEDULED
[21:15:59.504] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:37:0) after 2m35s
[21:18:34.532] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:37:0)
[21:18:34.562] Build status: SCHEDULED
[21:18:34.562] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:38:0) after 2m46s
[21:21:20.584] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:38:0)
[21:21:20.614] Build status: SCHEDULED
[21:21:20.614] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:39:0) after 8m15s
[21:29:35.734] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:39:0)
[21:29:35.761] Build status: SCHEDULED
[21:29:35.761] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:40:0) after 5m21s
[21:34:56.792] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:40:0)
[21:34:56.826] Build status: SCHEDULED
[21:34:56.826] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:41:0) after 1m18s
[21:36:14.868] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:41:0)
[21:36:14.897] Build status: SCHEDULED
[21:36:14.897] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:42:0) after 3m36s
[21:39:51.037] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:42:0)
[21:39:51.065] Build status: SCHEDULED
[21:39:51.065] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:43:0) after 5m34s
[21:41:00.566] Received PubSub notification, asking Buildbucket for the build status
[21:41:00.598] Build status: STARTED
[21:45:25.083] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:43:0)
[21:45:25.109] Build status: STARTED
[21:45:25.109] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:45:0) after 2m14s
[21:47:39.331] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:45:0)
[21:47:39.357] Build status: STARTED
[21:47:39.357] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9015927442102076640:46:0) after 5m31s
[21:49:29.077] Received PubSub notification, asking Buildbucket for the build status
[21:49:29.111] Build:
{
"id": "8850497379990119072",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac64 Release"
},
"number": 26045,
"createdBy": "project:webrtc",
"createTime": "2021-04-08T18:03:03.490673Z",
"startTime": "2021-04-08T21:40:57.009242Z",
"endTime": "2021-04-08T21:49:27.615417Z",
"updateTime": "2021-04-08T21:49:28.557931Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "edc946ea81a457e5d928497e7d3a2e6543e2fb9a",
"ref": "refs/heads/master"
}
}
}
[21:49:29.111] Invocation finished in 3h46m27.019403445s with status SUCCEEDED