[49.445259] Initializing watchdogs [49.445347] /dev/watchdog0 [49.451758] [001/171] (960s left) i915_module_load (load) [49.518290] Starting subtest: load [50.465447] Subtest load: SUCCESS (0.944s) [50.485059] [002/171] (959s left) core_auth (basic-auth) [50.600717] Starting subtest: basic-auth [50.601844] Subtest basic-auth: SUCCESS (0.001s) [50.658451] [003/171] (959s left) debugfs_test (read_all_entries) [50.723577] Starting subtest: read_all_entries [50.764164] Subtest read_all_entries: SUCCESS (0.040s) [50.843126] [004/171] (959s left) debugfs_test (basic-hwmon) [50.907520] Starting subtest: basic-hwmon [50.909699] Subtest basic-hwmon: SKIP (0.000s) [50.991277] [005/171] (959s left) fbdev (eof) [51.063197] Starting subtest: eof [51.064417] Subtest eof: SUCCESS (0.000s) [51.108431] [006/171] (958s left) fbdev (info) [51.170397] Starting subtest: info [51.171541] Subtest info: SUCCESS (0.000s) [51.227165] [007/171] (958s left) fbdev (nullptr) [51.297453] Starting subtest: nullptr [51.298804] Subtest nullptr: SUCCESS (0.000s) [51.341321] [008/171] (958s left) fbdev (read) [51.413129] Starting subtest: read [51.494768] Subtest read: SUCCESS (0.081s) [51.542337] [009/171] (958s left) fbdev (write) [51.612829] Starting subtest: write [51.653744] Subtest write: SUCCESS (0.041s) [51.691493] [010/171] (958s left) gem_basic (bad-close) [51.753718] Starting subtest: bad-close [51.755842] Subtest bad-close: SUCCESS (0.000s) [51.808300] [011/171] (958s left) gem_basic (create-close) [51.874439] Starting subtest: create-close [51.876533] Subtest create-close: SUCCESS (0.000s) [51.941629] [012/171] (958s left) gem_basic (create-fd-close) [52.004097] Starting subtest: create-fd-close [52.006094] Subtest create-fd-close: SUCCESS (0.000s) [52.074282] [013/171] (958s left) gem_busy (busy@all-engines) [52.146853] Starting subtest: busy [52.147957] Starting dynamic subtest: all-engines [52.172221] Dynamic subtest all-engines: SUCCESS (0.025s) [52.173533] Subtest busy: SUCCESS (0.025s) [52.477065] [014/171] (957s left) gem_close_race (basic-process) [52.555106] Starting subtest: basic-process [52.589818] Subtest basic-process: SUCCESS (0.034s) [52.761366] [015/171] (957s left) gem_close_race (basic-threads) [52.834373] Starting subtest: basic-threads [53.978583] Subtest basic-threads: SUCCESS (1.144s) [54.142401] [016/171] (956s left) gem_ctx_create (basic) [54.212325] Starting subtest: basic [54.213431] Subtest basic: SUCCESS (0.000s) [54.374578] [017/171] (955s left) gem_ctx_create (basic-files) [54.444215] Starting subtest: basic-files [56.456760] Subtest basic-files: SUCCESS (2.013s) [56.691037] [018/171] (953s left) gem_ctx_exec (basic) [56.757038] Starting subtest: basic [56.759230] Subtest basic: SUCCESS (0.003s) [56.841279] [019/171] (953s left) gem_exec_basic (basic) [56.909613] Starting subtest: basic [56.911286] Starting dynamic subtest: rcs0-smem [56.912343] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [56.917785] Starting dynamic subtest: bcs0-smem [56.918870] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [56.924202] Starting dynamic subtest: vcs0-smem [56.925332] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [56.930730] Starting dynamic subtest: vecs0-smem [56.931845] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [56.932976] Subtest basic: SUCCESS (0.002s) [57.074671] [020/171] (953s left) gem_exec_create (basic) [57.143913] Starting subtest: basic [57.145032] Starting dynamic subtest: smem [59.190441] Dynamic subtest smem: SUCCESS (2.046s) [59.191692] Subtest basic: SUCCESS (2.047s) [59.358474] [021/171] (950s left) gem_exec_fence (basic-busy) [59.541565] Starting subtest: basic-busy [59.542645] Starting dynamic subtest: rcs0 [59.575299] Dynamic subtest rcs0: SUCCESS (0.034s) [59.581554] Starting dynamic subtest: bcs0 [59.602406] Dynamic subtest bcs0: SUCCESS (0.026s) [59.608142] Starting dynamic subtest: vcs0 [59.629455] Dynamic subtest vcs0: SUCCESS (0.027s) [59.636201] Starting dynamic subtest: vecs0 [59.653875] Dynamic subtest vecs0: SUCCESS (0.024s) [59.655336] Subtest basic-busy: SUCCESS (0.112s) [60.106735] [022/171] (950s left) gem_exec_fence (basic-wait) [60.290490] Starting subtest: basic-wait [60.291753] Starting dynamic subtest: rcs0 [60.322836] Dynamic subtest rcs0: SUCCESS (0.032s) [60.329084] Starting dynamic subtest: bcs0 [60.357101] Dynamic subtest bcs0: SUCCESS (0.034s) [60.363541] Starting dynamic subtest: vcs0 [60.385736] Dynamic subtest vcs0: SUCCESS (0.028s) [60.392432] Starting dynamic subtest: vecs0 [60.420182] Dynamic subtest vecs0: SUCCESS (0.034s) [60.421476] Subtest basic-wait: SUCCESS (0.130s) [60.839832] [023/171] (949s left) gem_exec_fence (basic-await) [61.025780] Starting subtest: basic-await [61.026761] Starting dynamic subtest: rcs0 [61.097157] Dynamic subtest rcs0: SUCCESS (0.071s) [61.103063] Starting dynamic subtest: bcs0 [61.167839] Dynamic subtest bcs0: SUCCESS (0.071s) [61.173484] Starting dynamic subtest: vcs0 [61.238922] Dynamic subtest vcs0: SUCCESS (0.070s) [61.244600] Starting dynamic subtest: vecs0 [61.309513] Dynamic subtest vecs0: SUCCESS (0.071s) [61.310640] Subtest basic-await: SUCCESS (0.284s) [61.740015] [024/171] (948s left) gem_exec_fence (nb-await) [61.920562] Starting subtest: nb-await [61.921744] Starting dynamic subtest: rcs0 [61.973648] Dynamic subtest rcs0: SUCCESS (0.053s) [61.979607] Starting dynamic subtest: bcs0 [62.026073] Dynamic subtest bcs0: SUCCESS (0.052s) [62.031685] Starting dynamic subtest: vcs0 [62.079717] Dynamic subtest vcs0: SUCCESS (0.053s) [62.087212] Starting dynamic subtest: vecs0 [62.135734] Dynamic subtest vecs0: SUCCESS (0.056s) [62.136840] Subtest nb-await: SUCCESS (0.215s) [62.556477] [025/171] (947s left) gem_exec_gttfill (basic) [62.626979] Starting subtest: basic [65.725716] Subtest basic: SUCCESS (3.098s) [65.888684] [026/171] (944s left) gem_exec_parallel (engines) [66.016215] Starting subtest: engines [66.017294] Starting dynamic subtest: basic [67.442146] Dynamic subtest basic: SUCCESS (1.426s) [67.449436] Starting dynamic subtest: contexts [69.026585] Dynamic subtest contexts: SUCCESS (1.584s) [69.034824] Starting dynamic subtest: fds [70.803188] Dynamic subtest fds: SUCCESS (1.777s) [70.809664] Starting dynamic subtest: userptr [72.249575] Dynamic subtest userptr: SUCCESS (1.446s) [72.250864] Subtest engines: SUCCESS (6.233s) [72.411123] [027/171] (937s left) gem_exec_store (basic) [72.481889] Starting subtest: basic [72.521290] Subtest basic: SUCCESS (0.039s) [72.688244] [028/171] (937s left) gem_flink_basic (bad-flink) [72.750257] Starting subtest: bad-flink [72.751309] Subtest bad-flink: SUCCESS (0.000s) [72.804391] [029/171] (937s left) gem_flink_basic (bad-open) [72.867608] Starting subtest: bad-open [72.868679] Subtest bad-open: SUCCESS (0.000s) [72.920724] [030/171] (937s left) gem_flink_basic (basic) [72.981859] Starting subtest: basic [72.982995] Subtest basic: SUCCESS (0.000s) [73.054674] [031/171] (937s left) gem_flink_basic (double-flink) [73.115876] Starting subtest: double-flink [73.116931] Subtest double-flink: SUCCESS (0.000s) [73.188410] [032/171] (937s left) gem_flink_basic (flink-lifetime) [73.251238] Starting subtest: flink-lifetime [73.252245] Subtest flink-lifetime: SUCCESS (0.001s) [73.320420] [033/171] (937s left) gem_huc_copy (huc-copy) [73.385601] Subtest huc-copy: SKIP (0.000s) [73.416658] [034/171] (936s left) gem_linear_blits (basic) [73.558605] Starting subtest: basic [73.564622] Subtest basic: SUCCESS (0.006s) [73.662466] [035/171] (936s left) gem_mmap (basic) [73.796033] Starting subtest: basic [73.801517] Subtest basic: SUCCESS (0.000s) [73.872714] [036/171] (936s left) gem_mmap_gtt (basic) [73.937143] Starting subtest: basic [73.938149] Subtest basic: SUCCESS (0.001s) [73.983379] [037/171] (936s left) gem_render_linear_blits (basic) [74.047081] Starting subtest: basic [74.062196] Subtest basic: SUCCESS (0.015s) [74.100455] [038/171] (936s left) gem_render_tiled_blits (basic) [74.165615] Starting subtest: basic [74.185358] Subtest basic: SUCCESS (0.020s) [74.216378] [039/171] (936s left) gem_ringfill (basic-all) [74.399999] Starting subtest: basic-all [75.509377] Subtest basic-all: SUCCESS (1.110s) [75.589048] [040/171] (934s left) gem_softpin (allocator-basic) [75.655199] Subtest allocator-basic: SKIP (0.000s) [75.703375] [041/171] (934s left) gem_softpin (allocator-basic-reserve) [75.766910] Subtest allocator-basic-reserve: SKIP (0.000s) [75.821141] [042/171] (934s left) gem_softpin (safe-alignment) [75.885550] Starting subtest: safe-alignment [75.893155] Subtest safe-alignment: SUCCESS (0.009s) [75.972083] [043/171] (934s left) gem_sync (basic-all) [76.043059] Starting subtest: basic-all [78.097974] Subtest basic-all: SUCCESS (2.054s) [78.273666] [044/171] (932s left) gem_sync (basic-each) [78.343506] Starting subtest: basic-each [80.388803] Subtest basic-each: SUCCESS (2.045s) [80.553959] [045/171] (930s left) gem_tiled_blits (basic) [80.685039] Starting subtest: basic [80.694574] Subtest basic: SUCCESS (0.010s) [80.795552] [046/171] (929s left) gem_tiled_fence_blits (basic) [80.993698] Starting subtest: basic [80.999483] Subtest basic: SUCCESS (0.006s) [81.094529] [047/171] (929s left) gem_tiled_pread_basic [81.386779] [048/171] (929s left) gem_wait (busy@all-engines) [81.459335] Starting subtest: busy [81.460456] Starting dynamic subtest: all-engines [81.972617] Dynamic subtest all-engines: SUCCESS (0.513s) [81.973899] Subtest busy: SUCCESS (0.513s) [82.152980] [049/171] (928s left) gem_wait (wait@all-engines) [82.224993] Starting subtest: wait [82.226292] Starting dynamic subtest: all-engines [83.242941] Dynamic subtest all-engines: SUCCESS (1.017s) [83.244401] Subtest wait: SUCCESS (1.018s) [83.419320] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [83.482312] Starting subtest: basic-eu-total [83.484478] Subtest basic-eu-total: SUCCESS (0.000s) [83.536323] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [83.597279] Starting subtest: basic-subslice-total [83.599332] Subtest basic-subslice-total: SUCCESS (0.000s) [83.652642] [052/171] (927s left) i915_hangman (error-state-basic) [83.721433] Starting subtest: error-state-basic [83.727328] Subtest error-state-basic: SUCCESS (0.004s) [83.804137] [053/171] (926s left) i915_pciid [83.919175] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier) [83.985300] Starting subtest: addfb25-bad-modifier [83.986298] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [84.085043] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [84.149337] Starting subtest: addfb25-framebuffer-vs-set-tiling [84.150383] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.251969] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [84.315277] Starting subtest: addfb25-modifier-no-flag [84.316370] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [84.401346] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [84.463467] Starting subtest: addfb25-x-tiled-legacy [84.464564] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [84.551913] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [84.616462] Starting subtest: addfb25-x-tiled-mismatch-legacy [84.617501] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [84.701188] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [84.785397] Starting subtest: addfb25-yf-tiled-legacy [84.786450] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [84.868290] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy) [84.957703] Starting subtest: addfb25-y-tiled-legacy [84.958780] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [85.017613] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [85.100739] Starting subtest: addfb25-y-tiled-small-legacy [85.102986] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [85.168277] [062/171] (925s left) kms_addfb_basic (bad-pitch-0) [85.230039] Starting subtest: bad-pitch-0 [85.231131] Subtest bad-pitch-0: SUCCESS (0.000s) [85.317501] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [85.378866] Starting subtest: bad-pitch-1024 [85.380035] Subtest bad-pitch-1024: SUCCESS (0.000s) [85.468295] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [85.530996] Starting subtest: bad-pitch-128 [85.532090] Subtest bad-pitch-128: SUCCESS (0.000s) [85.617655] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [85.679102] Starting subtest: bad-pitch-256 [85.680235] Subtest bad-pitch-256: SUCCESS (0.000s) [85.768162] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [85.831821] Starting subtest: bad-pitch-32 [85.832820] Subtest bad-pitch-32: SUCCESS (0.000s) [85.917755] [067/171] (924s left) kms_addfb_basic (bad-pitch-63) [85.978630] Starting subtest: bad-pitch-63 [85.979775] Subtest bad-pitch-63: SUCCESS (0.000s) [86.071644] [068/171] (924s left) kms_addfb_basic (bad-pitch-65536) [86.132276] Starting subtest: bad-pitch-65536 [86.133483] Subtest bad-pitch-65536: SUCCESS (0.000s) [86.217208] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [86.277519] Starting subtest: bad-pitch-999 [86.278678] Subtest bad-pitch-999: SUCCESS (0.000s) [86.367171] [070/171] (924s left) kms_addfb_basic (basic) [86.429391] Starting subtest: basic [86.430513] Subtest basic: SUCCESS (0.000s) [86.518164] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [86.579317] Starting subtest: basic-x-tiled-legacy [86.580378] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [86.686367] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [86.750327] Starting subtest: basic-y-tiled-legacy [86.751465] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [86.850864] [073/171] (924s left) kms_addfb_basic (bo-too-small) [86.934683] Starting subtest: bo-too-small [86.935882] Subtest bo-too-small: SUCCESS (0.000s) [87.000891] [074/171] (923s left) kms_addfb_basic (bo-too-small-due-to-tiling) [87.087023] Starting subtest: bo-too-small-due-to-tiling [87.088218] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [87.170692] [075/171] (923s left) kms_addfb_basic (clobberred-modifier) [87.234112] Starting subtest: clobberred-modifier [87.235223] Subtest clobberred-modifier: SUCCESS (0.000s) [87.334201] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [87.397155] Starting subtest: framebuffer-vs-set-tiling [87.398204] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [87.502966] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [87.565159] Starting subtest: invalid-get-prop [87.566195] Subtest invalid-get-prop: SUCCESS (0.000s) [87.668038] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [87.730397] Starting subtest: invalid-get-prop-any [87.731425] Subtest invalid-get-prop-any: SUCCESS (0.000s) [87.817456] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [87.880507] Starting subtest: invalid-set-prop [87.881583] Subtest invalid-set-prop: SUCCESS (0.000s) [87.967237] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [88.028832] Starting subtest: invalid-set-prop-any [88.029968] Subtest invalid-set-prop-any: SUCCESS (0.000s) [88.117400] [081/171] (922s left) kms_addfb_basic (no-handle) [88.180290] Starting subtest: no-handle [88.181334] Subtest no-handle: SUCCESS (0.000s) [88.286289] [082/171] (922s left) kms_addfb_basic (size-max) [88.369558] Starting subtest: size-max [88.370675] Subtest size-max: SUCCESS (0.000s) [88.433762] [083/171] (922s left) kms_addfb_basic (small-bo) [88.520430] Starting subtest: small-bo [88.521490] Subtest small-bo: SUCCESS (0.000s) [88.600846] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [88.669595] Starting subtest: tile-pitch-mismatch [88.670781] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [88.767300] [085/171] (922s left) kms_addfb_basic (too-high) [88.849758] Starting subtest: too-high [88.850859] Subtest too-high: SUCCESS (0.001s) [88.916853] [086/171] (922s left) kms_addfb_basic (too-wide) [89.002151] Starting subtest: too-wide [89.003161] Subtest too-wide: SUCCESS (0.000s) [89.066479] [087/171] (922s left) kms_addfb_basic (unused-handle) [89.127990] Starting subtest: unused-handle [89.128995] Subtest unused-handle: SUCCESS (0.000s) [89.217299] [088/171] (921s left) kms_addfb_basic (unused-modifier) [89.278914] Starting subtest: unused-modifier [89.280013] Subtest unused-modifier: SUCCESS (0.000s) [89.368263] [089/171] (921s left) kms_addfb_basic (unused-offsets) [89.432218] Starting subtest: unused-offsets [89.433353] Subtest unused-offsets: SUCCESS (0.000s) [89.517362] [090/171] (921s left) kms_addfb_basic (unused-pitches) [89.579265] Starting subtest: unused-pitches [89.580354] Subtest unused-pitches: SUCCESS (0.000s) [89.667317] [091/171] (921s left) kms_busy (basic) [89.752797] Starting subtest: basic [89.754166] Starting dynamic subtest: flip [90.240357] Dynamic subtest flip: SUCCESS (0.487s) [90.247324] Starting dynamic subtest: modeset [90.820910] Dynamic subtest modeset: SUCCESS (0.579s) [90.822049] Subtest basic: SUCCESS (1.067s) [90.954853] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast) [91.079131] Subtest dp-hpd-fast: SKIP (0.000s) [91.163048] [093/171] (920s left) kms_chamelium_edid (dp-edid-read) [91.291990] Subtest dp-edid-read: SKIP (0.000s) [91.374665] [094/171] (919s left) kms_chamelium_frames (dp-crc-fast) [91.504917] Subtest dp-crc-fast: SKIP (0.000s) [91.589712] [095/171] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [91.719959] Subtest hdmi-hpd-fast: SKIP (0.000s) [91.804080] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [91.932805] Subtest hdmi-edid-read: SKIP (0.000s) [92.017157] [097/171] (919s left) kms_chamelium_frames (hdmi-crc-fast) [92.147383] Subtest hdmi-crc-fast: SKIP (0.000s) [92.233069] [098/171] (919s left) kms_chamelium_hpd (vga-hpd-fast) [92.363854] Subtest vga-hpd-fast: SKIP (0.000s) [92.449887] [099/171] (918s left) kms_chamelium_edid (vga-edid-read) [92.579060] Subtest vga-edid-read: SKIP (0.000s) [92.664852] [100/171] (918s left) kms_prop_blob (basic) [92.728692] Starting subtest: basic [92.729848] Subtest basic: SUCCESS (0.000s) [92.785174] [101/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [92.872045] Starting subtest: basic-busy-flip-before-cursor-atomic [93.809332] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.938s) [93.946764] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.029646] Starting subtest: basic-busy-flip-before-cursor-legacy [94.953613] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.923s) [95.083086] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [95.166843] Starting subtest: basic-flip-after-cursor-atomic [96.106439] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.939s) [96.236759] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [96.320215] Starting subtest: basic-flip-after-cursor-legacy [97.244433] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s) [97.374624] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [97.461053] Starting subtest: basic-flip-after-cursor-varying-size [98.382273] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.920s) [98.514141] [106/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [98.597585] Starting subtest: basic-flip-before-cursor-atomic [99.521929] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.924s) [99.654510] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [99.739046] Starting subtest: basic-flip-before-cursor-legacy [100.661569] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.923s) [100.793219] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [100.876348] Starting subtest: basic-flip-before-cursor-varying-size [101.816442] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.940s) [101.946638] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [102.019387] Starting subtest: basic-flip-vs-dpms [102.021447] Starting dynamic subtest: A-VGA1 [102.977325] Dynamic subtest A-VGA1: SUCCESS (0.956s) [102.985314] Starting dynamic subtest: B-VGA1 [103.877988] Dynamic subtest B-VGA1: SUCCESS (0.900s) [103.886607] Starting dynamic subtest: C-VGA1 [104.772612] Dynamic subtest C-VGA1: SUCCESS (0.893s) [104.774754] Subtest basic-flip-vs-dpms: SUCCESS (2.755s) [104.924058] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [105.004254] Starting subtest: basic-flip-vs-modeset [105.006977] Starting dynamic subtest: A-VGA1 [105.880644] Dynamic subtest A-VGA1: SUCCESS (0.872s) [105.887686] Starting dynamic subtest: B-VGA1 [106.682779] Dynamic subtest B-VGA1: SUCCESS (0.802s) [106.689633] Starting dynamic subtest: C-VGA1 [107.492917] Dynamic subtest C-VGA1: SUCCESS (0.810s) [107.495768] Subtest basic-flip-vs-modeset: SUCCESS (2.492s) [107.633859] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank) [107.711784] Starting subtest: basic-flip-vs-wf_vblank [107.712843] Starting dynamic subtest: A-VGA1 [108.858152] Dynamic subtest A-VGA1: SUCCESS (1.146s) [108.864927] Starting dynamic subtest: B-VGA1 [109.981560] Dynamic subtest B-VGA1: SUCCESS (1.123s) [109.989070] Starting dynamic subtest: C-VGA1 [111.105634] Dynamic subtest C-VGA1: SUCCESS (1.123s) [111.107848] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.398s) [111.293169] [112/171] (900s left) kms_flip (basic-plain-flip) [111.365742] Starting subtest: basic-plain-flip [111.368032] Starting dynamic subtest: A-VGA1 [112.235651] Dynamic subtest A-VGA1: SUCCESS (0.868s) [112.242801] Starting dynamic subtest: B-VGA1 [113.077220] Dynamic subtest B-VGA1: SUCCESS (0.841s) [113.085339] Starting dynamic subtest: C-VGA1 [113.919042] Dynamic subtest C-VGA1: SUCCESS (0.841s) [113.921330] Subtest basic-plain-flip: SUCCESS (2.556s) [114.091090] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [114.167749] Starting subtest: force-connector-state [114.304453] Subtest force-connector-state: SUCCESS (0.137s) [114.489064] [114/171] (897s left) kms_force_connector_basic (force-edid) [114.561779] Starting subtest: force-edid [114.581811] Subtest force-edid: SUCCESS (0.020s) [114.672133] [115/171] (896s left) kms_force_connector_basic (force-load-detect) [114.744374] Starting subtest: force-load-detect [114.890047] Subtest force-load-detect: SUCCESS (0.145s) [115.072859] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes) [115.146927] Starting subtest: prune-stale-modes [115.162950] Subtest prune-stale-modes: SUCCESS (0.016s) [115.255547] [117/171] (896s left) kms_frontbuffer_tracking (basic) [115.346847] Starting subtest: basic [117.157411] Subtest basic: SUCCESS (1.814s) [117.223661] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [117.309353] Starting subtest: compare-crc-sanitycheck-xr24 [117.310401] Starting dynamic subtest: pipe-A-VGA-1 [117.577759] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.268s) [117.584848] Starting dynamic subtest: pipe-B-VGA-1 [117.840853] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.261s) [117.848360] Starting dynamic subtest: pipe-C-VGA-1 [118.116872] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.274s) [118.118067] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.807s) [118.250361] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [118.333938] Starting subtest: compare-crc-sanitycheck-nv12 [118.335056] Starting dynamic subtest: pipe-A-VGA-1 [118.337225] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [118.343989] Starting dynamic subtest: pipe-B-VGA-1 [118.346107] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [118.352779] Starting dynamic subtest: pipe-C-VGA-1 [118.354857] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [118.356951] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s) [118.399699] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc) [118.484481] Starting subtest: hang-read-crc [118.485660] Starting dynamic subtest: pipe-A-VGA-1 [119.218339] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.732s) [119.225516] Starting dynamic subtest: pipe-B-VGA-1 [119.948124] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.729s) [119.955345] Starting dynamic subtest: pipe-C-VGA-1 [120.696192] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.748s) [120.697390] Subtest hang-read-crc: SUCCESS (2.212s) [120.814814] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc) [120.900710] Starting subtest: nonblocking-crc [120.901813] Starting dynamic subtest: pipe-A-VGA-1 [121.338663] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.436s) [121.347598] Starting dynamic subtest: pipe-B-VGA-1 [121.768913] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.429s) [121.775778] Starting dynamic subtest: pipe-C-VGA-1 [122.206100] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s) [122.207170] Subtest nonblocking-crc: SUCCESS (1.305s) [122.325345] [122/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.410382] Starting subtest: nonblocking-crc-frame-sequence [122.411471] Starting dynamic subtest: pipe-A-VGA-1 [122.847799] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.437s) [122.854925] Starting dynamic subtest: pipe-B-VGA-1 [123.276309] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.427s) [123.283574] Starting dynamic subtest: pipe-C-VGA-1 [123.716141] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.439s) [123.717216] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.307s) [123.834088] [123/171] (887s left) kms_pipe_crc_basic (read-crc) [123.922269] Starting subtest: read-crc [123.923401] Starting dynamic subtest: pipe-A-VGA-1 [124.290802] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.368s) [124.297792] Starting dynamic subtest: pipe-B-VGA-1 [124.653192] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s) [124.661855] Starting dynamic subtest: pipe-C-VGA-1 [125.026657] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.373s) [125.027878] Subtest read-crc: SUCCESS (1.105s) [125.144815] [124/171] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.228726] Starting subtest: read-crc-frame-sequence [125.229872] Starting dynamic subtest: pipe-A-VGA-1 [125.600727] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.371s) [125.607715] Starting dynamic subtest: pipe-B-VGA-1 [125.962264] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s) [125.969135] Starting dynamic subtest: pipe-C-VGA-1 [126.338445] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.375s) [126.339639] Subtest read-crc-frame-sequence: SUCCESS (1.109s) [126.457117] [125/171] (885s left) kms_psr (primary_page_flip) [126.521966] Subtest primary_page_flip: SKIP (0.000s) [126.552854] [126/171] (885s left) kms_psr (cursor_plane_move) [126.616480] Subtest cursor_plane_move: SKIP (0.000s) [126.637144] [127/171] (885s left) kms_psr (sprite_plane_onoff) [126.698821] Subtest sprite_plane_onoff: SKIP (0.000s) [126.718010] [128/171] (885s left) kms_psr (primary_mmap_gtt) [126.780358] Subtest primary_mmap_gtt: SKIP (0.000s) [126.801836] [129/171] (885s left) kms_setmode (basic-clone-single-crtc) [126.863993] Starting subtest: basic-clone-single-crtc [126.867264] Subtest basic-clone-single-crtc: SKIP (0.000s) [126.925340] [130/171] (884s left) i915_pm_backlight (basic-brightness) [127.012407] Subtest basic-brightness: SKIP (0.000s) [127.034690] [131/171] (884s left) i915_pm_rpm (basic-pci-d3-state) [128.400269] Starting subtest: basic-pci-d3-state [128.608966] Subtest basic-pci-d3-state: SUCCESS (0.207s) [128.852913] [132/171] (883s left) i915_pm_rpm (basic-rte) [128.923059] Starting subtest: basic-rte [130.428905] Subtest basic-rte: SUCCESS (1.502s) [130.870878] [133/171] (881s left) i915_pm_rps (basic-api) [130.936238] Starting subtest: basic-api [130.938906] Subtest basic-api: SUCCESS (0.002s) [131.002829] [134/171] (880s left) prime_self_import (basic-llseek-bad) [131.064079] Starting subtest: basic-llseek-bad [131.066319] Subtest basic-llseek-bad: SUCCESS (0.001s) [131.136310] [135/171] (880s left) prime_self_import (basic-llseek-size) [131.197971] Starting subtest: basic-llseek-size [131.200132] Subtest basic-llseek-size: SUCCESS (0.002s) [131.269713] [136/171] (880s left) prime_self_import (basic-with_fd_dup) [131.329450] Starting subtest: basic-with_fd_dup [131.333017] Subtest basic-with_fd_dup: SUCCESS (0.002s) [131.404058] [137/171] (880s left) prime_self_import (basic-with_one_bo) [131.464865] Starting subtest: basic-with_one_bo [131.467047] Subtest basic-with_one_bo: SUCCESS (0.002s) [131.516097] [138/171] (880s left) prime_self_import (basic-with_one_bo_two_files) [131.576903] Starting subtest: basic-with_one_bo_two_files [131.579160] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [131.653521] [139/171] (880s left) prime_self_import (basic-with_two_bos) [131.713864] Starting subtest: basic-with_two_bos [131.715942] Subtest basic-with_two_bos: SUCCESS (0.002s) [131.786174] [140/171] (880s left) prime_vgem (basic-fence-flip) [131.858965] Starting subtest: basic-fence-flip [132.188381] Subtest basic-fence-flip: SUCCESS (0.329s) [132.274298] [141/171] (879s left) prime_vgem (basic-fence-mmap) [132.358972] Starting subtest: basic-fence-mmap [132.380967] Subtest basic-fence-mmap: SUCCESS (0.022s) [132.453643] [142/171] (879s left) prime_vgem (basic-fence-read) [132.525195] Starting subtest: basic-fence-read [132.558206] Subtest basic-fence-read: SUCCESS (0.033s) [132.619645] [143/171] (879s left) prime_vgem (basic-gtt) [132.691974] Starting subtest: basic-gtt [132.702951] Subtest basic-gtt: SUCCESS (0.011s) [132.789765] [144/171] (879s left) prime_vgem (basic-read) [132.859338] Starting subtest: basic-read [132.875175] Subtest basic-read: SUCCESS (0.016s) [132.956436] [145/171] (879s left) prime_vgem (basic-write) [133.025237] Starting subtest: basic-write [133.042408] Subtest basic-write: SUCCESS (0.018s) [133.119360] [146/171] (878s left) vgem_basic (setversion) [133.189213] Starting subtest: setversion [133.191776] Subtest setversion: SUCCESS (0.000s) [133.237200] [147/171] (878s left) vgem_basic (create) [133.305842] Starting subtest: create [133.307051] Subtest create: SUCCESS (0.000s) [133.353453] [148/171] (878s left) vgem_basic (debugfs) [133.422654] Starting subtest: debugfs [133.423776] Subtest debugfs: SUCCESS (0.000s) [133.469486] [149/171] (878s left) vgem_basic (dmabuf-export) [133.539339] Starting subtest: dmabuf-export [133.541547] Subtest dmabuf-export: SUCCESS (0.002s) [133.602516] [150/171] (878s left) vgem_basic (dmabuf-fence) [133.672761] Starting subtest: dmabuf-fence [133.673844] Subtest dmabuf-fence: SUCCESS (0.001s) [133.719620] [151/171] (878s left) vgem_basic (dmabuf-fence-before) [133.789540] Starting subtest: dmabuf-fence-before [133.790634] Subtest dmabuf-fence-before: SUCCESS (0.000s) [133.838566] [152/171] (878s left) vgem_basic (dmabuf-mmap) [133.905769] Starting subtest: dmabuf-mmap [133.919910] Subtest dmabuf-mmap: SUCCESS (0.015s) [133.972607] [153/171] (878s left) vgem_basic (mmap) [134.038927] Starting subtest: mmap [134.048970] Subtest mmap: SUCCESS (0.011s) [134.089245] [154/171] (878s left) vgem_basic (second-client) [134.156230] Starting subtest: second-client [134.189968] Subtest second-client: SUCCESS (0.033s) [134.237523] [155/171] (877s left) vgem_basic (sysfs) [134.306113] Starting subtest: sysfs [134.307227] Subtest sysfs: SUCCESS (0.001s) [134.352668] [156/171] (877s left) core_hotunplug (unbind-rebind) [134.455675] Starting subtest: unbind-rebind [135.362144] Subtest unbind-rebind: SUCCESS (0.907s) [135.381955] [157/171] (876s left) vgem_basic (unload) [135.449308] Starting subtest: unload [164.317450] Subtest unload: SUCCESS (28.866s) [164.404267] [158/171] (847s left) i915_module_load (reload) [164.470364] Starting subtest: reload [166.357278] Subtest reload: SUCCESS (1.887s) [166.379960] [159/171] (845s left) gem_lmem_swapping (basic) [166.491435] Subtest basic: SKIP (0.000s) [166.515810] [160/171] (845s left) gem_lmem_swapping (parallel-random-engines) [166.580597] Subtest parallel-random-engines: SKIP (0.000s) [166.599307] [161/171] (845s left) gem_lmem_swapping (random-engines) [166.664500] Subtest random-engines: SKIP (0.000s) [166.683553] [162/171] (845s left) gem_lmem_swapping (verify-random) [166.749516] Subtest verify-random: SKIP (0.000s) [166.784124] [163/171] (845s left) i915_pm_rpm (module-reload) [168.698862] Starting subtest: module-reload [175.578098] Subtest module-reload: SUCCESS (6.879s) [175.592930] [164/171] (836s left) i915_selftest (live) [175.662259] Starting subtest: live [175.663490] Starting dynamic subtest: sanitycheck [176.219318] Dynamic subtest sanitycheck: SUCCESS (0.556s) [176.225345] Starting dynamic subtest: uncore [176.762196] Dynamic subtest uncore: SUCCESS (0.541s) [176.768365] Starting dynamic subtest: workarounds [177.443734] Dynamic subtest workarounds: SUCCESS (0.680s) [177.450232] Starting dynamic subtest: gt_engines [178.156630] Dynamic subtest gt_engines: SUCCESS (0.711s) [178.164426] Starting dynamic subtest: gt_timelines [183.935248] Dynamic subtest gt_timelines: SUCCESS (5.776s) [183.941503] Starting dynamic subtest: gt_contexts [184.603594] Dynamic subtest gt_contexts: SUCCESS (0.666s) [184.612684] Starting dynamic subtest: gt_lrc [185.319269] Dynamic subtest gt_lrc: SUCCESS (0.714s) [185.325209] Starting dynamic subtest: gt_mocs [186.044739] Dynamic subtest gt_mocs: SUCCESS (0.724s) [186.050738] Starting dynamic subtest: gt_pm [196.252844] Dynamic subtest gt_pm: SUCCESS (10.207s) [196.258284] Starting dynamic subtest: gt_heartbeat [196.951242] Dynamic subtest gt_heartbeat: SUCCESS (0.696s) [196.957684] Starting dynamic subtest: gt_tlb [197.594873] Dynamic subtest gt_tlb: SUCCESS (0.642s) [197.601183] Starting dynamic subtest: requests [203.943649] Dynamic subtest requests: SUCCESS (6.347s) [203.949366] Starting dynamic subtest: migrate [204.475926] Dynamic subtest migrate: SUCCESS (0.531s) [204.481318] Starting dynamic subtest: active [205.015912] Dynamic subtest active: SUCCESS (0.538s) [205.021916] Starting dynamic subtest: objects [206.055712] Dynamic subtest objects: SUCCESS (1.038s) [206.061487] Starting dynamic subtest: mman [210.189637] Dynamic subtest mman: SUCCESS (4.132s) [210.196859] Starting dynamic subtest: dmabuf [210.904705] Dynamic subtest dmabuf: SUCCESS (0.712s) [210.910482] Starting dynamic subtest: vma [211.626093] Dynamic subtest vma: SUCCESS (0.720s) [211.632457] Starting dynamic subtest: coherency [212.804282] Dynamic subtest coherency: SUCCESS (1.177s) [212.811303] Starting dynamic subtest: gtt [216.860787] Dynamic subtest gtt: SUCCESS (4.055s) [216.866864] Starting dynamic subtest: gem [217.735493] Dynamic subtest gem: SUCCESS (0.873s) [217.741352] Starting dynamic subtest: evict [218.292955] Dynamic subtest evict: SUCCESS (0.556s) [218.298409] Starting dynamic subtest: hugepages [219.413677] Dynamic subtest hugepages: SUCCESS (1.119s) [219.419366] Starting dynamic subtest: gem_contexts [224.260658] Dynamic subtest gem_contexts: SUCCESS (4.845s) [224.266874] Starting dynamic subtest: client [225.017762] Dynamic subtest client: SUCCESS (0.755s) [225.023203] Starting dynamic subtest: gem_migrate [225.584941] Dynamic subtest gem_migrate: SUCCESS (0.566s) [225.590755] Starting dynamic subtest: reset [227.354406] Dynamic subtest reset: SUCCESS (1.767s) [227.362256] Starting dynamic subtest: memory_region [228.020591] Dynamic subtest memory_region: SUCCESS (0.664s) [228.026937] Starting dynamic subtest: hangcheck [245.361020] Dynamic subtest hangcheck: SUCCESS (17.339s) [245.366730] Starting dynamic subtest: execlists [246.057098] Dynamic subtest execlists: SUCCESS (0.695s) [246.062787] Starting dynamic subtest: ring_submission [246.618079] Dynamic subtest ring_submission: SUCCESS (0.560s) [246.624316] Starting dynamic subtest: perf [247.367671] Dynamic subtest perf: SUCCESS (0.748s) [247.373906] Starting dynamic subtest: slpc [248.072413] Dynamic subtest slpc: SUCCESS (0.703s) [248.078111] Starting dynamic subtest: guc [248.711585] Dynamic subtest guc: SUCCESS (0.637s) [248.718895] Starting dynamic subtest: guc_multi_lrc [249.411580] Dynamic subtest guc_multi_lrc: SUCCESS (0.698s) [249.420128] Starting dynamic subtest: guc_hang [250.038046] Dynamic subtest guc_hang: SUCCESS (0.624s) [250.044170] Starting dynamic subtest: late_gt_pm [250.566336] Dynamic subtest late_gt_pm: SUCCESS (0.526s) [250.567490] Subtest live: SUCCESS (74.904s) [250.715805] [165/171] (761s left) dmabuf (all-tests) [250.782465] Starting subtest: all-tests [250.785868] Starting dynamic subtest: sanitycheck [250.845239] Dynamic subtest sanitycheck: SUCCESS (0.061s) [250.854548] Starting dynamic subtest: dma_fence [251.027543] Dynamic subtest dma_fence: SUCCESS (0.180s) [251.033591] Starting dynamic subtest: dma_fence_chain [262.233765] Dynamic subtest dma_fence_chain: SUCCESS (11.205s) [262.240094] Starting dynamic subtest: dma_fence_unwrap [262.301142] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [262.307214] Starting dynamic subtest: dma_resv [262.373467] Dynamic subtest dma_resv: SUCCESS (0.070s) [262.375150] Subtest all-tests: SUCCESS (11.591s) [262.388988] [166/171] (750s left) i915_suspend (basic-s2idle-without-i915) [262.450720] Starting subtest: basic-s2idle-without-i915 [279.789492] Subtest basic-s2idle-without-i915: SUCCESS (2.066s) [285.926632] [167/171] (747s left) i915_suspend (basic-s3-without-i915) [285.993608] Starting subtest: basic-s3-without-i915 [306.842296] Subtest basic-s3-without-i915: SUCCESS (4.008s) [306.954176] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1635 [max: 8192] direct dependencies: 16510 [max: 32768] indirect dependencies: 105142 all direct dependencies: 277542 dependency chains: 23442 [max: 131072] dependency chain hlocks used: 97636 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 145 in-softirq chains: 621 in-process chains: 22676 stack-trace entries: 233301 [max: 1048576] number of stack traces: 10997 number of stack hash chains: 8039 combined max dependencies: 2059343724 hardirq-safe locks: 73 hardirq-unsafe locks: 974 softirq-safe locks: 177 softirq-unsafe locks: 888 irq-safe locks: 195 irq-unsafe locks: 974 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 295 softirq-read-safe locks: 7 softirq-read-unsafe locks: 290 irq-read-safe locks: 7 irq-read-unsafe locks: 295 uncategorized locks: 280 unused locks: 1 max locking depth: 16 max bfs queue depth: 386 max lock class index: 1728 chain lookup misses: 61942 chain lookup hits: 395366300 cyclic checks: 61490 redundant checks: 0 redundant links: 0 find-mask forwards checks: 11408 find-mask backwards checks: 8564 hardirq on events: 247057820 hardirq off events: 247057815 redundant hardirq ons: 60 redundant hardirq offs: 26 softirq on events: 2054167 softirq off events: 2054167 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 4601 zapped lock chains: 38353 large chain blocks: 1 [306.955271] Closing watchdogs Done.