[51.497905] Initializing watchdogs [51.497964] /dev/watchdog0 [51.502761] [001/170] (960s left) i915_module_load (load) [51.553963] Starting subtest: load [52.469905] Subtest load: SUCCESS (0.916s) [52.486263] [002/170] (959s left) core_auth (basic-auth) [52.586013] Starting subtest: basic-auth [52.587314] Subtest basic-auth: SUCCESS (0.002s) [52.627830] [003/170] (959s left) debugfs_test (read_all_entries) [52.677772] Starting subtest: read_all_entries [52.720039] Subtest read_all_entries: SUCCESS (0.042s) [52.798294] [004/170] (959s left) debugfs_test (basic-hwmon) [52.851797] Starting subtest: basic-hwmon [52.853760] Subtest basic-hwmon: SKIP (0.000s) [52.940770] [005/170] (959s left) fbdev (eof) [53.003537] Starting subtest: eof [53.004641] Subtest eof: SUCCESS (0.000s) [53.035986] [006/170] (959s left) fbdev (info) [53.111680] Starting subtest: info [53.112695] Subtest info: SUCCESS (0.000s) [53.148711] [007/170] (958s left) fbdev (nullptr) [53.203295] Starting subtest: nullptr [53.204326] Subtest nullptr: SUCCESS (0.000s) [53.231362] [008/170] (958s left) fbdev (read) [53.286705] Starting subtest: read [53.936750] Subtest read: SUCCESS (0.649s) [53.965117] [009/170] (958s left) fbdev (write) [54.019984] Starting subtest: write [54.458061] Subtest write: SUCCESS (0.437s) [54.489653] [010/170] (957s left) gem_basic (bad-close) [54.537834] Starting subtest: bad-close [54.541070] Subtest bad-close: SUCCESS (0.000s) [54.577179] [011/170] (957s left) gem_basic (create-close) [54.627287] Starting subtest: create-close [54.629176] Subtest create-close: SUCCESS (0.000s) [54.685713] [012/170] (957s left) gem_basic (create-fd-close) [54.733732] Starting subtest: create-fd-close [54.735719] Subtest create-fd-close: SUCCESS (0.000s) [54.774673] [013/170] (957s left) gem_busy (busy@all-engines) [54.830942] Starting subtest: busy [54.832026] Starting dynamic subtest: all-engines [54.855650] Dynamic subtest all-engines: SUCCESS (0.025s) [54.856624] Subtest busy: SUCCESS (0.025s) [55.172601] [014/170] (956s left) gem_close_race (basic-process) [55.227962] Starting subtest: basic-process [55.274319] Subtest basic-process: SUCCESS (0.045s) [55.431247] [015/170] (956s left) gem_close_race (basic-threads) [55.494143] Starting subtest: basic-threads [56.631192] Subtest basic-threads: SUCCESS (1.137s) [56.788946] [016/170] (955s left) gem_ctx_create (basic) [56.852446] Starting subtest: basic [56.853527] Subtest basic: SUCCESS (0.000s) [57.006520] [017/170] (955s left) gem_ctx_create (basic-files) [57.065260] Starting subtest: basic-files [59.075555] Subtest basic-files: SUCCESS (2.010s) [59.236910] [018/170] (952s left) gem_ctx_exec (basic) [59.295647] Starting subtest: basic [59.296816] Subtest basic: SUCCESS (0.002s) [59.376707] [019/170] (952s left) gem_exec_basic (basic) [59.429806] Starting subtest: basic [59.430974] Starting dynamic subtest: rcs0-smem [59.432076] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [59.436216] Starting dynamic subtest: bcs0-smem [59.437950] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [59.442112] Starting dynamic subtest: vcs0-smem [59.443851] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [59.447977] Starting dynamic subtest: vecs0-smem [59.449834] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [59.451579] Subtest basic: SUCCESS (0.003s) [59.590233] [020/170] (952s left) gem_exec_create (basic) [59.650446] Starting subtest: basic [59.651567] Starting dynamic subtest: smem [61.696357] Dynamic subtest smem: SUCCESS (2.046s) [61.697433] Subtest basic: SUCCESS (2.046s) [61.849249] [021/170] (950s left) gem_exec_fence (basic-busy) [62.034171] Starting subtest: basic-busy [62.036173] Starting dynamic subtest: rcs0 [62.060317] Dynamic subtest rcs0: SUCCESS (0.027s) [62.069339] Starting dynamic subtest: bcs0 [62.082672] Dynamic subtest bcs0: SUCCESS (0.023s) [62.090996] Starting dynamic subtest: vcs0 [62.105037] Dynamic subtest vcs0: SUCCESS (0.022s) [62.112929] Starting dynamic subtest: vecs0 [62.134135] Dynamic subtest vecs0: SUCCESS (0.029s) [62.135750] Subtest basic-busy: SUCCESS (0.101s) [62.582356] [022/170] (949s left) gem_exec_fence (basic-wait) [62.766730] Starting subtest: basic-wait [62.768737] Starting dynamic subtest: rcs0 [62.785860] Dynamic subtest rcs0: SUCCESS (0.020s) [62.795732] Starting dynamic subtest: bcs0 [62.806677] Dynamic subtest bcs0: SUCCESS (0.021s) [62.815098] Starting dynamic subtest: vcs0 [62.843764] Dynamic subtest vcs0: SUCCESS (0.036s) [62.853279] Starting dynamic subtest: vecs0 [62.867635] Dynamic subtest vecs0: SUCCESS (0.024s) [62.869949] Subtest basic-wait: SUCCESS (0.101s) [63.291780] [023/170] (948s left) gem_exec_fence (basic-await) [63.469191] Starting subtest: basic-await [63.470955] Starting dynamic subtest: rcs0 [63.547364] Dynamic subtest rcs0: SUCCESS (0.078s) [63.557454] Starting dynamic subtest: bcs0 [63.630136] Dynamic subtest bcs0: SUCCESS (0.083s) [63.640094] Starting dynamic subtest: vcs0 [63.712421] Dynamic subtest vcs0: SUCCESS (0.082s) [63.721183] Starting dynamic subtest: vecs0 [63.803433] Dynamic subtest vecs0: SUCCESS (0.091s) [63.805099] Subtest basic-await: SUCCESS (0.335s) [64.232520] [024/170] (948s left) gem_exec_fence (nb-await) [64.417557] Starting subtest: nb-await [64.419169] Starting dynamic subtest: rcs0 [64.478065] Dynamic subtest rcs0: SUCCESS (0.060s) [64.486630] Starting dynamic subtest: bcs0 [64.538079] Dynamic subtest bcs0: SUCCESS (0.061s) [64.546856] Starting dynamic subtest: vcs0 [64.598211] Dynamic subtest vcs0: SUCCESS (0.060s) [64.609717] Starting dynamic subtest: vecs0 [64.661661] Dynamic subtest vecs0: SUCCESS (0.064s) [64.663163] Subtest nb-await: SUCCESS (0.245s) [65.091875] [025/170] (947s left) gem_exec_gttfill (basic) [65.152622] Starting subtest: basic [68.774917] Subtest basic: SUCCESS (3.621s) [68.922457] [026/170] (943s left) gem_exec_parallel (engines) [69.037443] Starting subtest: engines [69.038605] Starting dynamic subtest: basic [70.517271] Dynamic subtest basic: SUCCESS (1.480s) [70.521813] Starting dynamic subtest: contexts [72.668862] Dynamic subtest contexts: SUCCESS (2.151s) [72.673240] Starting dynamic subtest: fds [75.161340] Dynamic subtest fds: SUCCESS (2.492s) [75.165572] Starting dynamic subtest: userptr [76.732184] Dynamic subtest userptr: SUCCESS (1.571s) [76.733327] Subtest engines: SUCCESS (7.695s) [76.883883] [027/170] (935s left) gem_exec_store (basic) [76.943911] Starting subtest: basic [76.988958] Subtest basic: SUCCESS (0.045s) [77.145150] [028/170] (935s left) gem_flink_basic (bad-flink) [77.199295] Starting subtest: bad-flink [77.200394] Subtest bad-flink: SUCCESS (0.000s) [77.236843] [029/170] (935s left) gem_flink_basic (bad-open) [77.285905] Starting subtest: bad-open [77.287042] Subtest bad-open: SUCCESS (0.000s) [77.319743] [030/170] (935s left) gem_flink_basic (basic) [77.369573] Starting subtest: basic [77.370598] Subtest basic: SUCCESS (0.000s) [77.431094] [031/170] (934s left) gem_flink_basic (double-flink) [77.482829] Starting subtest: double-flink [77.484578] Subtest double-flink: SUCCESS (0.000s) [77.533989] [032/170] (934s left) gem_flink_basic (flink-lifetime) [77.586566] Starting subtest: flink-lifetime [77.587736] Subtest flink-lifetime: SUCCESS (0.001s) [77.640557] [033/170] (934s left) gem_huc_copy (huc-copy) [77.688555] Starting subtest: huc-copy [77.690711] Subtest huc-copy: SKIP (0.000s) [77.759029] [034/170] (934s left) gem_linear_blits (basic) [77.863291] Starting subtest: basic [77.867816] Subtest basic: SUCCESS (0.005s) [77.975987] [035/170] (934s left) gem_mmap (basic) [78.093441] Starting subtest: basic [78.098497] Subtest basic: SUCCESS (0.000s) [78.149047] [036/170] (934s left) gem_mmap_gtt (basic) [78.204681] Starting subtest: basic [78.205752] Subtest basic: SUCCESS (0.000s) [78.229409] [037/170] (934s left) gem_render_linear_blits (basic) [78.277310] Starting subtest: basic [78.295352] Subtest basic: SUCCESS (0.018s) [78.320350] [038/170] (934s left) gem_render_tiled_blits (basic) [78.371354] Starting subtest: basic [78.391258] Subtest basic: SUCCESS (0.021s) [78.421025] [039/170] (934s left) gem_ringfill (basic-all) [78.580578] Starting subtest: basic-all [79.692983] Subtest basic-all: SUCCESS (1.115s) [79.768557] [040/170] (932s left) gem_softpin (allocator-basic) [79.845601] Starting subtest: allocator-basic [79.900442] Subtest allocator-basic: SUCCESS (0.055s) [79.974834] [041/170] (932s left) gem_softpin (allocator-basic-reserve) [80.029677] Starting subtest: allocator-basic-reserve [80.088534] Subtest allocator-basic-reserve: SUCCESS (0.058s) [80.157304] [042/170] (932s left) gem_softpin (safe-alignment) [80.210751] Starting subtest: safe-alignment [80.217416] Subtest safe-alignment: SUCCESS (0.007s) [80.293461] [043/170] (932s left) gem_sync (basic-all) [80.357623] Starting subtest: basic-all [82.592792] Subtest basic-all: SUCCESS (2.240s) [82.742269] [044/170] (929s left) gem_sync (basic-each) [82.805757] Starting subtest: basic-each [84.906492] Subtest basic-each: SUCCESS (2.104s) [85.069450] [045/170] (927s left) gem_tiled_blits (basic) [85.193880] Starting subtest: basic [85.205905] Subtest basic: SUCCESS (0.012s) [85.301646] [046/170] (927s left) gem_tiled_fence_blits (basic) [85.482017] Starting subtest: basic [85.502918] Subtest basic: SUCCESS (0.021s) [85.600222] [047/170] (926s left) gem_tiled_pread_basic [85.831812] [048/170] (926s left) gem_wait (busy@all-engines) [85.892440] Starting subtest: busy [85.893609] Starting dynamic subtest: all-engines [86.411505] Dynamic subtest all-engines: SUCCESS (0.519s) [86.412735] Subtest busy: SUCCESS (0.519s) [86.586708] [049/170] (926s left) gem_wait (wait@all-engines) [86.651477] Starting subtest: wait [86.652607] Starting dynamic subtest: all-engines [87.675184] Dynamic subtest all-engines: SUCCESS (1.023s) [87.676963] Subtest wait: SUCCESS (1.023s) [87.842286] [050/170] (924s left) i915_getparams_basic (basic-eu-total) [87.893632] Starting subtest: basic-eu-total [87.895762] Subtest basic-eu-total: SUCCESS (0.000s) [87.930014] [051/170] (924s left) i915_getparams_basic (basic-subslice-total) [87.979602] Starting subtest: basic-subslice-total [87.981679] Subtest basic-subslice-total: SUCCESS (0.000s) [88.012919] [052/170] (924s left) i915_hangman (error-state-basic) [88.066525] Starting subtest: error-state-basic [88.071903] Subtest error-state-basic: SUCCESS (0.005s) [88.136871] [053/170] (924s left) i915_pciid [88.221541] [054/170] (924s left) kms_addfb_basic (addfb25-bad-modifier) [88.270767] Starting subtest: addfb25-bad-modifier [88.272056] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [88.381022] [055/170] (924s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [88.428663] Starting subtest: addfb25-framebuffer-vs-set-tiling [88.429797] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [88.522657] [056/170] (924s left) kms_addfb_basic (addfb25-modifier-no-flag) [88.572907] Starting subtest: addfb25-modifier-no-flag [88.574054] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [88.672615] [057/170] (924s left) kms_addfb_basic (addfb25-x-tiled-legacy) [88.722443] Starting subtest: addfb25-x-tiled-legacy [88.723557] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [88.822893] [058/170] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [88.873131] Starting subtest: addfb25-x-tiled-mismatch-legacy [88.874215] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [88.984417] [059/170] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [89.080890] Starting subtest: addfb25-yf-tiled-legacy [89.082047] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [89.131017] [060/170] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy) [89.230310] Starting subtest: addfb25-y-tiled-legacy [89.231424] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [89.272866] [061/170] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [89.370217] Starting subtest: addfb25-y-tiled-small-legacy [89.371230] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [89.430888] [062/170] (923s left) kms_addfb_basic (bad-pitch-0) [89.481591] Starting subtest: bad-pitch-0 [89.482720] Subtest bad-pitch-0: SUCCESS (0.000s) [89.575932] [063/170] (923s left) kms_addfb_basic (bad-pitch-1024) [89.623953] Starting subtest: bad-pitch-1024 [89.625072] Subtest bad-pitch-1024: SUCCESS (0.000s) [89.731083] [064/170] (923s left) kms_addfb_basic (bad-pitch-128) [89.781070] Starting subtest: bad-pitch-128 [89.782149] Subtest bad-pitch-128: SUCCESS (0.000s) [89.880877] [065/170] (922s left) kms_addfb_basic (bad-pitch-256) [89.930636] Starting subtest: bad-pitch-256 [89.931716] Subtest bad-pitch-256: SUCCESS (0.000s) [90.042840] [066/170] (922s left) kms_addfb_basic (bad-pitch-32) [90.093659] Starting subtest: bad-pitch-32 [90.095362] Subtest bad-pitch-32: SUCCESS (0.000s) [90.196478] [067/170] (922s left) kms_addfb_basic (bad-pitch-63) [90.244686] Starting subtest: bad-pitch-63 [90.245833] Subtest bad-pitch-63: SUCCESS (0.000s) [90.330096] [068/170] (922s left) kms_addfb_basic (bad-pitch-65536) [90.377310] Starting subtest: bad-pitch-65536 [90.378457] Subtest bad-pitch-65536: SUCCESS (0.000s) [90.475784] [069/170] (922s left) kms_addfb_basic (bad-pitch-999) [90.523482] Starting subtest: bad-pitch-999 [90.524568] Subtest bad-pitch-999: SUCCESS (0.000s) [90.630692] [070/170] (922s left) kms_addfb_basic (basic) [90.679810] Starting subtest: basic [90.681057] Subtest basic: SUCCESS (0.000s) [90.773251] [071/170] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [90.823466] Starting subtest: basic-x-tiled-legacy [90.824630] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [90.938036] [072/170] (921s left) kms_addfb_basic (basic-y-tiled-legacy) [90.985402] Starting subtest: basic-y-tiled-legacy [90.986537] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [91.096553] [073/170] (921s left) kms_addfb_basic (bo-too-small) [91.198262] Starting subtest: bo-too-small [91.199939] Subtest bo-too-small: SUCCESS (0.000s) [91.247631] [074/170] (921s left) kms_addfb_basic (bo-too-small-due-to-tiling) [91.347260] Starting subtest: bo-too-small-due-to-tiling [91.348295] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [91.392655] [075/170] (921s left) kms_addfb_basic (clobberred-modifier) [91.440452] Starting subtest: clobberred-modifier [91.441596] Subtest clobberred-modifier: SUCCESS (0.000s) [91.539690] [076/170] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling) [91.590191] Starting subtest: framebuffer-vs-set-tiling [91.591228] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [91.688158] [077/170] (921s left) kms_addfb_basic (invalid-get-prop) [91.735692] Starting subtest: invalid-get-prop [91.736854] Subtest invalid-get-prop: SUCCESS (0.000s) [91.846816] [078/170] (921s left) kms_addfb_basic (invalid-get-prop-any) [91.894123] Starting subtest: invalid-get-prop-any [91.895244] Subtest invalid-get-prop-any: SUCCESS (0.000s) [91.998182] [079/170] (920s left) kms_addfb_basic (invalid-set-prop) [92.048866] Starting subtest: invalid-set-prop [92.050199] Subtest invalid-set-prop: SUCCESS (0.000s) [92.156351] [080/170] (920s left) kms_addfb_basic (invalid-set-prop-any) [92.206544] Starting subtest: invalid-set-prop-any [92.207641] Subtest invalid-set-prop-any: SUCCESS (0.000s) [92.315805] [081/170] (920s left) kms_addfb_basic (no-handle) [92.363328] Starting subtest: no-handle [92.365008] Subtest no-handle: SUCCESS (0.000s) [92.468066] [082/170] (920s left) kms_addfb_basic (size-max) [92.570194] Starting subtest: size-max [92.571232] Subtest size-max: SUCCESS (0.000s) [92.623135] [083/170] (920s left) kms_addfb_basic (small-bo) [92.725102] Starting subtest: small-bo [92.726310] Subtest small-bo: SUCCESS (0.000s) [92.784669] [084/170] (920s left) kms_addfb_basic (tile-pitch-mismatch) [92.834261] Starting subtest: tile-pitch-mismatch [92.835329] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [92.931520] [085/170] (920s left) kms_addfb_basic (too-high) [93.034029] Starting subtest: too-high [93.035125] Subtest too-high: SUCCESS (0.001s) [93.093060] [086/170] (919s left) kms_addfb_basic (too-wide) [93.190184] Starting subtest: too-wide [93.191251] Subtest too-wide: SUCCESS (0.000s) [93.251519] [087/170] (919s left) kms_addfb_basic (unused-handle) [93.298881] Starting subtest: unused-handle [93.300026] Subtest unused-handle: SUCCESS (0.000s) [93.409543] [088/170] (919s left) kms_addfb_basic (unused-modifier) [93.459921] Starting subtest: unused-modifier [93.461125] Subtest unused-modifier: SUCCESS (0.000s) [93.564931] [089/170] (919s left) kms_addfb_basic (unused-offsets) [93.615831] Starting subtest: unused-offsets [93.617482] Subtest unused-offsets: SUCCESS (0.000s) [93.706661] [090/170] (919s left) kms_addfb_basic (unused-pitches) [93.757809] Starting subtest: unused-pitches [93.758925] Subtest unused-pitches: SUCCESS (0.000s) [93.868054] [091/170] (919s left) kms_busy (basic) [93.967190] Starting subtest: basic [93.968271] Starting dynamic subtest: flip [94.398009] Dynamic subtest flip: SUCCESS (0.424s) [94.403596] Starting dynamic subtest: modeset [94.922913] Dynamic subtest modeset: SUCCESS (0.530s) [94.924055] Subtest basic: SUCCESS (0.956s) [95.024983] [092/170] (918s left) kms_chamelium_hpd (dp-hpd-fast) [95.175780] Subtest dp-hpd-fast: SKIP (0.000s) [95.241800] [093/170] (917s left) kms_chamelium_edid (dp-edid-read) [95.401382] Subtest dp-edid-read: SKIP (0.000s) [95.465900] [094/170] (917s left) kms_chamelium_frames (dp-crc-fast) [95.621244] Subtest dp-crc-fast: SKIP (0.000s) [95.679141] [095/170] (917s left) kms_chamelium_hpd (hdmi-hpd-fast) [95.832263] Subtest hdmi-hpd-fast: SKIP (0.000s) [95.891143] [096/170] (917s left) kms_chamelium_edid (hdmi-edid-read) [96.043741] Subtest hdmi-edid-read: SKIP (0.000s) [96.113638] [097/170] (917s left) kms_chamelium_frames (hdmi-crc-fast) [96.267969] Subtest hdmi-crc-fast: SKIP (0.000s) [96.337542] [098/170] (916s left) kms_chamelium_hpd (vga-hpd-fast) [96.488455] Subtest vga-hpd-fast: SKIP (0.000s) [96.551269] [099/170] (916s left) kms_chamelium_edid (vga-edid-read) [96.706439] Subtest vga-edid-read: SKIP (0.000s) [96.771108] [100/170] (916s left) kms_prop_blob (basic) [96.841402] Starting subtest: basic [96.842436] Subtest basic: SUCCESS (0.000s) [96.879803] [101/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [96.976837] Starting subtest: basic-busy-flip-before-cursor-atomic [96.979061] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [97.017387] [102/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [97.115156] Starting subtest: basic-busy-flip-before-cursor-legacy [97.117278] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [97.151669] [103/170] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [97.249864] Starting subtest: basic-flip-after-cursor-atomic [97.771623] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.520s) [97.865376] [104/170] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [97.977204] Starting subtest: basic-flip-after-cursor-legacy [98.526223] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.550s) [98.629691] [105/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [98.734333] Starting subtest: basic-flip-after-cursor-varying-size [99.241969] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.505s) [99.341540] [106/170] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [99.448671] Starting subtest: basic-flip-before-cursor-atomic [99.965118] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.515s) [100.068659] [107/170] (913s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [100.175432] Starting subtest: basic-flip-before-cursor-legacy [100.711175] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.535s) [100.811818] [108/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [100.916431] Starting subtest: basic-flip-before-cursor-varying-size [101.436358] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.519s) [101.535414] [109/170] (911s left) kms_flip (basic-flip-vs-dpms) [101.628981] Starting subtest: basic-flip-vs-dpms [101.632992] Starting dynamic subtest: A-HDMI-A1 [102.363654] Dynamic subtest A-HDMI-A1: SUCCESS (0.730s) [102.369129] Starting dynamic subtest: B-HDMI-A1 [102.992788] Dynamic subtest B-HDMI-A1: SUCCESS (0.625s) [102.998996] Starting dynamic subtest: C-HDMI-A1 [103.675450] Dynamic subtest C-HDMI-A1: SUCCESS (0.685s) [103.684969] Starting dynamic subtest: D-HDMI-A1 [104.292312] Dynamic subtest D-HDMI-A1: SUCCESS (0.616s) [104.296125] Subtest basic-flip-vs-dpms: SUCCESS (2.667s) [104.389443] [110/170] (908s left) kms_flip (basic-flip-vs-modeset) [104.503386] Starting subtest: basic-flip-vs-modeset [104.506563] Starting dynamic subtest: A-HDMI-A1 [105.190631] Dynamic subtest A-HDMI-A1: SUCCESS (0.683s) [105.197971] Starting dynamic subtest: B-HDMI-A1 [105.827555] Dynamic subtest B-HDMI-A1: SUCCESS (0.637s) [105.832035] Starting dynamic subtest: C-HDMI-A1 [106.482779] Dynamic subtest C-HDMI-A1: SUCCESS (0.655s) [106.487952] Starting dynamic subtest: D-HDMI-A1 [107.114229] Dynamic subtest D-HDMI-A1: SUCCESS (0.630s) [107.117862] Subtest basic-flip-vs-modeset: SUCCESS (2.614s) [107.211405] [111/170] (906s left) kms_flip (basic-flip-vs-wf_vblank) [107.304718] Starting subtest: basic-flip-vs-wf_vblank [107.306603] Starting dynamic subtest: A-HDMI-A1 [108.134305] Dynamic subtest A-HDMI-A1: SUCCESS (0.828s) [108.138790] Starting dynamic subtest: B-HDMI-A1 [108.930782] Dynamic subtest B-HDMI-A1: SUCCESS (0.795s) [108.936907] Starting dynamic subtest: C-HDMI-A1 [109.717859] Dynamic subtest C-HDMI-A1: SUCCESS (0.787s) [109.725434] Starting dynamic subtest: D-HDMI-A1 [110.501663] Dynamic subtest D-HDMI-A1: SUCCESS (0.783s) [110.503872] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.201s) [110.623700] [112/170] (902s left) kms_flip (basic-plain-flip) [110.706232] Starting subtest: basic-plain-flip [110.709237] Starting dynamic subtest: A-HDMI-A1 [111.389466] Dynamic subtest A-HDMI-A1: SUCCESS (0.680s) [111.398206] Starting dynamic subtest: B-HDMI-A1 [112.035835] Dynamic subtest B-HDMI-A1: SUCCESS (0.645s) [112.041398] Starting dynamic subtest: C-HDMI-A1 [112.682443] Dynamic subtest C-HDMI-A1: SUCCESS (0.646s) [112.686987] Starting dynamic subtest: D-HDMI-A1 [113.328911] Dynamic subtest D-HDMI-A1: SUCCESS (0.645s) [113.330958] Subtest basic-plain-flip: SUCCESS (2.626s) [113.441708] [113/170] (899s left) kms_force_connector_basic (force-connector-state) [113.584235] Starting subtest: force-connector-state [113.959170] Subtest force-connector-state: SUCCESS (0.375s) [114.274372] [114/170] (899s left) kms_force_connector_basic (force-edid) [114.416311] Starting subtest: force-edid [114.564403] Subtest force-edid: SUCCESS (0.148s) [114.724533] [115/170] (898s left) kms_force_connector_basic (force-load-detect) [114.866295] Starting subtest: force-load-detect [114.868866] Subtest force-load-detect: SKIP (0.000s) [115.025394] [116/170] (898s left) kms_force_connector_basic (prune-stale-modes) [115.166371] Starting subtest: prune-stale-modes [115.310645] Subtest prune-stale-modes: SUCCESS (0.146s) [115.474630] [117/170] (897s left) kms_frontbuffer_tracking (basic) [115.588266] Starting subtest: basic [116.951121] Subtest basic: SUCCESS (1.366s) [117.016539] [118/170] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [117.116875] Starting subtest: compare-crc-sanitycheck [117.118053] Starting dynamic subtest: pipe-A-HDMI-A-1 [117.353851] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.227s) [117.359742] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.613767] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.263s) [117.619669] Starting dynamic subtest: pipe-C-HDMI-A-1 [117.853258] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.238s) [117.863728] Starting dynamic subtest: pipe-D-HDMI-A-1 [118.073534] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.216s) [118.074600] Subtest compare-crc-sanitycheck: SUCCESS (0.956s) [118.157233] [119/170] (895s left) kms_pipe_crc_basic (hang-read-crc) [118.269952] Starting subtest: hang-read-crc [118.272394] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.890594] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.613s) [118.898198] Starting dynamic subtest: pipe-B-HDMI-A-1 [119.507488] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.615s) [119.514744] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.096139] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.582s) [120.103566] Starting dynamic subtest: pipe-D-HDMI-A-1 [121.279702] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.180s) [121.280981] Subtest hang-read-crc: SUCCESS (3.006s) [121.356718] [120/170] (892s left) kms_pipe_crc_basic (nonblocking-crc) [121.468798] Starting subtest: nonblocking-crc [121.469868] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.796101] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.326s) [121.807120] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.118325] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.318s) [122.130466] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.458379] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.333s) [122.469480] Starting dynamic subtest: pipe-D-HDMI-A-1 [123.053719] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.588s) [123.055754] Subtest nonblocking-crc: SUCCESS (1.585s) [123.139336] [121/170] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [123.247095] Starting subtest: nonblocking-crc-frame-sequence [123.248293] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.564092] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.315s) [123.572639] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.928164] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.357s) [123.935386] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.258389] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.325s) [124.266234] Starting dynamic subtest: pipe-D-HDMI-A-1 [124.846418] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.585s) [124.847994] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.600s) [124.931845] [122/170] (888s left) kms_pipe_crc_basic (read-crc) [125.040575] Starting subtest: read-crc [125.041780] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.322779] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.280s) [125.330227] Starting dynamic subtest: pipe-B-HDMI-A-1 [125.653910] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.328s) [125.662514] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.976848] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.315s) [125.986222] Starting dynamic subtest: pipe-D-HDMI-A-1 [126.522547] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.542s) [126.524015] Subtest read-crc: SUCCESS (1.483s) [126.608563] [123/170] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [126.727707] Starting subtest: read-crc-frame-sequence [126.730609] Starting dynamic subtest: pipe-A-HDMI-A-1 [127.018871] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.285s) [127.027995] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.327678] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.307s) [127.337864] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.631463] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.300s) [127.642541] Starting dynamic subtest: pipe-D-HDMI-A-1 [128.169663] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.532s) [128.170791] Subtest read-crc-frame-sequence: SUCCESS (1.441s) [128.254317] [124/170] (885s left) kms_psr (primary_page_flip) [128.312355] Subtest primary_page_flip: SKIP (0.000s) [128.327183] [125/170] (885s left) kms_psr (cursor_plane_move) [128.381727] Subtest cursor_plane_move: SKIP (0.000s) [128.408881] [126/170] (885s left) kms_psr (sprite_plane_onoff) [128.464065] Subtest sprite_plane_onoff: SKIP (0.000s) [128.484533] [127/170] (885s left) kms_psr (primary_mmap_gtt) [128.538676] Subtest primary_mmap_gtt: SKIP (0.000s) [128.562079] [128/170] (885s left) kms_setmode (basic-clone-single-crtc) [128.646110] Starting subtest: basic-clone-single-crtc [128.649487] Subtest basic-clone-single-crtc: SKIP (0.000s) [128.685472] [129/170] (884s left) i915_pm_backlight (basic-brightness) [128.795265] Subtest basic-brightness: SKIP (0.000s) [128.818134] [130/170] (884s left) i915_pm_rpm (basic-pci-d3-state) [130.344025] Starting subtest: basic-pci-d3-state [131.308117] Subtest basic-pci-d3-state: SUCCESS (0.953s) [131.375241] [131/170] (882s left) i915_pm_rpm (basic-rte) [131.426312] Starting subtest: basic-rte [133.480879] Subtest basic-rte: SUCCESS (2.053s) [134.009236] [132/170] (879s left) i915_pm_rps (basic-api) [134.063134] Starting subtest: basic-api [134.065688] Subtest basic-api: SUCCESS (0.002s) [134.101968] [133/170] (879s left) prime_self_import (basic-llseek-bad) [134.167105] Starting subtest: basic-llseek-bad [134.168788] Subtest basic-llseek-bad: SUCCESS (0.001s) [134.219516] [134/170] (879s left) prime_self_import (basic-llseek-size) [134.268625] Starting subtest: basic-llseek-size [134.271273] Subtest basic-llseek-size: SUCCESS (0.002s) [134.329710] [135/170] (879s left) prime_self_import (basic-with_fd_dup) [134.379854] Starting subtest: basic-with_fd_dup [134.382443] Subtest basic-with_fd_dup: SUCCESS (0.002s) [134.437463] [136/170] (879s left) prime_self_import (basic-with_one_bo) [134.484513] Starting subtest: basic-with_one_bo [134.485766] Subtest basic-with_one_bo: SUCCESS (0.002s) [134.517581] [137/170] (879s left) prime_self_import (basic-with_one_bo_two_files) [134.563475] Starting subtest: basic-with_one_bo_two_files [134.564681] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [134.618511] [138/170] (879s left) prime_self_import (basic-with_two_bos) [134.667515] Starting subtest: basic-with_two_bos [134.670319] Subtest basic-with_two_bos: SUCCESS (0.002s) [134.729205] [139/170] (879s left) prime_vgem (basic-fence-flip) [134.789693] Starting subtest: basic-fence-flip [135.045979] Subtest basic-fence-flip: SUCCESS (0.255s) [135.093196] [140/170] (878s left) prime_vgem (basic-fence-mmap) [135.148454] Starting subtest: basic-fence-mmap [135.167676] Subtest basic-fence-mmap: SUCCESS (0.019s) [135.236230] [141/170] (878s left) prime_vgem (basic-fence-read) [135.300073] Starting subtest: basic-fence-read [135.336601] Subtest basic-fence-read: SUCCESS (0.036s) [135.396966] [142/170] (878s left) prime_vgem (basic-gtt) [135.456443] Starting subtest: basic-gtt [135.464607] Subtest basic-gtt: SUCCESS (0.008s) [135.522039] [143/170] (878s left) prime_vgem (basic-read) [135.581455] Starting subtest: basic-read [135.594334] Subtest basic-read: SUCCESS (0.013s) [135.650544] [144/170] (878s left) prime_vgem (basic-write) [135.722641] Starting subtest: basic-write [135.743117] Subtest basic-write: SUCCESS (0.020s) [135.787253] [145/170] (878s left) vgem_basic (setversion) [135.845477] Starting subtest: setversion [135.847546] Subtest setversion: SUCCESS (0.000s) [135.880661] [146/170] (877s left) vgem_basic (create) [135.936758] Starting subtest: create [135.937947] Subtest create: SUCCESS (0.000s) [135.969797] [147/170] (877s left) vgem_basic (debugfs) [136.028734] Starting subtest: debugfs [136.029902] Subtest debugfs: SUCCESS (0.000s) [136.064636] [148/170] (877s left) vgem_basic (dmabuf-export) [136.121889] Starting subtest: dmabuf-export [136.123094] Subtest dmabuf-export: SUCCESS (0.001s) [136.178062] [149/170] (877s left) vgem_basic (dmabuf-fence) [136.236846] Starting subtest: dmabuf-fence [136.238069] Subtest dmabuf-fence: SUCCESS (0.000s) [136.267873] [150/170] (877s left) vgem_basic (dmabuf-fence-before) [136.328551] Starting subtest: dmabuf-fence-before [136.329744] Subtest dmabuf-fence-before: SUCCESS (0.000s) [136.361703] [151/170] (877s left) vgem_basic (dmabuf-mmap) [136.420777] Starting subtest: dmabuf-mmap [136.429537] Subtest dmabuf-mmap: SUCCESS (0.009s) [136.460597] [152/170] (877s left) vgem_basic (mmap) [136.520256] Starting subtest: mmap [136.526134] Subtest mmap: SUCCESS (0.006s) [136.561709] [153/170] (877s left) vgem_basic (second-client) [136.620672] Starting subtest: second-client [136.644988] Subtest second-client: SUCCESS (0.024s) [136.680988] [154/170] (877s left) vgem_basic (sysfs) [136.736942] Starting subtest: sysfs [136.738231] Subtest sysfs: SUCCESS (0.000s) [136.769925] [155/170] (877s left) core_hotunplug (unbind-rebind) [136.862050] Starting subtest: unbind-rebind [137.820972] Subtest unbind-rebind: SUCCESS (0.959s) [137.842573] [156/170] (876s left) vgem_basic (unload) [137.904243] Starting subtest: unload [166.775320] Subtest unload: SUCCESS (28.870s) [166.839547] [157/170] (847s left) i915_module_load (reload) [166.889967] Starting subtest: reload [168.631801] Subtest reload: SUCCESS (1.739s) [168.649733] [158/170] (845s left) gem_lmem_swapping (basic) [168.752855] Subtest basic: SKIP (0.000s) [168.777652] [159/170] (845s left) gem_lmem_swapping (parallel-random-engines) [168.830891] Subtest parallel-random-engines: SKIP (0.000s) [168.852430] [160/170] (845s left) gem_lmem_swapping (random-engines) [168.905278] Subtest random-engines: SKIP (0.000s) [168.925857] [161/170] (845s left) gem_lmem_swapping (verify-random) [168.976149] Subtest verify-random: SKIP (0.000s) [168.993823] [162/170] (845s left) i915_pm_rpm (module-reload) [170.591150] Starting subtest: module-reload [178.109970] Subtest module-reload: SUCCESS (7.518s) [178.131780] [163/170] (835s left) i915_selftest (live) [178.195566] Starting subtest: live [178.196700] Starting dynamic subtest: sanitycheck [178.711276] Dynamic subtest sanitycheck: SUCCESS (0.514s) [178.719100] Starting dynamic subtest: uncore [179.190128] Dynamic subtest uncore: SUCCESS (0.478s) [179.197797] Starting dynamic subtest: workarounds [179.885536] Dynamic subtest workarounds: SUCCESS (0.694s) [179.894543] Starting dynamic subtest: gt_engines [180.834443] Dynamic subtest gt_engines: SUCCESS (0.948s) [180.841785] Starting dynamic subtest: gt_timelines [187.067222] Dynamic subtest gt_timelines: SUCCESS (6.232s) [187.074382] Starting dynamic subtest: gt_contexts [187.623272] Dynamic subtest gt_contexts: SUCCESS (0.555s) [187.632393] Starting dynamic subtest: gt_lrc [190.481524] Dynamic subtest gt_lrc: SUCCESS (2.857s) [190.490460] Starting dynamic subtest: gt_mocs [191.070246] Dynamic subtest gt_mocs: SUCCESS (0.588s) [191.077497] Starting dynamic subtest: gt_pm [205.914312] Dynamic subtest gt_pm: SUCCESS (14.843s) [205.923429] Starting dynamic subtest: gt_heartbeat [206.525116] Dynamic subtest gt_heartbeat: SUCCESS (0.610s) [206.534062] Starting dynamic subtest: gt_tlb [208.141962] Dynamic subtest gt_tlb: SUCCESS (1.615s) [208.150020] Starting dynamic subtest: requests [214.884267] Dynamic subtest requests: SUCCESS (6.742s) [214.891953] Starting dynamic subtest: migrate [218.075502] Dynamic subtest migrate: SUCCESS (3.190s) [218.083655] Starting dynamic subtest: active [218.587225] Dynamic subtest active: SUCCESS (0.511s) [218.596234] Starting dynamic subtest: objects [219.692172] Dynamic subtest objects: SUCCESS (1.104s) [219.699451] Starting dynamic subtest: mman [223.808284] Dynamic subtest mman: SUCCESS (4.115s) [223.816306] Starting dynamic subtest: dmabuf [224.379160] Dynamic subtest dmabuf: SUCCESS (0.570s) [224.386806] Starting dynamic subtest: vma [224.901235] Dynamic subtest vma: SUCCESS (0.521s) [224.908977] Starting dynamic subtest: coherency [226.542171] Dynamic subtest coherency: SUCCESS (1.640s) [226.550752] Starting dynamic subtest: gtt [234.749156] Dynamic subtest gtt: SUCCESS (8.206s) [234.758313] Starting dynamic subtest: gem [235.676722] Dynamic subtest gem: SUCCESS (0.926s) [235.684954] Starting dynamic subtest: evict [236.876488] Dynamic subtest evict: SUCCESS (1.199s) [236.884526] Starting dynamic subtest: hugepages [243.037810] Dynamic subtest hugepages: SUCCESS (6.160s) [243.046022] Starting dynamic subtest: gem_contexts [254.588360] Dynamic subtest gem_contexts: SUCCESS (11.550s) [254.596483] Starting dynamic subtest: client [255.146448] Dynamic subtest client: SUCCESS (0.557s) [255.154183] Starting dynamic subtest: gem_migrate [255.643286] Dynamic subtest gem_migrate: SUCCESS (0.496s) [255.651225] Starting dynamic subtest: reset [260.042827] Dynamic subtest reset: SUCCESS (4.398s) [260.051075] Starting dynamic subtest: memory_region [260.516261] Dynamic subtest memory_region: SUCCESS (0.473s) [260.525858] Starting dynamic subtest: hangcheck [284.108172] Dynamic subtest hangcheck: SUCCESS (23.591s) [284.115775] Starting dynamic subtest: execlists [292.531525] Dynamic subtest execlists: SUCCESS (8.422s) [292.540949] Starting dynamic subtest: ring_submission [293.039184] Dynamic subtest ring_submission: SUCCESS (0.507s) [293.047046] Starting dynamic subtest: perf [293.585271] Dynamic subtest perf: SUCCESS (0.545s) [293.593088] Starting dynamic subtest: slpc [294.112468] Dynamic subtest slpc: SUCCESS (0.526s) [294.120929] Starting dynamic subtest: guc [294.592290] Dynamic subtest guc: SUCCESS (0.479s) [294.600072] Starting dynamic subtest: guc_multi_lrc [295.079309] Dynamic subtest guc_multi_lrc: SUCCESS (0.486s) [295.088012] Starting dynamic subtest: guc_hang [295.574345] Dynamic subtest guc_hang: SUCCESS (0.494s) [295.582233] Starting dynamic subtest: late_gt_pm [296.130317] Dynamic subtest late_gt_pm: SUCCESS (0.555s) [296.131960] Subtest live: SUCCESS (117.934s) [296.295797] [164/170] (717s left) dmabuf (all-tests) [296.360692] Starting subtest: all-tests [296.364136] Starting dynamic subtest: sanitycheck [296.426640] Dynamic subtest sanitycheck: SUCCESS (0.065s) [296.438568] Starting dynamic subtest: dma_fence [296.594177] Dynamic subtest dma_fence: SUCCESS (0.167s) [296.605122] Starting dynamic subtest: dma_fence_chain [307.221578] Dynamic subtest dma_fence_chain: SUCCESS (10.626s) [307.231830] Starting dynamic subtest: dma_fence_unwrap [307.282039] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [307.293824] Starting dynamic subtest: dma_resv [307.353450] Dynamic subtest dma_resv: SUCCESS (0.070s) [307.355800] Subtest all-tests: SUCCESS (10.992s) [307.375842] [165/170] (706s left) i915_suspend (basic-s2idle-without-i915) [307.427556] Starting subtest: basic-s2idle-without-i915 [325.677732] Subtest basic-s2idle-without-i915: SUCCESS (2.221s) [330.782349] [166/170] (704s left) i915_suspend (basic-s3-without-i915) [330.835497] Starting subtest: basic-s3-without-i915