[18:39:30.829] New invocation is queued and will start shortly
[18:39:32.329] Starting the invocation (attempt 1)
[18:39:32.365] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/cc49311969764d38a256ac09ca6ba8c1c5f349d8"
[18:39:32.365] Popped gitiles commit info from properties and tags
[18:39:32.365] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:39:32.365] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:39:32.366] Buildbucket request:
{
"requestId": "9014022610768929088",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac Asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "141a4de0727cb2eba7d21e896e4ecf72b5be1502"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@141a4de0727cb2eba7d21e896e4ecf72b5be1502",
"title": "141a4de0727cb2eba7d21e896e4ecf72b5be1502",
"url": "https://webrtc.googlesource.com/src/+/141a4de0727cb2eba7d21e896e4ecf72b5be1502"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "d66a60597de5db028172803abc273bff5075239e"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@d66a60597de5db028172803abc273bff5075239e",
"title": "d66a60597de5db028172803abc273bff5075239e",
"url": "https://webrtc.googlesource.com/src/+/d66a60597de5db028172803abc273bff5075239e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "a2efd15627de29c829c65b2dbbeaebc861af7471"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@a2efd15627de29c829c65b2dbbeaebc861af7471",
"title": "a2efd15627de29c829c65b2dbbeaebc861af7471",
"url": "https://webrtc.googlesource.com/src/+/a2efd15627de29c829c65b2dbbeaebc861af7471"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "cc49311969764d38a256ac09ca6ba8c1c5f349d8"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@cc49311969764d38a256ac09ca6ba8c1c5f349d8",
"title": "cc49311969764d38a256ac09ca6ba8c1c5f349d8",
"url": "https://webrtc.googlesource.com/src/+/cc49311969764d38a256ac09ca6ba8c1c5f349d8"
}
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "cc49311969764d38a256ac09ca6ba8c1c5f349d8",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9014022610768929088"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Mac Asan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:39:32.908] Scheduled build:
{
"id": "8848592548401935888",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac Asan"
},
"number": 26301,
"createdBy": "project:webrtc",
"createTime": "2021-04-29T18:39:32.453114Z",
"updateTime": "2021-04-29T18:39:32.835570Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "cc49311969764d38a256ac09ca6ba8c1c5f349d8",
"ref": "refs/heads/master"
}
}
}
[18:39:32.908] Task URL: https://cr-buildbucket.appspot.com/build/8848592548401935888
[18:39:32.908] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:2:0) after 1m25s
[18:40:58.189] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:2:0)
[18:40:58.218] Build status: SCHEDULED
[18:40:58.218] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:3:0) after 3m40s
[18:44:38.281] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:3:0)
[18:44:38.307] Build status: SCHEDULED
[18:44:38.307] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:4:0) after 2m50s
[18:47:28.370] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:4:0)
[18:47:28.514] Build status: SCHEDULED
[18:47:28.514] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:5:0) after 1m41s
[18:49:09.630] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:5:0)
[18:49:09.655] Build status: SCHEDULED
[18:49:09.655] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:6:0) after 1m37s
[18:50:46.722] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:6:0)
[18:50:46.750] Build status: SCHEDULED
[18:50:46.750] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:7:0) after 2m11s
[18:52:57.771] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:7:0)
[18:52:57.811] Build status: SCHEDULED
[18:52:57.811] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:8:0) after 2m45s
[18:55:43.034] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:8:0)
[18:55:43.065] Build status: SCHEDULED
[18:55:43.065] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:9:0) after 4m50s
[19:00:33.058] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:9:0)
[19:00:33.120] Build status: SCHEDULED
[19:00:33.121] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:10:0) after 6m22s
[19:06:55.177] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:10:0)
[19:06:55.204] Build status: SCHEDULED
[19:06:55.204] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:11:0) after 9m14s
[19:16:09.351] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:11:0)
[19:16:09.388] Build status: SCHEDULED
[19:16:09.388] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:12:0) after 1m53s
[19:18:02.457] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:12:0)
[19:18:02.506] Build status: SCHEDULED
[19:18:02.506] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:13:0) after 6m1s
[19:24:03.521] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:13:0)
[19:24:03.552] Build status: SCHEDULED
[19:24:03.552] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:14:0) after 5m20s
[19:29:23.655] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:14:0)
[19:29:23.684] Build status: SCHEDULED
[19:29:23.684] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:15:0) after 6m26s
[19:35:49.885] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:15:0)
[19:35:49.925] Build status: SCHEDULED
[19:35:49.925] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:16:0) after 6m3s
[19:41:53.119] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:16:0)
[19:41:53.201] Build status: SCHEDULED
[19:41:53.201] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:17:0) after 2m53s
[19:44:46.582] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:17:0)
[19:44:46.611] Build status: SCHEDULED
[19:44:46.611] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:18:0) after 3m11s
[19:47:57.629] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:18:0)
[19:47:57.661] Build status: SCHEDULED
[19:47:57.661] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:19:0) after 2m57s
[19:50:54.792] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:19:0)
[19:50:54.834] Build status: SCHEDULED
[19:50:54.834] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:20:0) after 3m37s
[19:54:32.120] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:20:0)
[19:54:32.159] Build status: SCHEDULED
[19:54:32.159] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:21:0) after 6m59s
[20:01:31.278] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:21:0)
[20:01:31.314] Build status: SCHEDULED
[20:01:31.314] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:22:0) after 6m52s
[20:08:23.448] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:22:0)
[20:08:23.528] Build status: SCHEDULED
[20:08:23.528] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:23:0) after 1m1s
[20:09:24.563] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:23:0)
[20:09:24.636] Build status: SCHEDULED
[20:09:24.636] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:24:0) after 2m54s
[20:12:18.688] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:24:0)
[20:12:18.719] Build status: SCHEDULED
[20:12:18.719] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:25:0) after 6m12s
[20:18:30.810] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:25:0)
[20:18:30.860] Build status: SCHEDULED
[20:18:30.860] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:26:0) after 1m0s
[20:19:30.943] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:26:0)
[20:19:30.998] Build status: SCHEDULED
[20:19:30.998] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:27:0) after 6m30s
[20:26:01.295] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:27:0)
[20:26:01.343] Build status: SCHEDULED
[20:26:01.343] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:28:0) after 8m18s
[20:34:19.387] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:28:0)
[20:34:19.434] Build status: SCHEDULED
[20:34:19.434] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:29:0) after 3m15s
[20:37:34.554] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:29:0)
[20:37:34.583] Build status: SCHEDULED
[20:37:34.583] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:30:0) after 1m36s
[20:39:10.729] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:30:0)
[20:39:10.766] Build status: SCHEDULED
[20:39:10.766] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:31:0) after 8m3s
[20:47:13.789] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:31:0)
[20:47:13.818] Build status: SCHEDULED
[20:47:13.818] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:32:0) after 6m39s
[20:53:52.897] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:32:0)
[20:53:52.928] Build status: SCHEDULED
[20:53:52.928] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:33:0) after 9m34s
[21:03:26.998] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:33:0)
[21:03:27.030] Build status: SCHEDULED
[21:03:27.030] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:34:0) after 2m56s
[21:06:23.008] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:34:0)
[21:06:23.036] Build status: SCHEDULED
[21:06:23.036] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:35:0) after 9m4s
[21:15:27.342] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:35:0)
[21:15:27.413] Build status: SCHEDULED
[21:15:27.413] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:36:0) after 7m7s
[21:22:34.529] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:36:0)
[21:22:34.561] Build status: SCHEDULED
[21:22:34.561] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:37:0) after 5m7s
[21:27:41.532] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:37:0)
[21:27:41.562] Build status: SCHEDULED
[21:27:41.562] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:38:0) after 2m23s
[21:30:04.605] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:38:0)
[21:30:04.702] Build status: SCHEDULED
[21:30:04.702] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:39:0) after 8m14s
[21:38:18.953] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:39:0)
[21:38:18.985] Build status: SCHEDULED
[21:38:18.985] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:40:0) after 7m46s
[21:46:05.099] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:40:0)
[21:46:05.132] Build status: SCHEDULED
[21:46:05.132] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:41:0) after 5m51s
[21:51:56.393] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:41:0)
[21:51:56.429] Build status: SCHEDULED
[21:51:56.429] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:42:0) after 5m29s
[21:55:44.654] Received PubSub notification, asking Buildbucket for the build status
[21:55:44.682] Build status: STARTED
[21:57:25.446] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:42:0)
[21:57:25.482] Build status: STARTED
[21:57:25.482] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:44:0) after 9m36s
[22:07:01.501] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:44:0)
[22:07:01.526] Build status: STARTED
[22:07:01.526] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:45:0) after 5m57s
[22:12:58.696] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:45:0)
[22:12:58.736] Build status: STARTED
[22:12:58.736] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:46:0) after 5m58s
[22:18:57.032] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:46:0)
[22:18:57.057] Build status: STARTED
[22:18:57.058] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:47:0) after 5m48s
[22:24:45.044] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:47:0)
[22:24:45.076] Build status: STARTED
[22:24:45.076] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:48:0) after 4m31s
[22:29:16.179] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:48:0)
[22:29:16.213] Build status: STARTED
[22:29:16.213] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:49:0) after 7m56s
[22:37:12.243] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:49:0)
[22:37:12.289] Build status: STARTED
[22:37:12.289] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:50:0) after 6m31s
[22:43:43.339] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:50:0)
[22:43:43.367] Build status: STARTED
[22:43:43.367] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014022610768929088:51:0) after 9m37s
[22:48:21.814] Received PubSub notification, asking Buildbucket for the build status
[22:48:21.841] Build:
{
"id": "8848592548401935888",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac Asan"
},
"number": 26301,
"createdBy": "project:webrtc",
"createTime": "2021-04-29T18:39:32.453114Z",
"startTime": "2021-04-29T21:55:43.794185Z",
"endTime": "2021-04-29T22:48:20.602524Z",
"updateTime": "2021-04-29T22:48:21.036633Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "cc49311969764d38a256ac09ca6ba8c1c5f349d8",
"ref": "refs/heads/master"
}
}
}
[22:48:21.841] Invocation finished in 4h8m51.028403318s with status SUCCEEDED