[32.556759] Initializing watchdogs [32.557064] /dev/watchdog0 [32.605334] [001/165] (960s left) i915_module_load (load) [32.790606] Starting subtest: load [34.380210] Subtest load: SUCCESS (1.571s) [34.501554] [002/165] (958s left) core_auth (basic-auth) [34.738889] Starting subtest: basic-auth [34.759542] Subtest basic-auth: SUCCESS (0.001s) [34.834814] [003/165] (958s left) debugfs_test (read_all_entries) [35.027435] Starting subtest: read_all_entries [35.085817] Subtest read_all_entries: SUCCESS (0.088s) [35.209058] [004/165] (958s left) debugfs_test (basic-hwmon) [35.379997] Starting subtest: basic-hwmon [35.422108] Subtest basic-hwmon: SKIP (0.000s) [35.502382] [005/165] (957s left) fbdev (eof) [35.669953] Starting subtest: eof [35.690794] Subtest eof: SUCCESS (0.001s) [35.787249] [006/165] (957s left) fbdev (info) [35.957519] Starting subtest: info [35.976235] Subtest info: SUCCESS (0.000s) [36.078633] [007/165] (957s left) fbdev (nullptr) [36.216701] Starting subtest: nullptr [36.235205] Subtest nullptr: SUCCESS (0.000s) [36.338700] [008/165] (957s left) fbdev (read) [36.503536] Starting subtest: read [36.777654] Subtest read: SUCCESS (0.271s) [36.876409] [009/165] (956s left) fbdev (write) [37.027767] Starting subtest: write [37.158220] Subtest write: SUCCESS (0.138s) [37.254537] [010/165] (956s left) gem_basic (bad-close) [37.433811] Starting subtest: bad-close [37.472224] Subtest bad-close: SUCCESS (0.000s) [37.558416] [011/165] (956s left) gem_basic (create-close) [37.739223] Starting subtest: create-close [37.780817] Subtest create-close: SUCCESS (0.000s) [37.856029] [012/165] (956s left) gem_basic (create-fd-close) [38.042751] Starting subtest: create-fd-close [38.079755] Subtest create-fd-close: SUCCESS (0.000s) [38.167455] [013/165] (955s left) gem_busy (busy@all-engines) [38.348410] Starting subtest: busy [38.369827] Starting dynamic subtest: all-engines [38.391363] Dynamic subtest all-engines: SUCCESS (0.031s) [38.412090] Subtest busy: SUCCESS (0.032s) [38.728852] [014/165] (955s left) gem_close_race (basic-process) [38.940118] Starting subtest: basic-process [38.965058] Subtest basic-process: SUCCESS (0.052s) [39.184644] [015/165] (955s left) gem_close_race (basic-threads) [39.402708] Starting subtest: basic-threads [40.577048] Subtest basic-threads: SUCCESS (1.177s) [40.795275] [016/165] (953s left) gem_ctx_create (basic) [40.992986] Starting subtest: basic [41.019801] Subtest basic: SUCCESS (0.000s) [41.175773] [017/165] (953s left) gem_ctx_create (basic-files) [41.343377] Starting subtest: basic-files [43.347767] Subtest basic-files: SUCCESS (2.023s) [43.646669] [018/165] (950s left) gem_ctx_exec (basic) [43.836867] Starting subtest: basic [43.857934] Subtest basic: SUCCESS (0.001s) [43.936951] [019/165] (950s left) gem_exec_basic (basic) [44.129671] Starting subtest: basic [44.149186] Starting dynamic subtest: rcs0-smem [44.168322] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [44.201702] Starting dynamic subtest: vcs0-smem [44.221273] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [44.242374] Subtest basic: SUCCESS (0.001s) [44.323377] [020/165] (950s left) gem_exec_create (basic) [44.507785] Starting subtest: basic [44.527718] Starting dynamic subtest: smem [46.547225] Dynamic subtest smem: SUCCESS (2.046s) [46.567071] Subtest basic: SUCCESS (2.046s) [46.751279] [021/165] (947s left) gem_exec_fence (basic-busy) [47.048950] Starting subtest: basic-busy [47.069257] Starting dynamic subtest: rcs0 [47.111683] Dynamic subtest rcs0: SUCCESS (0.023s) [47.151611] Starting dynamic subtest: vcs0 [47.189767] Dynamic subtest vcs0: SUCCESS (0.022s) [47.208853] Subtest basic-busy: SUCCESS (0.045s) [47.672938] [022/165] (947s left) gem_exec_fence (basic-wait) [47.973750] Starting subtest: basic-wait [47.994356] Starting dynamic subtest: rcs0 [48.013504] Dynamic subtest rcs0: SUCCESS (0.024s) [48.049118] Starting dynamic subtest: vcs0 [48.067747] Dynamic subtest vcs0: SUCCESS (0.024s) [48.087886] Subtest basic-wait: SUCCESS (0.049s) [48.532165] [023/165] (946s left) gem_exec_fence (basic-await) [48.806128] Starting subtest: basic-await [48.825815] Starting dynamic subtest: rcs0 [48.877823] Dynamic subtest rcs0: SUCCESS (0.071s) [48.907545] Starting dynamic subtest: vcs0 [48.950861] Dynamic subtest vcs0: SUCCESS (0.072s) [48.972124] Subtest basic-await: SUCCESS (0.144s) [49.486231] [024/165] (945s left) gem_exec_fence (nb-await) [49.786487] Starting subtest: nb-await [49.805536] Starting dynamic subtest: rcs0 [49.843284] Dynamic subtest rcs0: SUCCESS (0.053s) [49.880247] Starting dynamic subtest: vcs0 [49.902110] Dynamic subtest vcs0: SUCCESS (0.054s) [49.923169] Subtest nb-await: SUCCESS (0.108s) [50.408413] [025/165] (944s left) gem_exec_gttfill (basic) [50.589893] Starting subtest: basic [59.888950] Subtest basic: SUCCESS (9.319s) [60.100380] [026/165] (934s left) gem_exec_parallel (engines) [60.406883] Starting subtest: engines [60.425411] Starting dynamic subtest: basic [61.933190] Dynamic subtest basic: SUCCESS (1.541s) [61.972482] Starting dynamic subtest: contexts [63.976626] Dynamic subtest contexts: SUCCESS (2.049s) [64.008973] Starting dynamic subtest: fds [64.044850] Dynamic subtest fds: SKIP (0.001s) [64.076985] Starting dynamic subtest: userptr [65.794901] Dynamic subtest userptr: SUCCESS (1.802s) [65.815842] Subtest engines: SUCCESS (5.394s) [65.998064] [027/165] (929s left) gem_exec_store (basic) [66.243389] Starting subtest: basic [66.263181] Subtest basic: SUCCESS (0.044s) [66.420692] [028/165] (928s left) gem_flink_basic (bad-flink) [66.590749] Starting subtest: bad-flink [66.612302] Subtest bad-flink: SUCCESS (0.000s) [66.697558] [029/165] (928s left) gem_flink_basic (bad-open) [66.877165] Starting subtest: bad-open [66.898506] Subtest bad-open: SUCCESS (0.000s) [66.980526] [030/165] (928s left) gem_flink_basic (basic) [67.160363] Starting subtest: basic [67.179737] Subtest basic: SUCCESS (0.000s) [67.261451] [031/165] (928s left) gem_flink_basic (double-flink) [67.440623] Starting subtest: double-flink [67.459535] Subtest double-flink: SUCCESS (0.000s) [67.546600] [032/165] (927s left) gem_flink_basic (flink-lifetime) [67.712646] Starting subtest: flink-lifetime [67.732192] Subtest flink-lifetime: SUCCESS (0.003s) [67.821940] [033/165] (927s left) gem_huc_copy (huc-copy) [68.015672] Subtest huc-copy: SKIP (0.000s) [68.102145] [034/165] (927s left) gem_linear_blits (basic) [68.369699] Starting subtest: basic [68.389792] Subtest basic: SUCCESS (0.015s) [68.556144] [035/165] (927s left) gem_mmap (basic) [68.849636] Starting subtest: basic [68.952245] Subtest basic: SUCCESS (0.001s) [69.032382] [036/165] (926s left) gem_mmap_gtt (basic) [69.232658] Starting subtest: basic [69.251257] Subtest basic: SUCCESS (0.001s) [69.342814] [037/165] (926s left) gem_render_linear_blits (basic) [69.519960] Starting subtest: basic [69.621860] Subtest basic: SUCCESS (0.034s) [69.702568] [038/165] (926s left) gem_render_tiled_blits (basic) [69.910165] Starting subtest: basic [70.062799] Subtest basic: SUCCESS (0.037s) [70.165267] [039/165] (925s left) gem_ringfill (basic-all) [70.507431] Starting subtest: basic-all [71.501242] Subtest basic-all: SUCCESS (1.107s) [71.605771] [040/165] (924s left) gem_softpin (allocator-basic) [71.821378] Subtest allocator-basic: SKIP (0.000s) [71.923812] [041/165] (924s left) gem_softpin (allocator-basic-reserve) [72.136879] Subtest allocator-basic-reserve: SKIP (0.000s) [72.245709] [042/165] (924s left) gem_softpin (safe-alignment) [72.470118] Starting subtest: safe-alignment [72.489241] Subtest safe-alignment: SUCCESS (0.006s) [72.570852] [043/165] (923s left) gem_sync (basic-all) [72.781955] Starting subtest: basic-all [74.818977] Subtest basic-all: SUCCESS (2.079s) [75.028150] [044/165] (921s left) gem_sync (basic-each) [75.237467] Starting subtest: basic-each [77.288056] Subtest basic-each: SUCCESS (2.086s) [77.480889] [045/165] (919s left) gem_tiled_blits (basic) [77.722635] Starting subtest: basic [77.764076] Subtest basic: SUCCESS (0.029s) [77.911360] [046/165] (918s left) gem_tiled_fence_blits (basic) [78.303218] Starting subtest: basic [78.325268] Subtest basic: SUCCESS (0.013s) [78.481558] [047/165] (918s left) gem_tiled_pread_basic [79.021555] [048/165] (917s left) gem_wait (busy@all-engines) [79.207789] Starting subtest: busy [79.228863] Starting dynamic subtest: all-engines [79.724069] Dynamic subtest all-engines: SUCCESS (0.514s) [79.743299] Subtest busy: SUCCESS (0.514s) [79.974337] [049/165] (916s left) gem_wait (wait@all-engines) [80.152027] Starting subtest: wait [80.173147] Starting dynamic subtest: all-engines [81.169281] Dynamic subtest all-engines: SUCCESS (1.022s) [81.188316] Subtest wait: SUCCESS (1.022s) [81.437341] [050/165] (915s left) i915_getparams_basic (basic-eu-total) [81.608415] Starting subtest: basic-eu-total [81.650098] Subtest basic-eu-total: SUCCESS (0.000s) [81.748471] [051/165] (915s left) i915_getparams_basic (basic-subslice-total) [81.929758] Starting subtest: basic-subslice-total [81.966904] Subtest basic-subslice-total: SUCCESS (0.000s) [82.057455] [052/165] (915s left) i915_hangman (error-state-basic) [82.240269] Starting subtest: error-state-basic [82.261778] Subtest error-state-basic: SUCCESS (0.004s) [82.361384] [053/165] (914s left) i915_pciid [82.637694] [054/165] (914s left) kms_addfb_basic (addfb25-4-tiled) [82.872103] Starting subtest: addfb25-4-tiled [82.893944] Subtest addfb25-4-tiled: SUCCESS (0.000s) [82.984834] [055/165] (914s left) kms_addfb_basic (addfb25-bad-modifier) [83.152605] Starting subtest: addfb25-bad-modifier [83.173577] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [83.258892] [056/165] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [83.436288] Starting subtest: addfb25-framebuffer-vs-set-tiling [83.455289] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [83.536207] [057/165] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [83.711821] Starting subtest: addfb25-modifier-no-flag [83.730377] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [83.822409] [058/165] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [83.998048] Starting subtest: addfb25-x-tiled-legacy [84.019544] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [84.107639] [059/165] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [84.280099] Starting subtest: addfb25-x-tiled-mismatch-legacy [84.301026] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [84.386826] [060/165] (913s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [84.575372] Starting subtest: addfb25-yf-tiled-legacy [84.594218] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [84.673170] [061/165] (913s left) kms_addfb_basic (addfb25-y-tiled-legacy) [84.842403] Starting subtest: addfb25-y-tiled-legacy [84.860806] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [84.946680] [062/165] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [85.117709] Starting subtest: addfb25-y-tiled-small-legacy [85.160809] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [85.245746] [063/165] (912s left) kms_addfb_basic (bad-pitch-0) [85.417137] Starting subtest: bad-pitch-0 [85.437862] Subtest bad-pitch-0: SUCCESS (0.000s) [85.520788] [064/165] (912s left) kms_addfb_basic (bad-pitch-1024) [85.700185] Starting subtest: bad-pitch-1024 [85.719149] Subtest bad-pitch-1024: SUCCESS (0.000s) [85.803844] [065/165] (912s left) kms_addfb_basic (bad-pitch-128) [85.995231] Starting subtest: bad-pitch-128 [86.013893] Subtest bad-pitch-128: SUCCESS (0.000s) [86.104912] [066/165] (912s left) kms_addfb_basic (bad-pitch-256) [86.301998] Starting subtest: bad-pitch-256 [86.323263] Subtest bad-pitch-256: SUCCESS (0.000s) [86.412069] [067/165] (911s left) kms_addfb_basic (bad-pitch-32) [86.594359] Starting subtest: bad-pitch-32 [86.614973] Subtest bad-pitch-32: SUCCESS (0.000s) [86.698378] [068/165] (911s left) kms_addfb_basic (bad-pitch-63) [86.885316] Starting subtest: bad-pitch-63 [86.904318] Subtest bad-pitch-63: SUCCESS (0.000s) [86.996170] [069/165] (911s left) kms_addfb_basic (bad-pitch-65536) [87.165877] Starting subtest: bad-pitch-65536 [87.184722] Subtest bad-pitch-65536: SUCCESS (0.000s) [87.271337] [070/165] (911s left) kms_addfb_basic (bad-pitch-999) [87.451511] Starting subtest: bad-pitch-999 [87.473428] Subtest bad-pitch-999: SUCCESS (0.000s) [87.563413] [071/165] (911s left) kms_addfb_basic (basic) [87.735503] Starting subtest: basic [87.756099] Subtest basic: SUCCESS (0.000s) [87.838367] [072/165] (910s left) kms_addfb_basic (basic-x-tiled-legacy) [88.025365] Starting subtest: basic-x-tiled-legacy [88.044491] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [88.132433] [073/165] (910s left) kms_addfb_basic (basic-y-tiled-legacy) [88.312432] Starting subtest: basic-y-tiled-legacy [88.331843] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [88.422211] [074/165] (910s left) kms_addfb_basic (bo-too-small) [88.594507] Starting subtest: bo-too-small [88.616233] Subtest bo-too-small: SUCCESS (0.000s) [88.700347] [075/165] (910s left) kms_addfb_basic (bo-too-small-due-to-tiling) [88.863282] Starting subtest: bo-too-small-due-to-tiling [88.884069] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [88.968208] [076/165] (909s left) kms_addfb_basic (clobberred-modifier) [89.144336] Starting subtest: clobberred-modifier [89.163286] Subtest clobberred-modifier: SUCCESS (0.000s) [89.249208] [077/165] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling) [89.411476] Starting subtest: framebuffer-vs-set-tiling [89.430228] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [89.520445] [078/165] (909s left) kms_addfb_basic (invalid-get-prop) [89.682985] Starting subtest: invalid-get-prop [89.704653] Subtest invalid-get-prop: SUCCESS (0.000s) [89.792646] [079/165] (909s left) kms_addfb_basic (invalid-get-prop-any) [89.967607] Starting subtest: invalid-get-prop-any [89.995989] Subtest invalid-get-prop-any: SUCCESS (0.000s) [90.083244] [080/165] (909s left) kms_addfb_basic (invalid-set-prop) [90.262119] Starting subtest: invalid-set-prop [90.281282] Subtest invalid-set-prop: SUCCESS (0.000s) [90.367350] [081/165] (908s left) kms_addfb_basic (invalid-set-prop-any) [90.530846] Starting subtest: invalid-set-prop-any [90.551636] Subtest invalid-set-prop-any: SUCCESS (0.000s) [90.642610] [082/165] (908s left) kms_addfb_basic (no-handle) [90.836670] Starting subtest: no-handle [90.857215] Subtest no-handle: SUCCESS (0.000s) [90.941728] [083/165] (908s left) kms_addfb_basic (size-max) [91.119745] Starting subtest: size-max [91.144868] Subtest size-max: SUCCESS (0.000s) [91.247289] [084/165] (908s left) kms_addfb_basic (small-bo) [91.444665] Starting subtest: small-bo [91.469067] Subtest small-bo: SUCCESS (0.000s) [91.583648] [085/165] (908s left) kms_addfb_basic (tile-pitch-mismatch) [91.794278] Starting subtest: tile-pitch-mismatch [91.818226] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [91.919703] [086/165] (907s left) kms_addfb_basic (too-high) [92.102469] Starting subtest: too-high [92.124595] Subtest too-high: SUCCESS (0.001s) [92.221424] [087/165] (907s left) kms_addfb_basic (too-wide) [92.402413] Starting subtest: too-wide [92.424269] Subtest too-wide: SUCCESS (0.000s) [92.525258] [088/165] (907s left) kms_addfb_basic (unused-handle) [92.709695] Starting subtest: unused-handle [92.734264] Subtest unused-handle: SUCCESS (0.000s) [92.838397] [089/165] (907s left) kms_addfb_basic (unused-modifier) [93.044635] Starting subtest: unused-modifier [93.076414] Subtest unused-modifier: SUCCESS (0.000s) [93.184127] [090/165] (906s left) kms_addfb_basic (unused-offsets) [93.390951] Starting subtest: unused-offsets [93.413617] Subtest unused-offsets: SUCCESS (0.000s) [93.508794] [091/165] (906s left) kms_addfb_basic (unused-pitches) [93.706550] Starting subtest: unused-pitches [93.729820] Subtest unused-pitches: SUCCESS (0.000s) [93.832496] [092/165] (906s left) kms_busy (basic) [94.021323] Starting subtest: basic [94.042193] Starting dynamic subtest: flip [94.781689] Dynamic subtest flip: SUCCESS (0.754s) [94.813945] Starting dynamic subtest: modeset [95.360552] Dynamic subtest modeset: SUCCESS (0.597s) [95.381462] Subtest basic: SUCCESS (1.352s) [95.554793] [093/165] (904s left) kms_prop_blob (basic) [95.749621] Starting subtest: basic [95.768367] Subtest basic: SUCCESS (0.000s) [95.854988] [094/165] (904s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [96.041044] Starting subtest: basic-busy-flip-before-cursor-atomic [97.019202] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.975s) [97.203718] [095/165] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [97.397788] Starting subtest: basic-busy-flip-before-cursor-legacy [98.388125] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.981s) [98.545313] [096/165] (902s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [98.716786] Starting subtest: basic-flip-after-cursor-atomic [99.698845] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.977s) [99.860517] [097/165] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [100.035493] Starting subtest: basic-flip-after-cursor-legacy [101.046207] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.005s) [101.214824] [098/165] (899s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [101.394857] Starting subtest: basic-flip-after-cursor-varying-size [102.383947] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.986s) [102.542707] [099/165] (898s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [102.714706] Starting subtest: basic-flip-before-cursor-atomic [103.681560] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.969s) [103.862202] [100/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [104.042066] Starting subtest: basic-flip-before-cursor-legacy [105.002935] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.968s) [105.167717] [101/165] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [105.342635] Starting subtest: basic-flip-before-cursor-varying-size [106.317086] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.972s) [106.491408] [102/165] (894s left) kms_dsc (dsc-basic) [106.685540] Subtest dsc-basic: SKIP (0.000s) [106.775737] [103/165] (894s left) kms_flip (basic-flip-vs-dpms) [106.987038] Starting subtest: basic-flip-vs-dpms [107.005574] Starting dynamic subtest: A-VGA1 [108.252910] Dynamic subtest A-VGA1: SUCCESS (1.283s) [108.294595] Starting dynamic subtest: B-VGA1 [109.480227] Dynamic subtest B-VGA1: SUCCESS (1.228s) [109.500368] Subtest basic-flip-vs-dpms: SUCCESS (2.513s) [109.672235] [104/165] (891s left) kms_flip (basic-flip-vs-modeset) [109.863910] Starting subtest: basic-flip-vs-modeset [109.884536] Starting dynamic subtest: A-VGA1 [111.225260] Dynamic subtest A-VGA1: SUCCESS (1.369s) [111.260385] Starting dynamic subtest: B-VGA1 [112.441501] Dynamic subtest B-VGA1: SUCCESS (1.205s) [112.465938] Subtest basic-flip-vs-modeset: SUCCESS (2.577s) [112.636220] [105/165] (888s left) kms_flip (basic-flip-vs-wf_vblank) [112.851711] Starting subtest: basic-flip-vs-wf_vblank [112.876932] Starting dynamic subtest: A-VGA1 [114.373193] Dynamic subtest A-VGA1: SUCCESS (1.542s) [114.413838] Starting dynamic subtest: B-VGA1 [115.868537] Dynamic subtest B-VGA1: SUCCESS (1.496s) [115.893422] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.043s) [116.105128] [106/165] (885s left) kms_flip (basic-plain-flip) [116.322917] Starting subtest: basic-plain-flip [116.348446] Starting dynamic subtest: A-VGA1 [117.586222] Dynamic subtest A-VGA1: SUCCESS (1.281s) [117.631443] Starting dynamic subtest: B-VGA1 [118.780939] Dynamic subtest B-VGA1: SUCCESS (1.207s) [118.805880] Subtest basic-plain-flip: SUCCESS (2.493s) [119.027044] [107/165] (882s left) kms_force_connector_basic (force-connector-state) [119.220849] Starting subtest: force-connector-state [119.325165] Subtest force-connector-state: SUCCESS (0.113s) [119.552076] [108/165] (882s left) kms_force_connector_basic (force-edid) [119.779626] Starting subtest: force-edid [119.801912] Subtest force-edid: SUCCESS (0.023s) [119.913256] [109/165] (881s left) kms_force_connector_basic (force-load-detect) [120.127701] Starting subtest: force-load-detect [120.296703] Subtest force-load-detect: SUCCESS (0.184s) [120.530611] [110/165] (881s left) kms_force_connector_basic (prune-stale-modes) [120.716501] Starting subtest: prune-stale-modes [120.734900] Subtest prune-stale-modes: SUCCESS (0.015s) [120.863241] [111/165] (881s left) kms_frontbuffer_tracking (basic) [121.110759] Starting subtest: basic [123.316140] Subtest basic: SUCCESS (2.269s) [123.456888] [112/165] (878s left) kms_hdmi_inject (inject-audio) [123.662486] Starting subtest: inject-audio [123.840740] Subtest inject-audio: SUCCESS (0.151s) [124.069504] [113/165] (878s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [124.263075] Starting subtest: compare-crc-sanitycheck-xr24 [124.284165] Starting dynamic subtest: pipe-A-VGA-1 [124.580795] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.316s) [124.616618] Starting dynamic subtest: pipe-B-VGA-1 [124.922123] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.342s) [124.940417] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.660s) [125.104646] [114/165] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [125.283196] Starting subtest: compare-crc-sanitycheck-nv12 [125.303419] Starting dynamic subtest: pipe-A-VGA-1 [125.341512] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [125.391811] Starting dynamic subtest: pipe-B-VGA-1 [125.432242] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [125.475094] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s) [125.561803] [115/165] (876s left) kms_pipe_crc_basic (hang-read-crc) [125.741585] Starting subtest: hang-read-crc [125.761037] Starting dynamic subtest: pipe-A-VGA-1 [126.570679] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.835s) [126.603715] Starting dynamic subtest: pipe-B-VGA-1 [127.467318] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.893s) [127.485932] Subtest hang-read-crc: SUCCESS (1.731s) [127.627832] [116/165] (874s left) kms_pipe_crc_basic (nonblocking-crc) [127.813337] Starting subtest: nonblocking-crc [127.834812] Starting dynamic subtest: pipe-A-VGA-1 [128.283893] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.477s) [128.315153] Starting dynamic subtest: pipe-B-VGA-1 [128.808849] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.518s) [128.828987] Subtest nonblocking-crc: SUCCESS (0.998s) [128.970903] [117/165] (873s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [129.145369] Starting subtest: nonblocking-crc-frame-sequence [129.164487] Starting dynamic subtest: pipe-A-VGA-1 [129.655100] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.496s) [129.688546] Starting dynamic subtest: pipe-B-VGA-1 [130.133836] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.490s) [130.155079] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.989s) [130.294358] [118/165] (872s left) kms_pipe_crc_basic (read-crc) [130.477904] Starting subtest: read-crc [130.497166] Starting dynamic subtest: pipe-A-VGA-1 [130.880963] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.416s) [130.914395] Starting dynamic subtest: pipe-B-VGA-1 [131.343830] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.452s) [131.362430] Subtest read-crc: SUCCESS (0.871s) [131.504623] [119/165] (871s left) kms_pipe_crc_basic (read-crc-frame-sequence) [131.675142] Starting subtest: read-crc-frame-sequence [131.696140] Starting dynamic subtest: pipe-A-VGA-1 [132.098536] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.421s) [132.129200] Starting dynamic subtest: pipe-B-VGA-1 [132.554045] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.454s) [132.575503] Subtest read-crc-frame-sequence: SUCCESS (0.879s) [132.707740] [120/165] (869s left) kms_pm_backlight (basic-brightness) [132.912869] Subtest basic-brightness: SKIP (0.000s) [132.999471] [121/165] (869s left) kms_pm_rpm (basic-pci-d3-state) [134.486944] Subtest basic-pci-d3-state: SKIP (0.000s) [134.575210] [122/165] (868s left) kms_pm_rpm (basic-rte) [134.740723] Starting subtest: basic-rte [136.377206] Subtest basic-rte: SKIP (1.581s) [136.535086] [123/165] (866s left) kms_psr (psr_primary_page_flip) [136.762316] Subtest psr_primary_page_flip: SKIP (0.000s) [136.869655] [124/165] (866s left) kms_psr (psr_cursor_plane_move) [137.094445] Subtest psr_cursor_plane_move: SKIP (0.000s) [137.198580] [125/165] (865s left) kms_psr (psr_sprite_plane_onoff) [137.415303] Subtest psr_sprite_plane_onoff: SKIP (0.000s) [137.522265] [126/165] (865s left) kms_psr (psr_primary_mmap_gtt) [137.756311] Subtest psr_primary_mmap_gtt: SKIP (0.000s) [137.858850] [127/165] (865s left) kms_setmode (basic-clone-single-crtc) [138.066151] Starting subtest: basic-clone-single-crtc [138.143683] Subtest basic-clone-single-crtc: SKIP (0.000s) [138.260730] [128/165] (865s left) i915_pm_rps (basic-api) [138.458348] Subtest basic-api: SKIP (0.000s) [138.541739] [129/165] (864s left) prime_self_import (basic-llseek-bad) [138.717913] Starting subtest: basic-llseek-bad [138.755707] Subtest basic-llseek-bad: SUCCESS (0.004s) [138.844609] [130/165] (864s left) prime_self_import (basic-llseek-size) [138.995103] Starting subtest: basic-llseek-size [139.035419] Subtest basic-llseek-size: SUCCESS (0.005s) [139.131151] [131/165] (864s left) prime_self_import (basic-with_fd_dup) [139.279974] Starting subtest: basic-with_fd_dup [139.322335] Subtest basic-with_fd_dup: SUCCESS (0.007s) [139.408186] [132/165] (864s left) prime_self_import (basic-with_one_bo) [139.567144] Starting subtest: basic-with_one_bo [139.606963] Subtest basic-with_one_bo: SUCCESS (0.007s) [139.691130] [133/165] (864s left) prime_self_import (basic-with_one_bo_two_files) [139.835442] Starting subtest: basic-with_one_bo_two_files [139.873648] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [139.964690] [134/165] (863s left) prime_self_import (basic-with_two_bos) [140.131130] Starting subtest: basic-with_two_bos [140.171179] Subtest basic-with_two_bos: SUCCESS (0.007s) [140.266186] [135/165] (863s left) prime_vgem (basic-fence-flip) [140.478577] Starting subtest: basic-fence-flip [140.808925] Subtest basic-fence-flip: SUCCESS (0.374s) [140.936789] [136/165] (863s left) prime_vgem (basic-fence-mmap) [141.133153] Starting subtest: basic-fence-mmap [141.175673] Subtest basic-fence-mmap: SUCCESS (0.058s) [141.278574] [137/165] (862s left) prime_vgem (basic-fence-read) [141.477290] Starting subtest: basic-fence-read [141.519880] Subtest basic-fence-read: SUCCESS (0.086s) [141.632331] [138/165] (862s left) prime_vgem (basic-gtt) [141.833566] Starting subtest: basic-gtt [141.852592] Subtest basic-gtt: SUCCESS (0.024s) [141.956197] [139/165] (862s left) prime_vgem (basic-read) [142.125796] Starting subtest: basic-read [142.144746] Subtest basic-read: SUCCESS (0.034s) [142.260255] [140/165] (862s left) prime_vgem (basic-write) [142.458129] Starting subtest: basic-write [142.479224] Subtest basic-write: SUCCESS (0.037s) [142.581750] [141/165] (861s left) vgem_basic (setversion) [142.768914] Starting subtest: setversion [142.806428] Subtest setversion: SUCCESS (0.000s) [142.905444] [142/165] (861s left) vgem_basic (create) [143.069978] Starting subtest: create [143.091356] Subtest create: SUCCESS (0.000s) [143.199425] [143/165] (861s left) vgem_basic (debugfs) [143.408182] Starting subtest: debugfs [143.427339] Subtest debugfs: SUCCESS (0.003s) [143.510213] [144/165] (861s left) vgem_basic (dmabuf-export) [143.687627] Starting subtest: dmabuf-export [143.725163] Subtest dmabuf-export: SUCCESS (0.004s) [143.822136] [145/165] (861s left) vgem_basic (dmabuf-fence) [143.992882] Starting subtest: dmabuf-fence [144.013887] Subtest dmabuf-fence: SUCCESS (0.001s) [144.103175] [146/165] (860s left) vgem_basic (dmabuf-fence-before) [144.304566] Starting subtest: dmabuf-fence-before [144.324818] Subtest dmabuf-fence-before: SUCCESS (0.001s) [144.408242] [147/165] (860s left) vgem_basic (dmabuf-mmap) [144.593357] Starting subtest: dmabuf-mmap [144.612217] Subtest dmabuf-mmap: SUCCESS (0.030s) [144.698587] [148/165] (860s left) vgem_basic (mmap) [144.848290] Starting subtest: mmap [144.867172] Subtest mmap: SUCCESS (0.023s) [144.957310] [149/165] (860s left) vgem_basic (second-client) [145.123294] Starting subtest: second-client [145.166658] Subtest second-client: SUCCESS (0.033s) [145.253749] [150/165] (860s left) vgem_basic (sysfs) [145.423027] Starting subtest: sysfs [145.442899] Subtest sysfs: SUCCESS (0.001s) [145.529975] [151/165] (859s left) core_hotunplug (unbind-rebind) [145.763668] Starting subtest: unbind-rebind [149.993802] Subtest unbind-rebind: SUCCESS (4.226s) [150.050628] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1619 [max: 8192] direct dependencies: 15394 [max: 32768] indirect dependencies: 106496 all direct dependencies: 298903 dependency chains: 20937 [max: 131072] dependency chain hlocks used: 87160 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 182 in-softirq chains: 608 in-process chains: 20147 stack-trace entries: 146562 [max: 1048576] number of stack traces: 7602 number of stack hash chains: 6093 combined max dependencies: 2245434156 hardirq-safe locks: 80 hardirq-unsafe locks: 981 softirq-safe locks: 191 softirq-unsafe locks: 892 irq-safe locks: 209 irq-unsafe locks: 981 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 263 softirq-read-safe locks: 7 softirq-read-unsafe locks: 258 irq-read-safe locks: 7 irq-read-unsafe locks: 263 uncategorized locks: 275 unused locks: 1 max locking depth: 15 max bfs queue depth: 362 max lock class index: 1747 chain lookup misses: 23503 chain lookup hits: 77136153 cyclic checks: 23476 redundant checks: 0 redundant links: 0 find-mask forwards checks: 3404 find-mask backwards checks: 2660 hardirq on events: 48056264 hardirq off events: 48056260 redundant hardirq ons: 44 redundant hardirq offs: 71 softirq on events: 345059 softirq off events: 345059 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 133 zapped lock chains: 2419 large chain blocks: 1 [150.069461] Closing watchdogs Done.