[15:04:44.827] New invocation is queued and will start shortly
[15:04:46.002] Starting the invocation (attempt 1)
[15:04:46.058] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/e313c0702030dabc82383faf88188945f898c656"
[15:04:46.058] Popped gitiles commit info from properties and tags
[15:04:46.058] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:04:46.058] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:04:46.058] Buildbucket request:
{
"requestId": "9014851495423234448",
"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": "b4ced39b93ef3531ebf89525d5c6ffb362895081"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@b4ced39b93ef3531ebf89525d5c6ffb362895081",
"title": "b4ced39b93ef3531ebf89525d5c6ffb362895081",
"url": "https://webrtc.googlesource.com/src/+/b4ced39b93ef3531ebf89525d5c6ffb362895081"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "319d76cd67746ae7a9dedf2f811afd02d1c81e8b"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@319d76cd67746ae7a9dedf2f811afd02d1c81e8b",
"title": "319d76cd67746ae7a9dedf2f811afd02d1c81e8b",
"url": "https://webrtc.googlesource.com/src/+/319d76cd67746ae7a9dedf2f811afd02d1c81e8b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "1153974c89ff812fffc95fc32289eeebc76eb109"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@1153974c89ff812fffc95fc32289eeebc76eb109",
"title": "1153974c89ff812fffc95fc32289eeebc76eb109",
"url": "https://webrtc.googlesource.com/src/+/1153974c89ff812fffc95fc32289eeebc76eb109"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "437d129ef5c1c7e9e967f9b43b5aafbe38d98b1d"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@437d129ef5c1c7e9e967f9b43b5aafbe38d98b1d",
"title": "437d129ef5c1c7e9e967f9b43b5aafbe38d98b1d",
"url": "https://webrtc.googlesource.com/src/+/437d129ef5c1c7e9e967f9b43b5aafbe38d98b1d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "59d6e2a19e3e92229d3eb8a33d379894c480bb95"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@59d6e2a19e3e92229d3eb8a33d379894c480bb95",
"title": "59d6e2a19e3e92229d3eb8a33d379894c480bb95",
"url": "https://webrtc.googlesource.com/src/+/59d6e2a19e3e92229d3eb8a33d379894c480bb95"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "0b0afaa81a784e824d3007e8f3503edaa7740179"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@0b0afaa81a784e824d3007e8f3503edaa7740179",
"title": "0b0afaa81a784e824d3007e8f3503edaa7740179",
"url": "https://webrtc.googlesource.com/src/+/0b0afaa81a784e824d3007e8f3503edaa7740179"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "0e73602a9f8eaecdaf1f5a1922902bb6576485f9"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@0e73602a9f8eaecdaf1f5a1922902bb6576485f9",
"title": "0e73602a9f8eaecdaf1f5a1922902bb6576485f9",
"url": "https://webrtc.googlesource.com/src/+/0e73602a9f8eaecdaf1f5a1922902bb6576485f9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "49bec37d9b0fb29b91ed6286c1a4bf65cf48b49b"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@49bec37d9b0fb29b91ed6286c1a4bf65cf48b49b",
"title": "49bec37d9b0fb29b91ed6286c1a4bf65cf48b49b",
"url": "https://webrtc.googlesource.com/src/+/49bec37d9b0fb29b91ed6286c1a4bf65cf48b49b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "63b01e19e9bd01de364f30d15b9e68a0b387138b"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@63b01e19e9bd01de364f30d15b9e68a0b387138b",
"title": "63b01e19e9bd01de364f30d15b9e68a0b387138b",
"url": "https://webrtc.googlesource.com/src/+/63b01e19e9bd01de364f30d15b9e68a0b387138b"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://webrtc.googlesource.com/src",
"revision": "e313c0702030dabc82383faf88188945f898c656"
},
"id": "https://webrtc.googlesource.com/src/+/refs/heads/master@e313c0702030dabc82383faf88188945f898c656",
"title": "e313c0702030dabc82383faf88188945f898c656",
"url": "https://webrtc.googlesource.com/src/+/e313c0702030dabc82383faf88188945f898c656"
}
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "e313c0702030dabc82383faf88188945f898c656",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9014851495423234448"
},
{
"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"
}
}
[15:04:48.038] Scheduled build:
{
"id": "8849421433364855216",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac Asan"
},
"number": 26263,
"createdBy": "project:webrtc",
"createTime": "2021-04-20T15:04:46.152687Z",
"updateTime": "2021-04-20T15:04:47.799372Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "e313c0702030dabc82383faf88188945f898c656",
"ref": "refs/heads/master"
}
}
}
[15:04:48.038] Task URL: https://cr-buildbucket.appspot.com/build/8849421433364855216
[15:04:48.038] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:2:0) after 1m0s
[15:05:48.112] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:2:0)
[15:05:48.136] Build status: SCHEDULED
[15:05:48.136] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:3:0) after 5m45s
[15:11:33.235] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:3:0)
[15:11:33.268] Build status: SCHEDULED
[15:11:33.268] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:4:0) after 4m44s
[15:16:17.340] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:4:0)
[15:16:17.368] Build status: SCHEDULED
[15:16:17.368] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:5:0) after 4m48s
[15:21:05.398] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:5:0)
[15:21:05.428] Build status: SCHEDULED
[15:21:05.428] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:6:0) after 7m32s
[15:28:37.495] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:6:0)
[15:28:37.524] Build status: SCHEDULED
[15:28:37.524] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:7:0) after 5m56s
[15:34:33.586] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:7:0)
[15:34:33.613] Build status: SCHEDULED
[15:34:33.613] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:8:0) after 3m33s
[15:38:06.636] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:8:0)
[15:38:06.673] Build status: SCHEDULED
[15:38:06.673] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:9:0) after 1m47s
[15:39:53.735] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:9:0)
[15:39:53.766] Build status: SCHEDULED
[15:39:53.766] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:10:0) after 7m51s
[15:47:44.791] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:10:0)
[15:47:44.815] Build status: SCHEDULED
[15:47:44.815] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:11:0) after 2m56s
[15:50:40.906] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:11:0)
[15:50:40.940] Build status: SCHEDULED
[15:50:40.940] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:12:0) after 8m45s
[15:59:26.112] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:12:0)
[15:59:26.140] Build status: SCHEDULED
[15:59:26.141] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:13:0) after 4m20s
[16:03:46.164] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:13:0)
[16:03:46.198] Build status: SCHEDULED
[16:03:46.198] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:14:0) after 2m48s
[16:06:34.332] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:14:0)
[16:06:34.366] Build status: SCHEDULED
[16:06:34.366] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:15:0) after 3m43s
[16:10:17.431] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:15:0)
[16:10:17.460] Build status: SCHEDULED
[16:10:17.460] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:16:0) after 9m55s
[16:20:12.509] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:16:0)
[16:20:12.535] Build status: SCHEDULED
[16:20:12.535] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:17:0) after 8m34s
[16:28:46.515] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:17:0)
[16:28:46.544] Build status: SCHEDULED
[16:28:46.544] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:18:0) after 6m10s
[16:34:56.579] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:18:0)
[16:34:56.606] Build status: SCHEDULED
[16:34:56.606] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:19:0) after 4m57s
[16:39:53.659] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:19:0)
[16:39:53.686] Build status: SCHEDULED
[16:39:53.686] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:20:0) after 3m47s
[16:43:40.715] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:20:0)
[16:43:40.770] Build status: SCHEDULED
[16:43:40.770] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:21:0) after 3m18s
[16:46:58.787] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:21:0)
[16:46:58.816] Build status: SCHEDULED
[16:46:58.816] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:22:0) after 8m53s
[16:55:51.961] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:22:0)
[16:55:51.987] Build status: SCHEDULED
[16:55:51.987] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:23:0) after 4m2s
[16:59:54.286] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:23:0)
[16:59:54.323] Build status: SCHEDULED
[16:59:54.323] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:24:0) after 5m59s
[17:05:53.612] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:24:0)
[17:05:53.651] Build status: SCHEDULED
[17:05:53.651] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:25:0) after 8m19s
[17:14:12.670] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:25:0)
[17:14:12.697] Build status: SCHEDULED
[17:14:12.697] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:26:0) after 3m59s
[17:18:11.817] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:26:0)
[17:18:11.843] Build status: SCHEDULED
[17:18:11.843] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:27:0) after 4m49s
[17:23:00.862] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:27:0)
[17:23:00.892] Build status: SCHEDULED
[17:23:00.892] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:28:0) after 9m37s
[17:32:37.951] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:28:0)
[17:32:37.979] Build status: SCHEDULED
[17:32:37.979] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:29:0) after 5m54s
[17:35:29.295] Received PubSub notification, asking Buildbucket for the build status
[17:35:29.343] Build status: STARTED
[17:38:32.102] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:29:0)
[17:38:32.138] Build status: STARTED
[17:38:32.138] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:31:0) after 1m49s
[17:40:21.343] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:31:0)
[17:40:21.372] Build status: STARTED
[17:40:21.372] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:32:0) after 5m34s
[17:45:55.431] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:32:0)
[17:45:55.464] Build status: STARTED
[17:45:55.464] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:33:0) after 3m12s
[17:49:07.545] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:33:0)
[17:49:07.573] Build status: STARTED
[17:49:07.573] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:34:0) after 2m47s
[17:51:54.678] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:34:0)
[17:51:54.706] Build status: STARTED
[17:51:54.706] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:35:0) after 7m40s
[17:59:34.894] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:35:0)
[17:59:34.924] Build status: STARTED
[17:59:34.924] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9014851495423234448:36:0) after 9m39s
[18:00:35.052] Received PubSub notification, asking Buildbucket for the build status
[18:00:35.080] Build:
{
"id": "8849421433364855216",
"builder": {
"project": "webrtc",
"bucket": "ci",
"builder": "Mac Asan"
},
"number": 26263,
"createdBy": "project:webrtc",
"createTime": "2021-04-20T15:04:46.152687Z",
"startTime": "2021-04-20T17:35:27.406922Z",
"endTime": "2021-04-20T18:00:34.042778Z",
"updateTime": "2021-04-20T18:00:34.759776Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "e313c0702030dabc82383faf88188945f898c656",
"ref": "refs/heads/master"
}
}
}
[18:00:35.080] Invocation finished in 2h55m50.27445756s with status SUCCEEDED