[09:50:59.140] New invocation is queued and will start shortly
[09:51:00.381] Starting the invocation (attempt 1)
[09:51:00.426] Ignoring unrecognized buildset tag "buildset:commit/git/5e847f354d08a95763bec13e477e90542dddd348"
[09:51:00.426] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e847f354d08a95763bec13e477e90542dddd348"
[09:51:00.426] Popped gitiles commit info from properties and tags
[09:51:00.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:51:00.426] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:51:00.426] Buildbucket request:
{
"requestId": "9017589144571731712",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e847f354d08a95763bec13e477e90542dddd348",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017589144571731712"
},
{
"key": "scheduler_job_id",
"value": "chromium/Deterministic Android (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:51:00.945] Scheduled build:
{
"id": "8852159082490128080",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"number": 8875,
"createdBy": "project:chromium",
"createTime": "2021-03-21T09:51:00.494851Z",
"updateTime": "2021-03-21T09:51:00.878943Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e847f354d08a95763bec13e477e90542dddd348",
"ref": "refs/heads/master"
}
}
}
[09:51:00.945] Task URL: https://cr-buildbucket.appspot.com/build/8852159082490128080
[09:51:00.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:2:0) after 1m21s
[09:51:04.763] Received PubSub notification, asking Buildbucket for the build status
[09:51:05.129] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:21.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:2:0)
[09:52:21.986] Build status: STARTED
[09:52:21.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:4:0) after 8m3s
[10:00:25.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:4:0)
[10:00:25.018] Timer tick, asking Buildbucket for the build status
[10:00:25.190] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:5:0) after 1m0s
[10:01:25.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:5:0)
[10:01:25.207] Timer tick, asking Buildbucket for the build status
[10:01:25.270] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:25.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:6:0) after 1m0s
[10:02:25.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:6:0)
[10:02:25.616] Build status: STARTED
[10:02:25.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:7:0) after 5m5s
[10:07:30.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:7:0)
[10:07:30.659] Build status: STARTED
[10:07:30.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:8:0) after 4m6s
[10:11:36.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:8:0)
[10:11:36.703] Build status: STARTED
[10:11:36.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:9:0) after 8m38s
[10:20:14.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:9:0)
[10:20:14.763] Timer tick, asking Buildbucket for the build status
[10:20:14.908] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:14.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:10:0) after 1m0s
[10:21:14.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:10:0)
[10:21:14.950] Build status: STARTED
[10:21:14.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:11:0) after 8m31s
[10:29:46.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:11:0)
[10:29:46.042] Build status: STARTED
[10:29:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:12:0) after 1m38s
[10:31:24.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:12:0)
[10:31:24.515] Build status: STARTED
[10:31:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:13:0) after 7m57s
[10:39:21.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:13:0)
[10:39:21.585] Build status: STARTED
[10:39:21.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:14:0) after 5m24s
[10:44:45.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:14:0)
[10:44:45.787] Build status: STARTED
[10:44:45.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:15:0) after 3m15s
[10:48:00.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:15:0)
[10:48:00.894] Build status: STARTED
[10:48:00.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:16:0) after 5m3s
[10:53:03.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:16:0)
[10:53:03.956] Build status: STARTED
[10:53:03.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:17:0) after 1m23s
[10:54:27.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:17:0)
[10:54:27.059] Timer tick, asking Buildbucket for the build status
[10:54:27.246] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:27.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:18:0) after 1m0s
[10:55:27.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:18:0)
[10:55:27.307] Build status: STARTED
[10:55:27.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:19:0) after 3m41s
[10:59:08.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:19:0)
[10:59:08.391] Build status: STARTED
[10:59:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:20:0) after 1m44s
[11:00:52.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:20:0)
[11:00:52.409] Timer tick, asking Buildbucket for the build status
[11:00:52.498] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:52.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:21:0) after 1m0s
[11:01:52.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:21:0)
[11:01:52.540] Build status: STARTED
[11:01:52.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:22:0) after 3m44s
[11:05:36.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:22:0)
[11:05:36.646] Timer tick, asking Buildbucket for the build status
[11:05:36.722] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:23:0) after 1m0s
[11:06:36.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:23:0)
[11:06:36.847] Build status: STARTED
[11:06:36.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:24:0) after 2m26s
[11:09:02.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:24:0)
[11:09:02.895] Build status: STARTED
[11:09:02.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:25:0) after 2m18s
[11:11:21.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:25:0)
[11:11:21.485] Build status: STARTED
[11:11:21.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:26:0) after 9m45s
[11:21:06.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:26:0)
[11:21:06.527] Build status: STARTED
[11:21:06.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:27:0) after 4m11s
[11:25:17.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:27:0)
[11:25:17.770] Build status: STARTED
[11:25:17.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:28:0) after 4m8s
[11:29:25.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:28:0)
[11:29:25.919] Build status: STARTED
[11:29:25.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:29:0) after 8m25s
[11:37:51.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:29:0)
[11:37:51.200] Build status: STARTED
[11:37:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:30:0) after 9m48s
[11:47:39.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:30:0)
[11:47:39.247] Build status: STARTED
[11:47:39.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:31:0) after 8m11s
[11:55:50.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:31:0)
[11:55:50.392] Build status: STARTED
[11:55:50.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:32:0) after 2m31s
[11:58:21.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:32:0)
[11:58:21.907] Timer tick, asking Buildbucket for the build status
[11:58:21.996] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:33:0) after 1m0s
[11:59:22.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:33:0)
[11:59:22.491] Timer tick, asking Buildbucket for the build status
[11:59:22.560] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:22.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:34:0) after 1m0s
[12:00:22.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:34:0)
[12:00:22.931] Timer tick, asking Buildbucket for the build status
[12:00:23.001] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:23.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:35:0) after 1m0s
[12:01:23.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:35:0)
[12:01:23.202] Build status: STARTED
[12:01:23.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:36:0) after 4m29s
[12:05:52.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:36:0)
[12:05:52.223] Timer tick, asking Buildbucket for the build status
[12:05:52.317] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:52.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:37:0) after 1m0s
[12:06:52.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:37:0)
[12:06:52.352] Timer tick, asking Buildbucket for the build status
[12:06:52.436] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:52.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:38:0) after 1m0s
[12:07:52.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:38:0)
[12:07:52.455] Timer tick, asking Buildbucket for the build status
[12:07:52.558] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:52.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:39:0) after 1m0s
[12:08:52.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:39:0)
[12:08:52.689] Timer tick, asking Buildbucket for the build status
[12:08:52.767] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:52.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:40:0) after 1m0s
[12:09:52.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:40:0)
[12:09:52.871] Build status: STARTED
[12:09:52.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:41:0) after 8m12s
[12:18:04.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:41:0)
[12:18:04.945] Build status: STARTED
[12:18:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:42:0) after 2m29s
[12:20:34.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:42:0)
[12:20:34.188] Timer tick, asking Buildbucket for the build status
[12:20:34.336] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:34.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:43:0) after 1m0s
[12:21:34.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:43:0)
[12:21:34.486] Timer tick, asking Buildbucket for the build status
[12:21:34.547] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:34.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:44:0) after 1m0s
[12:22:34.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:44:0)
[12:22:34.596] Build status: STARTED
[12:22:34.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:45:0) after 6m16s
[12:28:50.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:45:0)
[12:28:50.647] Build status: STARTED
[12:28:50.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:46:0) after 3m12s
[12:32:02.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:46:0)
[12:32:02.798] Build status: STARTED
[12:32:02.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:47:0) after 7m20s
[12:39:22.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:47:0)
[12:39:22.846] Build status: STARTED
[12:39:22.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:48:0) after 2m58s
[12:42:21.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:48:0)
[12:42:21.179] Timer tick, asking Buildbucket for the build status
[12:42:21.397] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:21.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:49:0) after 1m0s
[12:43:21.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:49:0)
[12:43:21.468] Build status: STARTED
[12:43:21.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:50:0) after 6m35s
[12:49:56.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:50:0)
[12:49:56.501] Build status: STARTED
[12:49:56.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:51:0) after 1m16s
[12:51:12.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:51:0)
[12:51:12.658] Build status: STARTED
[12:51:12.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:52:0) after 7m22s
[12:58:34.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:52:0)
[12:58:34.767] Build status: STARTED
[12:58:34.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:53:0) after 1m38s
[13:00:12.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:53:0)
[13:00:12.759] Timer tick, asking Buildbucket for the build status
[13:00:12.843] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:12.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:54:0) after 1m0s
[13:01:13.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:54:0)
[13:01:13.050] Build status: STARTED
[13:01:13.050] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:55:0) after 4m0s
[13:05:13.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:55:0)
[13:05:13.091] Build status: STARTED
[13:05:13.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:56:0) after 8m2s
[13:13:15.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:56:0)
[13:13:15.220] Timer tick, asking Buildbucket for the build status
[13:13:15.486] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:15.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:57:0) after 1m0s
[13:14:15.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:57:0)
[13:14:15.579] Build status: STARTED
[13:14:15.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:58:0) after 7m58s
[13:22:13.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:58:0)
[13:22:13.808] Timer tick, asking Buildbucket for the build status
[13:22:13.991] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:13.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:59:0) after 1m0s
[13:23:14.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:59:0)
[13:23:14.359] Timer tick, asking Buildbucket for the build status
[13:23:14.432] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:14.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:60:0) after 1m0s
[13:24:14.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:60:0)
[13:24:14.610] Timer tick, asking Buildbucket for the build status
[13:24:14.670] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:14.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:61:0) after 1m0s
[13:25:14.686] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:61:0)
[13:25:14.715] Build status: STARTED
[13:25:14.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:62:0) after 5m40s
[13:30:54.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:62:0)
[13:30:54.733] Timer tick, asking Buildbucket for the build status
[13:30:54.814] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:54.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:63:0) after 1m0s
[13:31:54.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:63:0)
[13:31:54.888] Build status: STARTED
[13:31:54.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:64:0) after 1m33s
[13:33:27.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:64:0)
[13:33:27.914] Timer tick, asking Buildbucket for the build status
[13:33:28.030] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:28.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:65:0) after 1m0s
[13:34:28.120] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:65:0)
[13:34:28.120] Timer tick, asking Buildbucket for the build status
[13:34:28.208] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:66:0) after 1m0s
[13:35:28.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:66:0)
[13:35:28.246] Timer tick, asking Buildbucket for the build status
[13:35:28.398] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:28.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:67:0) after 1m0s
[13:36:28.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:67:0)
[13:36:28.445] Build status: STARTED
[13:36:28.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:68:0) after 7m32s
[13:44:00.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:68:0)
[13:44:00.622] Timer tick, asking Buildbucket for the build status
[13:44:00.917] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:00.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:69:0) after 1m0s
[13:45:00.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:69:0)
[13:45:00.946] Timer tick, asking Buildbucket for the build status
[13:45:01.287] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:01.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:70:0) after 1m0s
[13:46:01.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:70:0)
[13:46:01.316] Timer tick, asking Buildbucket for the build status
[13:46:01.592] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:01.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:71:0) after 1m0s
[13:47:01.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:71:0)
[13:47:01.709] Timer tick, asking Buildbucket for the build status
[13:47:01.796] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:72:0) after 1m0s
[13:48:01.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:72:0)
[13:48:01.847] Timer tick, asking Buildbucket for the build status
[13:48:02.104] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:02.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:73:0) after 1m0s
[13:49:02.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:73:0)
[13:49:02.115] Timer tick, asking Buildbucket for the build status
[13:49:02.234] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:02.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:74:0) after 1m0s
[13:50:02.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:74:0)
[13:50:02.277] Build status: STARTED
[13:50:02.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:75:0) after 9m8s
[13:59:10.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:75:0)
[13:59:10.323] Build status: STARTED
[13:59:10.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:76:0) after 3m42s
[14:02:52.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:76:0)
[14:02:52.463] Build status: STARTED
[14:02:52.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:77:0) after 6m23s
[14:09:15.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:77:0)
[14:09:15.512] Build status: STARTED
[14:09:15.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:78:0) after 4m38s
[14:13:53.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:78:0)
[14:13:53.532] Timer tick, asking Buildbucket for the build status
[14:13:53.991] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:53.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:79:0) after 1m0s
[14:14:54.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:79:0)
[14:14:54.037] Build status: STARTED
[14:14:54.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:80:0) after 4m14s
[14:19:08.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:80:0)
[14:19:08.372] Build status: STARTED
[14:19:08.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:81:0) after 6m59s
[14:26:07.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:81:0)
[14:26:07.513] Build status: STARTED
[14:26:07.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:82:0) after 1m41s
[14:27:48.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:82:0)
[14:27:48.535] Timer tick, asking Buildbucket for the build status
[14:27:48.614] Build 8852159082490128080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:83:0) after 1m0s
[14:28:48.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:83:0)
[14:28:48.708] Build status: STARTED
[14:28:48.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017589144571731712:84:0) after 1m58s
[14:29:01.887] Received PubSub notification, asking Buildbucket for the build status
[14:29:02.041] Build 8852159082490128080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:29:02.041] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616336941220506",
"created_by": "project:chromium",
"created_ts": "1616320260494851",
"id": "8852159082490128080",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-92-n7nj\", \"builder_group\": \"chromium.android\", \"buildername\": \"Deterministic Android (dbg)\", \"buildnumber\": 8875, \"got_angle_revision\": \"90cf278c36871437c89b8f88d62e6a538b51501d\", \"got_dawn_revision\": \"6b80743d3f5bb389665590585c43eeb9cfa70a34\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"5e847f354d08a95763bec13e477e90542dddd348\", \"got_revision_cp\": \"refs/heads/master@{#864993}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"8bf1cd1c665a538a366bce4770acbb990b025388\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33513}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_5cfa6949b8ed8b3c18e47fed5c02ed7a7d0840ce4dd9ed99833e169fb40000c1_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-92-n7nj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616320264013054",
"status": "COMPLETED",
"status_changed_ts": "1616336941509230",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/8875",
"builder:Deterministic Android (dbg)",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e847f354d08a95763bec13e477e90542dddd348",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017589144571731712",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852159082490128080/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:526d03743bb64d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1616336941513028",
"url": "https://ci.chromium.org/b/8852159082490128080",
"utcnow_ts": "1616336942027302"
}
}
[14:29:02.041] Invocation finished in 4h38m2.914958712s with status SUCCEEDED