[38.227962] Initializing watchdogs [38.228101] /dev/watchdog0 [38.232829] [001/160] (960s left) i915_module_load (load) [38.293047] Starting subtest: load [41.593218] Subtest load: SUCCESS (3.302s) [41.610718] [002/160] (957s left) core_auth (basic-auth) [41.688572] Starting subtest: basic-auth [41.689863] Subtest basic-auth: SUCCESS (0.002s) [41.772418] [003/160] (956s left) debugfs_test (read_all_entries) [41.854680] Starting subtest: read_all_entries [42.281922] Subtest read_all_entries: SUCCESS (0.427s) [42.848926] [004/160] (955s left) debugfs_test (basic-hwmon) [42.943496] Starting subtest: basic-hwmon [42.944970] Subtest basic-hwmon: SKIP (0.000s) [43.483823] [005/160] (955s left) fbdev (eof) [43.548713] Starting subtest: eof [43.549333] Subtest eof: SUCCESS (0.001s) [43.596733] [006/160] (955s left) fbdev (info) [43.651966] Starting subtest: info [43.652542] Subtest info: SUCCESS (0.000s) [43.711458] [007/160] (955s left) fbdev (nullptr) [43.780447] Starting subtest: nullptr [43.781195] Subtest nullptr: SUCCESS (0.000s) [43.837308] [008/160] (955s left) fbdev (read) [43.915804] Starting subtest: read [44.153269] Subtest read: SUCCESS (0.239s) [44.194304] [009/160] (954s left) fbdev (write) [44.260625] Starting subtest: write [44.386721] Subtest write: SUCCESS (0.126s) [44.426865] [010/160] (954s left) gem_basic (bad-close) [44.481706] Starting subtest: bad-close [44.482827] Subtest bad-close: SUCCESS (0.000s) [44.553305] [011/160] (954s left) gem_basic (create-close) [44.628364] Starting subtest: create-close [44.629730] Subtest create-close: SUCCESS (0.000s) [44.709873] [012/160] (954s left) gem_basic (create-fd-close) [44.799533] Starting subtest: create-fd-close [44.800600] Subtest create-fd-close: SUCCESS (0.000s) [44.862952] [013/160] (954s left) gem_busy (busy@all-engines) [44.941877] Starting subtest: busy [44.942452] Starting dynamic subtest: all-engines [45.003566] Dynamic subtest all-engines: SUCCESS (0.062s) [45.004038] Subtest busy: SUCCESS (0.062s) [45.393656] [014/160] (953s left) gem_close_race (basic-process) [45.470736] Starting subtest: basic-process [45.531117] Subtest basic-process: SUCCESS (0.060s) [45.758918] [015/160] (953s left) gem_close_race (basic-threads) [45.851449] Starting subtest: basic-threads [47.105184] Subtest basic-threads: SUCCESS (1.256s) [47.305345] [016/160] (951s left) gem_ctx_create (basic) [47.385744] Starting subtest: basic [47.386365] Subtest basic: SUCCESS (0.000s) [47.593086] [017/160] (951s left) gem_ctx_create (basic-files) [47.681775] Starting subtest: basic-files [49.696836] Subtest basic-files: SUCCESS (2.015s) [49.939749] [018/160] (949s left) gem_ctx_exec (basic) [50.022768] Starting subtest: basic [50.025473] Subtest basic: SUCCESS (0.004s) [50.130719] [019/160] (948s left) gem_exec_basic (basic) [50.225953] Starting subtest: basic [50.229157] Starting dynamic subtest: rcs0-smem [50.229738] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [50.235381] Starting dynamic subtest: bcs0-smem [50.235972] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [50.240934] Starting dynamic subtest: vcs0-smem [50.241647] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [50.246909] Starting dynamic subtest: vcs1-smem [50.247854] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [50.253253] Starting dynamic subtest: vecs0-smem [50.254017] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [50.254946] Subtest basic: SUCCESS (0.006s) [50.458655] [020/160] (948s left) gem_exec_create (basic) [50.552616] Starting subtest: basic [50.554597] Starting dynamic subtest: smem [52.601017] Dynamic subtest smem: SUCCESS (2.050s) [52.601593] Subtest basic: SUCCESS (2.051s) [52.806323] [021/160] (946s left) gem_exec_fence (basic-busy) [53.006744] Starting subtest: basic-busy [53.008179] Starting dynamic subtest: rcs0 [53.035329] Dynamic subtest rcs0: SUCCESS (0.028s) [53.046479] Starting dynamic subtest: bcs0 [53.068356] Dynamic subtest bcs0: SUCCESS (0.033s) [53.080713] Starting dynamic subtest: vcs0 [53.091904] Dynamic subtest vcs0: SUCCESS (0.022s) [53.098889] Starting dynamic subtest: vcs1 [53.113428] Dynamic subtest vcs1: SUCCESS (0.022s) [53.120372] Starting dynamic subtest: vecs0 [53.139862] Dynamic subtest vecs0: SUCCESS (0.028s) [53.140395] Subtest basic-busy: SUCCESS (0.134s) [53.811556] [022/160] (945s left) gem_exec_fence (basic-wait) [54.030374] Starting subtest: basic-wait [54.031778] Starting dynamic subtest: rcs0 [54.061525] Dynamic subtest rcs0: SUCCESS (0.033s) [54.075525] Starting dynamic subtest: bcs0 [54.100278] Dynamic subtest bcs0: SUCCESS (0.036s) [54.114264] Starting dynamic subtest: vcs0 [54.129420] Dynamic subtest vcs0: SUCCESS (0.031s) [54.143425] Starting dynamic subtest: vcs1 [54.158191] Dynamic subtest vcs1: SUCCESS (0.029s) [54.169313] Starting dynamic subtest: vecs0 [54.189905] Dynamic subtest vecs0: SUCCESS (0.029s) [54.190875] Subtest basic-wait: SUCCESS (0.160s) [54.826104] [023/160] (944s left) gem_exec_fence (basic-await) [55.021283] Starting subtest: basic-await [55.022609] Starting dynamic subtest: rcs0 [55.132921] Dynamic subtest rcs0: SUCCESS (0.112s) [55.141255] Starting dynamic subtest: bcs0 [55.230591] Dynamic subtest bcs0: SUCCESS (0.097s) [55.238284] Starting dynamic subtest: vcs0 [55.330958] Dynamic subtest vcs0: SUCCESS (0.100s) [55.339136] Starting dynamic subtest: vcs1 [55.431862] Dynamic subtest vcs1: SUCCESS (0.101s) [55.444447] Starting dynamic subtest: vecs0 [55.560652] Dynamic subtest vecs0: SUCCESS (0.128s) [55.561250] Subtest basic-await: SUCCESS (0.540s) [56.203430] [024/160] (943s left) gem_exec_fence (nb-await) [56.410137] Starting subtest: nb-await [56.411827] Starting dynamic subtest: rcs0 [56.489846] Dynamic subtest rcs0: SUCCESS (0.079s) [56.512941] Starting dynamic subtest: bcs0 [56.574539] Dynamic subtest bcs0: SUCCESS (0.083s) [56.589946] Starting dynamic subtest: vcs0 [56.644944] Dynamic subtest vcs0: SUCCESS (0.070s) [56.663130] Starting dynamic subtest: vcs1 [56.720291] Dynamic subtest vcs1: SUCCESS (0.071s) [56.747753] Starting dynamic subtest: vecs0 [56.812881] Dynamic subtest vecs0: SUCCESS (0.095s) [56.814992] Subtest nb-await: SUCCESS (0.402s) [57.458296] [025/160] (941s left) gem_exec_gttfill (basic) [57.548616] Starting subtest: basic [66.017090] Subtest basic: SUCCESS (8.469s) [66.180588] [026/160] (933s left) gem_exec_parallel (engines) [66.390426] Starting subtest: engines [66.391094] Starting dynamic subtest: basic [68.461885] Dynamic subtest basic: SUCCESS (2.070s) [68.467826] Starting dynamic subtest: contexts [72.697181] Dynamic subtest contexts: SUCCESS (4.237s) [72.704283] Starting dynamic subtest: fds [80.108709] Dynamic subtest fds: SUCCESS (7.411s) [80.115209] Starting dynamic subtest: userptr [82.187242] Dynamic subtest userptr: SUCCESS (2.079s) [82.187844] Subtest engines: SUCCESS (15.798s) [82.389211] [027/160] (916s left) gem_exec_store (basic) [82.467488] Starting subtest: basic [82.517680] Subtest basic: SUCCESS (0.050s) [82.721704] [028/160] (916s left) gem_flink_basic (bad-flink) [82.786569] Starting subtest: bad-flink [82.787126] Subtest bad-flink: SUCCESS (0.000s) [82.865816] [029/160] (916s left) gem_flink_basic (bad-open) [82.939582] Starting subtest: bad-open [82.940213] Subtest bad-open: SUCCESS (0.000s) [83.018170] [030/160] (916s left) gem_flink_basic (basic) [83.091859] Starting subtest: basic [83.092497] Subtest basic: SUCCESS (0.000s) [83.166831] [031/160] (916s left) gem_flink_basic (double-flink) [83.235633] Starting subtest: double-flink [83.236151] Subtest double-flink: SUCCESS (0.000s) [83.312616] [032/160] (916s left) gem_flink_basic (flink-lifetime) [83.397104] Starting subtest: flink-lifetime [83.397890] Subtest flink-lifetime: SUCCESS (0.002s) [83.492847] [033/160] (915s left) gem_huc_copy (huc-copy) [83.568133] Starting subtest: huc-copy [83.569500] Subtest huc-copy: SKIP (0.000s) [83.688385] [034/160] (915s left) gem_linear_blits (basic) [83.870539] Starting subtest: basic [83.877591] Subtest basic: SUCCESS (0.007s) [84.028622] [035/160] (915s left) gem_mmap (basic) [84.176340] Starting subtest: basic [84.179421] Subtest basic: SUCCESS (0.000s) [84.276514] [036/160] (915s left) gem_mmap_gtt (basic) [84.351460] Starting subtest: basic [84.352011] Subtest basic: SUCCESS (0.001s) [84.425601] [037/160] (915s left) gem_render_linear_blits (basic) [84.503865] Starting subtest: basic [84.536042] Subtest basic: SUCCESS (0.032s) [84.571359] [038/160] (914s left) gem_render_tiled_blits (basic) [84.638233] Starting subtest: basic [84.672890] Subtest basic: SUCCESS (0.035s) [84.718334] [039/160] (914s left) gem_ringfill (basic-all) [84.993773] Starting subtest: basic-all [86.151167] Subtest basic-all: SUCCESS (1.157s) [86.259644] [040/160] (913s left) gem_softpin (allocator-basic) [86.353124] Starting subtest: allocator-basic [86.457824] Subtest allocator-basic: SUCCESS (0.105s) [86.575301] [041/160] (913s left) gem_softpin (allocator-basic-reserve) [86.667324] Starting subtest: allocator-basic-reserve [86.773745] Subtest allocator-basic-reserve: SUCCESS (0.106s) [86.864675] [042/160] (912s left) gem_softpin (safe-alignment) [86.938878] Starting subtest: safe-alignment [86.953554] Subtest safe-alignment: SUCCESS (0.015s) [87.048912] [043/160] (912s left) gem_sync (basic-all) [87.140460] Starting subtest: basic-all [89.177950] Subtest basic-all: SUCCESS (2.037s) [89.375046] [044/160] (910s left) gem_sync (basic-each) [89.447783] Starting subtest: basic-each [91.661210] Subtest basic-each: SUCCESS (2.213s) [91.874450] [045/160] (907s left) gem_tiled_blits (basic) [92.095245] Starting subtest: basic [92.117873] Subtest basic: SUCCESS (0.022s) [92.277483] [046/160] (907s left) gem_tiled_fence_blits (basic) [92.513148] Starting subtest: basic [92.523252] Subtest basic: SUCCESS (0.011s) [92.672364] [047/160] (907s left) gem_tiled_pread_basic [93.036553] [048/160] (906s left) gem_wait (busy@all-engines) [93.118903] Starting subtest: busy [93.119508] Starting dynamic subtest: all-engines [93.641978] Dynamic subtest all-engines: SUCCESS (0.523s) [93.642724] Subtest busy: SUCCESS (0.523s) [93.845301] [049/160] (905s left) gem_wait (wait@all-engines) [93.948638] Starting subtest: wait [93.949197] Starting dynamic subtest: all-engines [94.987422] Dynamic subtest all-engines: SUCCESS (1.037s) [94.989743] Subtest wait: SUCCESS (1.038s) [95.253528] [050/160] (904s left) i915_getparams_basic (basic-eu-total) [95.343536] Starting subtest: basic-eu-total [95.344711] Subtest basic-eu-total: SUCCESS (0.000s) [95.422978] [051/160] (904s left) i915_getparams_basic (basic-subslice-total) [95.507405] Starting subtest: basic-subslice-total [95.508720] Subtest basic-subslice-total: SUCCESS (0.000s) [95.589647] [052/160] (904s left) i915_hangman (error-state-basic) [95.683707] Starting subtest: error-state-basic [95.693045] Subtest error-state-basic: SUCCESS (0.009s) [95.763546] [053/160] (904s left) i915_pciid [95.915391] [054/160] (904s left) kms_addfb_basic (addfb25-4-tiled) [96.416793] Starting subtest: addfb25-4-tiled [96.417555] Subtest addfb25-4-tiled: SUCCESS (0.001s) [96.495634] [055/160] (903s left) kms_addfb_basic (addfb25-bad-modifier) [96.558411] Starting subtest: addfb25-bad-modifier [96.559057] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [97.086123] [056/160] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [97.150321] Starting subtest: addfb25-framebuffer-vs-set-tiling [97.150937] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.679522] [057/160] (902s left) kms_addfb_basic (addfb25-modifier-no-flag) [97.746672] Starting subtest: addfb25-modifier-no-flag [97.747210] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [98.258188] [058/160] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [98.318770] Starting subtest: addfb25-x-tiled-legacy [98.319375] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [98.836610] [059/160] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [98.901115] Starting subtest: addfb25-x-tiled-mismatch-legacy [98.901662] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [99.436292] [060/160] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [99.939640] Starting subtest: addfb25-yf-tiled-legacy [99.940564] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [100.024075] [061/160] (900s left) kms_addfb_basic (addfb25-y-tiled-legacy) [100.565886] Starting subtest: addfb25-y-tiled-legacy [100.566788] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [100.649648] [062/160] (899s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [101.159191] Starting subtest: addfb25-y-tiled-small-legacy [101.160666] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [101.237647] [063/160] (898s left) kms_addfb_basic (bad-pitch-0) [101.307180] Starting subtest: bad-pitch-0 [101.307716] Subtest bad-pitch-0: SUCCESS (0.000s) [101.823251] [064/160] (898s left) kms_addfb_basic (bad-pitch-1024) [101.891193] Starting subtest: bad-pitch-1024 [101.891736] Subtest bad-pitch-1024: SUCCESS (0.000s) [102.445872] [065/160] (897s left) kms_addfb_basic (bad-pitch-128) [102.509677] Starting subtest: bad-pitch-128 [102.510208] Subtest bad-pitch-128: SUCCESS (0.000s) [103.054807] [066/160] (897s left) kms_addfb_basic (bad-pitch-256) [103.127353] Starting subtest: bad-pitch-256 [103.128015] Subtest bad-pitch-256: SUCCESS (0.000s) [103.661461] [067/160] (896s left) kms_addfb_basic (bad-pitch-32) [103.719719] Starting subtest: bad-pitch-32 [103.720316] Subtest bad-pitch-32: SUCCESS (0.000s) [104.248745] [068/160] (895s left) kms_addfb_basic (bad-pitch-63) [104.315641] Starting subtest: bad-pitch-63 [104.316130] Subtest bad-pitch-63: SUCCESS (0.000s) [104.832959] [069/160] (895s left) kms_addfb_basic (bad-pitch-65536) [104.895715] Starting subtest: bad-pitch-65536 [104.896200] Subtest bad-pitch-65536: SUCCESS (0.000s) [105.427323] [070/160] (894s left) kms_addfb_basic (bad-pitch-999) [105.492391] Starting subtest: bad-pitch-999 [105.492971] Subtest bad-pitch-999: SUCCESS (0.000s) [106.017767] [071/160] (894s left) kms_addfb_basic (basic) [106.081541] Starting subtest: basic [106.082137] Subtest basic: SUCCESS (0.000s) [106.613569] [072/160] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [106.675383] Starting subtest: basic-x-tiled-legacy [106.676062] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [107.232976] [073/160] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [107.296038] Starting subtest: basic-y-tiled-legacy [107.296638] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [107.818272] [074/160] (892s left) kms_addfb_basic (bo-too-small) [108.324868] Starting subtest: bo-too-small [108.325731] Subtest bo-too-small: SUCCESS (0.000s) [108.411788] [075/160] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [108.935029] Starting subtest: bo-too-small-due-to-tiling [108.935811] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [109.018658] [076/160] (891s left) kms_addfb_basic (clobberred-modifier) [109.083463] Starting subtest: clobberred-modifier [109.083919] Subtest clobberred-modifier: SUCCESS (0.000s) [109.619251] [077/160] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.688178] Starting subtest: framebuffer-vs-set-tiling [109.688672] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.228303] [078/160] (890s left) kms_addfb_basic (invalid-get-prop) [110.293615] Starting subtest: invalid-get-prop [110.294213] Subtest invalid-get-prop: SUCCESS (0.000s) [110.835721] [079/160] (889s left) kms_addfb_basic (invalid-get-prop-any) [110.896789] Starting subtest: invalid-get-prop-any [110.897369] Subtest invalid-get-prop-any: SUCCESS (0.000s) [111.417177] [080/160] (888s left) kms_addfb_basic (invalid-set-prop) [111.481779] Starting subtest: invalid-set-prop [111.482366] Subtest invalid-set-prop: SUCCESS (0.000s) [111.995151] [081/160] (888s left) kms_addfb_basic (invalid-set-prop-any) [112.058781] Starting subtest: invalid-set-prop-any [112.059377] Subtest invalid-set-prop-any: SUCCESS (0.000s) [112.600199] [082/160] (887s left) kms_addfb_basic (no-handle) [112.666707] Starting subtest: no-handle [112.667169] Subtest no-handle: SUCCESS (0.000s) [113.184238] [083/160] (887s left) kms_addfb_basic (size-max) [113.714031] Starting subtest: size-max [113.715211] Subtest size-max: SUCCESS (0.000s) [113.802120] [084/160] (886s left) kms_addfb_basic (small-bo) [114.332386] Starting subtest: small-bo [114.333574] Subtest small-bo: SUCCESS (0.000s) [114.428284] [085/160] (886s left) kms_addfb_basic (tile-pitch-mismatch) [114.494746] Starting subtest: tile-pitch-mismatch [114.495305] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [115.022841] [086/160] (885s left) kms_addfb_basic (too-high) [115.552429] Starting subtest: too-high [115.553590] Subtest too-high: SUCCESS (0.001s) [115.646688] [087/160] (884s left) kms_addfb_basic (too-wide) [116.164592] Starting subtest: too-wide [116.166053] Subtest too-wide: SUCCESS (0.000s) [116.263696] [088/160] (884s left) kms_addfb_basic (unused-handle) [116.329958] Starting subtest: unused-handle [116.330568] Subtest unused-handle: SUCCESS (0.000s) [116.858898] [089/160] (883s left) kms_addfb_basic (unused-modifier) [116.924856] Starting subtest: unused-modifier [116.925439] Subtest unused-modifier: SUCCESS (0.000s) [117.445912] [090/160] (883s left) kms_addfb_basic (unused-offsets) [117.512875] Starting subtest: unused-offsets [117.513468] Subtest unused-offsets: SUCCESS (0.000s) [118.054092] [091/160] (882s left) kms_addfb_basic (unused-pitches) [118.119849] Starting subtest: unused-pitches [118.120483] Subtest unused-pitches: SUCCESS (0.000s) [118.665470] [092/160] (881s left) kms_busy (basic) [119.181682] Starting subtest: basic [119.182792] Starting dynamic subtest: flip [120.523142] Dynamic subtest flip: SUCCESS (1.338s) [120.531833] Starting dynamic subtest: modeset [121.690122] Dynamic subtest modeset: SUCCESS (1.167s) [121.690712] Subtest basic: SUCCESS (2.511s) [122.230166] [093/160] (878s left) kms_prop_blob (basic) [122.297891] Starting subtest: basic [122.298542] Subtest basic: SUCCESS (0.000s) [122.377700] [094/160] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [122.884297] Starting subtest: basic-busy-flip-before-cursor-atomic [122.886533] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [122.966331] [095/160] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [123.509338] Starting subtest: basic-busy-flip-before-cursor-legacy [123.511668] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [123.594088] [096/160] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [124.117074] Starting subtest: basic-flip-after-cursor-atomic [125.768992] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.651s) [126.299997] [097/160] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [126.804701] Starting subtest: basic-flip-after-cursor-legacy [128.965645] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.160s) [129.557596] [098/160] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [130.079575] Starting subtest: basic-flip-after-cursor-varying-size [131.763870] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.683s) [132.342572] [099/160] (868s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [132.865854] Starting subtest: basic-flip-before-cursor-atomic [134.341312] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.474s) [134.898074] [100/160] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [135.415782] Starting subtest: basic-flip-before-cursor-legacy [136.948768] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.532s) [138.059735] [101/160] (862s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [138.581193] Starting subtest: basic-flip-before-cursor-varying-size [139.989740] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.413s) [140.534604] [102/160] (860s left) kms_dsc (dsc-basic) [141.046507] Subtest dsc-basic: SKIP (0.000s) [141.099971] [103/160] (859s left) kms_flip (basic-flip-vs-dpms) [141.650647] Starting subtest: basic-flip-vs-dpms [141.659467] Starting dynamic subtest: A-DP1 [142.997335] Dynamic subtest A-DP1: SUCCESS (1.337s) [143.018917] Starting dynamic subtest: B-DP1 [144.010028] Dynamic subtest B-DP1: SUCCESS (1.006s) [144.030817] Starting dynamic subtest: C-DP1 [144.976482] Dynamic subtest C-DP1: SUCCESS (0.960s) [144.996315] Starting dynamic subtest: A-DP3 [146.262434] Dynamic subtest A-DP3: SUCCESS (1.281s) [146.283808] Starting dynamic subtest: B-DP3 [148.556297] Dynamic subtest B-DP3: SUCCESS (2.279s) [148.598104] Starting dynamic subtest: C-DP3 [150.184098] Dynamic subtest C-DP3: SUCCESS (1.622s) [150.193752] Subtest basic-flip-vs-dpms: SUCCESS (8.539s) [150.842911] [104/160] (850s left) kms_flip (basic-flip-vs-modeset) [151.380478] Starting subtest: basic-flip-vs-modeset [151.384291] Starting dynamic subtest: A-DP1 [152.905370] Dynamic subtest A-DP1: SUCCESS (1.518s) [152.927949] Starting dynamic subtest: B-DP1 [154.072484] Dynamic subtest B-DP1: SUCCESS (1.160s) [154.088705] Starting dynamic subtest: C-DP1 [155.044316] Dynamic subtest C-DP1: SUCCESS (0.967s) [155.070299] Starting dynamic subtest: A-DP3 [156.481389] Dynamic subtest A-DP3: SUCCESS (1.417s) [156.503107] Starting dynamic subtest: B-DP3 [157.869139] Dynamic subtest B-DP3: SUCCESS (1.389s) [157.893301] Starting dynamic subtest: C-DP3 [159.246443] Dynamic subtest C-DP3: SUCCESS (1.375s) [159.251182] Subtest basic-flip-vs-modeset: SUCCESS (7.869s) [159.883705] [105/160] (841s left) kms_flip (basic-flip-vs-wf_vblank) [160.424824] Starting subtest: basic-flip-vs-wf_vblank [160.430502] Starting dynamic subtest: A-DP1 [162.068886] Dynamic subtest A-DP1: SUCCESS (1.638s) [162.080967] Starting dynamic subtest: B-DP1 [163.204543] Dynamic subtest B-DP1: SUCCESS (1.135s) [163.213897] Starting dynamic subtest: C-DP1 [164.519159] Dynamic subtest C-DP1: SUCCESS (1.310s) [164.529598] Starting dynamic subtest: A-DP3 [165.703434] Dynamic subtest A-DP3: SUCCESS (1.181s) [165.712645] Starting dynamic subtest: B-DP3 [167.805510] Dynamic subtest B-DP3: SUCCESS (2.101s) [167.821306] Starting dynamic subtest: C-DP3 [169.312578] Dynamic subtest C-DP3: SUCCESS (1.505s) [169.315386] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.892s) [170.341051] [106/160] (830s left) kms_flip (basic-plain-flip) [170.861066] Starting subtest: basic-plain-flip [170.864359] Starting dynamic subtest: A-DP1 [172.186523] Dynamic subtest A-DP1: SUCCESS (1.322s) [172.196699] Starting dynamic subtest: B-DP1 [173.069384] Dynamic subtest B-DP1: SUCCESS (0.879s) [173.124827] Starting dynamic subtest: C-DP1 [174.013963] Dynamic subtest C-DP1: SUCCESS (0.932s) [174.026760] Starting dynamic subtest: A-DP3 [174.945213] Dynamic subtest A-DP3: SUCCESS (0.928s) [174.954418] Starting dynamic subtest: B-DP3 [176.167867] Dynamic subtest B-DP3: SUCCESS (1.223s) [176.178606] Starting dynamic subtest: C-DP3 [177.529573] Dynamic subtest C-DP3: SUCCESS (1.358s) [177.546230] Subtest basic-plain-flip: SUCCESS (6.681s) [178.488500] [107/160] (822s left) kms_force_connector_basic (force-connector-state) [178.773704] Starting subtest: force-connector-state [180.114052] Subtest force-connector-state: SUCCESS (1.344s) [181.161721] [108/160] (820s left) kms_force_connector_basic (force-edid) [181.421465] Starting subtest: force-edid [181.817381] Subtest force-edid: SUCCESS (0.388s) [182.470121] [109/160] (818s left) kms_force_connector_basic (force-load-detect) [182.725695] Starting subtest: force-load-detect [182.726938] Subtest force-load-detect: SKIP (0.000s) [183.157824] [110/160] (818s left) kms_force_connector_basic (prune-stale-modes) [183.423661] Starting subtest: prune-stale-modes [183.890622] Subtest prune-stale-modes: SUCCESS (0.463s) [184.555838] [111/160] (816s left) kms_frontbuffer_tracking (basic) [185.096453] Starting subtest: basic [188.462087] Subtest basic: SUCCESS (3.364s) [189.107886] [112/160] (812s left) kms_hdmi_inject (inject-audio) [189.422296] Starting subtest: inject-audio [189.973975] Subtest inject-audio: SUCCESS (0.542s) [190.875453] [113/160] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [191.402162] Starting subtest: compare-crc-sanitycheck-xr24 [191.403016] Starting dynamic subtest: pipe-A-DP-1 [192.489676] Dynamic subtest pipe-A-DP-1: SUCCESS (1.085s) [192.509714] Starting dynamic subtest: pipe-B-DP-3 [193.361303] Dynamic subtest pipe-B-DP-3: SUCCESS (0.861s) [193.416182] Starting dynamic subtest: pipe-C-DP-1 [194.008739] Dynamic subtest pipe-C-DP-1: SUCCESS (0.630s) [194.011103] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.608s) [194.584572] [114/160] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [195.099781] Starting subtest: compare-crc-sanitycheck-nv12 [195.100783] Starting dynamic subtest: pipe-A-DP-1 [196.339138] Dynamic subtest pipe-A-DP-1: SUCCESS (1.235s) [196.356225] Starting dynamic subtest: pipe-B-DP-3 [197.251554] Dynamic subtest pipe-B-DP-3: SUCCESS (0.903s) [197.301347] Starting dynamic subtest: pipe-C-DP-1 [197.304401] Dynamic subtest pipe-C-DP-1: SKIP (0.004s) [197.306095] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.172s) [197.928484] [115/160] (803s left) kms_pipe_crc_basic (hang-read-crc) [198.471869] Starting subtest: hang-read-crc [198.473524] Starting dynamic subtest: pipe-A-DP-1 [200.320880] Dynamic subtest pipe-A-DP-1: SUCCESS (1.846s) [200.337328] Starting dynamic subtest: pipe-B-DP-3 [202.325724] Dynamic subtest pipe-B-DP-3: SUCCESS (1.995s) [202.373099] Starting dynamic subtest: pipe-C-DP-1 [203.824156] Dynamic subtest pipe-C-DP-1: SUCCESS (1.488s) [203.825289] Subtest hang-read-crc: SUCCESS (5.354s) [204.377487] [116/160] (797s left) kms_pipe_crc_basic (nonblocking-crc) [204.895116] Starting subtest: nonblocking-crc [204.900224] Starting dynamic subtest: pipe-A-DP-1 [206.054874] Dynamic subtest pipe-A-DP-1: SUCCESS (1.155s) [206.071605] Starting dynamic subtest: pipe-B-DP-3 [207.027575] Dynamic subtest pipe-B-DP-3: SUCCESS (0.968s) [207.040746] Starting dynamic subtest: pipe-C-DP-1 [207.827656] Dynamic subtest pipe-C-DP-1: SUCCESS (0.795s) [207.828543] Subtest nonblocking-crc: SUCCESS (2.933s) [208.359841] [117/160] (793s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [208.878760] Starting subtest: nonblocking-crc-frame-sequence [208.880090] Starting dynamic subtest: pipe-A-DP-1 [210.131954] Dynamic subtest pipe-A-DP-1: SUCCESS (1.253s) [210.146364] Starting dynamic subtest: pipe-B-DP-3 [211.186663] Dynamic subtest pipe-B-DP-3: SUCCESS (1.051s) [211.236993] Starting dynamic subtest: pipe-C-DP-1 [212.039290] Dynamic subtest pipe-C-DP-1: SUCCESS (0.838s) [212.040336] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.164s) [212.571997] [118/160] (789s left) kms_pipe_crc_basic (read-crc) [213.084298] Starting subtest: read-crc [213.091588] Starting dynamic subtest: pipe-A-DP-1 [214.239980] Dynamic subtest pipe-A-DP-1: SUCCESS (1.153s) [214.255023] Starting dynamic subtest: pipe-B-DP-3 [215.319660] Dynamic subtest pipe-B-DP-3: SUCCESS (1.068s) [215.366810] Starting dynamic subtest: pipe-C-DP-1 [216.106122] Dynamic subtest pipe-C-DP-1: SUCCESS (0.770s) [216.107676] Subtest read-crc: SUCCESS (3.017s) [216.671456] [119/160] (785s left) kms_pipe_crc_basic (read-crc-frame-sequence) [217.225881] Starting subtest: read-crc-frame-sequence [217.226996] Starting dynamic subtest: pipe-A-DP-1 [218.375550] Dynamic subtest pipe-A-DP-1: SUCCESS (1.146s) [218.390675] Starting dynamic subtest: pipe-B-DP-3 [219.217865] Dynamic subtest pipe-B-DP-3: SUCCESS (0.836s) [219.235687] Starting dynamic subtest: pipe-C-DP-1 [219.977366] Dynamic subtest pipe-C-DP-1: SUCCESS (0.756s) [219.978336] Subtest read-crc-frame-sequence: SUCCESS (2.753s) [220.630336] [120/160] (781s left) kms_pm_backlight (basic-brightness) [221.151631] Subtest basic-brightness: SKIP (0.000s) [221.198681] [121/160] (780s left) kms_pm_rpm (basic-pci-d3-state) [223.363070] Starting subtest: basic-pci-d3-state [224.161677] Subtest basic-pci-d3-state: SUCCESS (0.797s) [225.042694] [122/160] (776s left) kms_pm_rpm (basic-rte) [225.111627] Starting subtest: basic-rte [227.952195] Subtest basic-rte: SUCCESS (2.840s) [229.238887] [123/160] (772s left) kms_psr (psr-primary-page-flip) [229.762319] Subtest psr-primary-page-flip: SKIP (0.000s) [229.813297] [124/160] (772s left) kms_psr (psr-cursor-plane-move) [230.374080] Subtest psr-cursor-plane-move: SKIP (0.000s) [230.421618] [125/160] (771s left) kms_psr (psr-sprite-plane-onoff) [230.968298] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [231.007338] [126/160] (770s left) kms_psr (psr-primary-mmap-gtt) [231.552900] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [231.614732] [127/160] (770s left) kms_setmode (basic-clone-single-crtc) [231.700241] Starting subtest: basic-clone-single-crtc [232.565466] Subtest basic-clone-single-crtc: SKIP (0.866s) [233.100373] [128/160] (768s left) i915_pm_rps (basic-api) [233.185470] Starting subtest: basic-api [233.189491] Subtest basic-api: SUCCESS (0.004s) [233.268021] [129/160] (768s left) prime_self_import (basic-llseek-bad) [233.332080] Starting subtest: basic-llseek-bad [233.345332] Subtest basic-llseek-bad: SUCCESS (0.012s) [233.439625] [130/160] (768s left) prime_self_import (basic-llseek-size) [233.508500] Starting subtest: basic-llseek-size [233.518805] Subtest basic-llseek-size: SUCCESS (0.010s) [233.621803] [131/160] (768s left) prime_self_import (basic-with_fd_dup) [233.691480] Starting subtest: basic-with_fd_dup [233.706222] Subtest basic-with_fd_dup: SUCCESS (0.014s) [233.825305] [132/160] (768s left) prime_self_import (basic-with_one_bo) [233.878595] Starting subtest: basic-with_one_bo [233.888257] Subtest basic-with_one_bo: SUCCESS (0.009s) [233.976443] [133/160] (768s left) prime_self_import (basic-with_one_bo_two_files) [234.041917] Starting subtest: basic-with_one_bo_two_files [234.055178] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s) [234.136310] [134/160] (768s left) prime_self_import (basic-with_two_bos) [234.197375] Starting subtest: basic-with_two_bos [234.206098] Subtest basic-with_two_bos: SUCCESS (0.008s) [234.290936] [135/160] (767s left) prime_vgem (basic-fence-flip) [234.376207] Starting subtest: basic-fence-flip [235.274571] Subtest basic-fence-flip: SUCCESS (0.897s) [235.401054] [136/160] (766s left) prime_vgem (basic-fence-mmap) [235.490838] Starting subtest: basic-fence-mmap [235.516795] Subtest basic-fence-mmap: SUCCESS (0.026s) [235.594970] [137/160] (766s left) prime_vgem (basic-fence-read) [235.688237] Starting subtest: basic-fence-read [235.745705] Subtest basic-fence-read: SUCCESS (0.057s) [235.816988] [138/160] (766s left) prime_vgem (basic-gtt) [235.904821] Starting subtest: basic-gtt [235.916330] Subtest basic-gtt: SUCCESS (0.012s) [236.010219] [139/160] (766s left) prime_vgem (basic-read) [236.097759] Starting subtest: basic-read [236.123729] Subtest basic-read: SUCCESS (0.027s) [236.196485] [140/160] (766s left) prime_vgem (basic-write) [236.281233] Starting subtest: basic-write [236.309940] Subtest basic-write: SUCCESS (0.029s) [236.381063] [141/160] (766s left) vgem_basic (setversion) [236.445713] Starting subtest: setversion [236.446901] Subtest setversion: SUCCESS (0.000s) [236.497717] [142/160] (765s left) vgem_basic (create) [236.563977] Starting subtest: create [236.564707] Subtest create: SUCCESS (0.000s) [236.612546] [143/160] (765s left) vgem_basic (debugfs) [236.678926] Starting subtest: debugfs [236.680989] Subtest debugfs: SUCCESS (0.000s) [236.734773] [144/160] (765s left) vgem_basic (dmabuf-export) [236.809206] Starting subtest: dmabuf-export [236.825606] Subtest dmabuf-export: SUCCESS (0.017s) [236.907607] [145/160] (765s left) vgem_basic (dmabuf-fence) [236.995641] Starting subtest: dmabuf-fence [236.996300] Subtest dmabuf-fence: SUCCESS (0.001s) [237.047014] [146/160] (765s left) vgem_basic (dmabuf-fence-before) [237.115051] Starting subtest: dmabuf-fence-before [237.115938] Subtest dmabuf-fence-before: SUCCESS (0.000s) [237.163103] [147/160] (765s left) vgem_basic (dmabuf-mmap) [237.228999] Starting subtest: dmabuf-mmap [237.241670] Subtest dmabuf-mmap: SUCCESS (0.012s) [237.296428] [148/160] (765s left) vgem_basic (mmap) [237.362411] Starting subtest: mmap [237.371018] Subtest mmap: SUCCESS (0.009s) [237.423996] [149/160] (765s left) vgem_basic (second-client) [237.490843] Starting subtest: second-client [237.524177] Subtest second-client: SUCCESS (0.033s) [237.591562] [150/160] (764s left) vgem_basic (sysfs) [237.662313] Starting subtest: sysfs [237.662991] Subtest sysfs: SUCCESS (0.001s) [237.713931] [151/160] (764s left) core_hotunplug (unbind-rebind) [237.845744] Starting subtest: unbind-rebind [242.127298] Subtest unbind-rebind: SUCCESS (4.281s) [242.155991] [152/160] (760s left) vgem_basic (unload) [242.226674] Starting subtest: unload [271.325662] Subtest unload: SUCCESS (29.097s) [271.456341] [153/160] (731s left) i915_module_load (reload) [271.510304] Starting subtest: reload [275.881200] Subtest reload: SUCCESS (4.371s) [275.923590] [154/160] (726s left) gem_lmem_swapping (basic) [276.038659] Subtest basic: SKIP (0.000s) [276.094650] [155/160] (726s left) gem_lmem_swapping (parallel-random-engines) [276.153667] Subtest parallel-random-engines: SKIP (0.000s) [276.186877] [156/160] (726s left) gem_lmem_swapping (random-engines) [276.243253] Subtest random-engines: SKIP (0.000s) [276.272628] [157/160] (726s left) gem_lmem_swapping (verify-random) [276.330532] Subtest verify-random: SKIP (0.000s) [276.355947] [158/160] (726s left) i915_pm_rpm (module-reload) [279.044092] Starting subtest: module-reload [291.068914] Subtest module-reload: SUCCESS (12.032s) [291.111587] [159/160] (711s left) i915_selftest (live) [291.209666] Starting subtest: live [291.211639] Starting dynamic subtest: sanitycheck [292.502117] Dynamic subtest sanitycheck: SUCCESS (1.290s) [292.510756] Starting dynamic subtest: uncore [293.807835] Dynamic subtest uncore: SUCCESS (1.305s) [293.817228] Starting dynamic subtest: workarounds [295.373492] Dynamic subtest workarounds: SUCCESS (1.564s) [295.383442] Starting dynamic subtest: gt_engines [297.191772] Dynamic subtest gt_engines: SUCCESS (1.816s) [297.200881] Starting dynamic subtest: gt_timelines [309.368664] Dynamic subtest gt_timelines: SUCCESS (12.175s) [309.376437] Starting dynamic subtest: gt_contexts [310.794504] Dynamic subtest gt_contexts: SUCCESS (1.424s) [310.802795] Starting dynamic subtest: gt_lrc [315.067495] Dynamic subtest gt_lrc: SUCCESS (4.271s) [315.074158] Starting dynamic subtest: gt_mocs [316.501582] Dynamic subtest gt_mocs: SUCCESS (1.433s) [316.508167] Starting dynamic subtest: gt_pm [323.684533] Dynamic subtest gt_pm: SUCCESS (7.181s) [323.692211] Starting dynamic subtest: gt_heartbeat [325.061092] Dynamic subtest gt_heartbeat: SUCCESS (1.373s) [325.067953] Starting dynamic subtest: gt_tlb [327.520473] Dynamic subtest gt_tlb: SUCCESS (2.459s) [327.530399] Starting dynamic subtest: requests [336.392846] Dynamic subtest requests: SUCCESS (8.870s) [336.400984] Starting dynamic subtest: migrate [340.604653] Dynamic subtest migrate: SUCCESS (4.210s) [340.612172] Starting dynamic subtest: active [341.964466] Dynamic subtest active: SUCCESS (1.358s) [341.971426] Starting dynamic subtest: objects [344.164160] Dynamic subtest objects: SUCCESS (2.197s) [344.170475] Starting dynamic subtest: mman [349.215661] Dynamic subtest mman: SUCCESS (5.051s) [349.223418] Starting dynamic subtest: dmabuf [350.566607] Dynamic subtest dmabuf: SUCCESS (1.349s) [350.573939] Starting dynamic subtest: vma [351.829965] Dynamic subtest vma: SUCCESS (1.262s) [351.842523] Starting dynamic subtest: coherency [354.422538] Dynamic subtest coherency: SUCCESS (2.590s) [354.430389] Starting dynamic subtest: gtt [362.912849] Dynamic subtest gtt: SUCCESS (8.489s) [362.923424] Starting dynamic subtest: gem [364.341738] Dynamic subtest gem: SUCCESS (1.427s) [364.348921] Starting dynamic subtest: evict [367.452753] Dynamic subtest evict: SUCCESS (3.109s) [367.463036] Starting dynamic subtest: hugepages [374.680473] Dynamic subtest hugepages: SUCCESS (7.226s) [374.688222] Starting dynamic subtest: gem_contexts [392.668544] Dynamic subtest gem_contexts: SUCCESS (17.986s) [392.676904] Starting dynamic subtest: client [393.954490] Dynamic subtest client: SUCCESS (1.284s) [393.961895] Starting dynamic subtest: gem_migrate [395.221153] Dynamic subtest gem_migrate: SUCCESS (1.263s) [395.226979] Starting dynamic subtest: reset [397.133686] Dynamic subtest reset: SUCCESS (1.913s) [397.143240] Starting dynamic subtest: memory_region [398.377189] Dynamic subtest memory_region: SUCCESS (1.240s) [398.386710] Starting dynamic subtest: hangcheck [428.220596] Dynamic subtest hangcheck: SUCCESS (29.843s) [428.228047] Starting dynamic subtest: execlists [442.067570] Dynamic subtest execlists: SUCCESS (13.845s) [442.075697] Starting dynamic subtest: ring_submission [443.296676] Dynamic subtest ring_submission: SUCCESS (1.227s) [443.303525] Starting dynamic subtest: perf [444.741208] Dynamic subtest perf: SUCCESS (1.441s) [444.747061] Starting dynamic subtest: slpc [446.030524] Dynamic subtest slpc: SUCCESS (1.289s) [446.037782] Starting dynamic subtest: guc [447.339831] Dynamic subtest guc: SUCCESS (1.307s) [447.348660] Starting dynamic subtest: guc_multi_lrc [448.616103] Dynamic subtest guc_multi_lrc: SUCCESS (1.273s) [448.623079] Starting dynamic subtest: guc_hang [449.914454] Dynamic subtest guc_hang: SUCCESS (1.298s) [449.923516] Starting dynamic subtest: late_gt_pm [451.223684] Dynamic subtest late_gt_pm: SUCCESS (1.307s) [451.224744] Subtest live: SUCCESS (160.015s) [451.249239] [160/160] (551s left) dmabuf (all-tests) [451.311897] Starting subtest: all-tests [451.312502] Starting dynamic subtest: sanitycheck [451.387292] Dynamic subtest sanitycheck: SUCCESS (0.072s) [451.411805] Starting dynamic subtest: dma_fence [451.575135] Dynamic subtest dma_fence: SUCCESS (0.186s) [451.583607] Starting dynamic subtest: dma_fence_chain [465.702213] Dynamic subtest dma_fence_chain: SUCCESS (14.123s) [465.716374] Starting dynamic subtest: dma_fence_unwrap [465.777288] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [465.804231] Starting dynamic subtest: dma_resv [465.850210] Dynamic subtest dma_resv: SUCCESS (0.066s) [465.851504] Subtest all-tests: SUCCESS (14.538s) [465.880861] Closing watchdogs Done.