[31.740583] Initializing watchdogs [31.740634] /dev/watchdog0 [31.744778] [001/170] (960s left) i915_module_load (load) [31.788735] Starting subtest: load [32.373256] Subtest load: SUCCESS (0.584s) [32.382138] [002/170] (959s left) core_auth (basic-auth) [32.431821] Starting subtest: basic-auth [32.433100] Subtest basic-auth: SUCCESS (0.001s) [32.482034] [003/170] (959s left) debugfs_test (read_all_entries) [32.526743] Starting subtest: read_all_entries [32.573508] Subtest read_all_entries: SUCCESS (0.047s) [32.665179] [004/170] (959s left) debugfs_test (basic-hwmon) [32.705639] Starting subtest: basic-hwmon [32.707283] Subtest basic-hwmon: SKIP (0.000s) [32.799309] [005/170] (959s left) fbdev (eof) [32.856929] Starting subtest: eof [32.857870] Subtest eof: SUCCESS (0.000s) [32.905204] [006/170] (959s left) fbdev (info) [32.949561] Starting subtest: info [32.950443] Subtest info: SUCCESS (0.000s) [33.009627] [007/170] (959s left) fbdev (nullptr) [33.073775] Starting subtest: nullptr [33.074812] Subtest nullptr: SUCCESS (0.000s) [33.133606] [008/170] (959s left) fbdev (read) [33.207037] Starting subtest: read [33.785890] Subtest read: SUCCESS (0.578s) [33.815661] [009/170] (958s left) fbdev (write) [33.856536] Starting subtest: write [34.244359] Subtest write: SUCCESS (0.387s) [34.287452] [010/170] (958s left) gem_basic (bad-close) [34.332484] Starting subtest: bad-close [34.333892] Subtest bad-close: SUCCESS (0.000s) [34.386851] [011/170] (957s left) gem_basic (create-close) [34.448023] Starting subtest: create-close [34.449345] Subtest create-close: SUCCESS (0.000s) [34.549123] [012/170] (957s left) gem_basic (create-fd-close) [34.606665] Starting subtest: create-fd-close [34.608034] Subtest create-fd-close: SUCCESS (0.000s) [34.699651] [013/170] (957s left) gem_busy (busy@all-engines) [34.765263] Starting subtest: busy [34.765953] Starting dynamic subtest: all-engines [34.782732] Dynamic subtest all-engines: SUCCESS (0.017s) [34.783391] Subtest busy: SUCCESS (0.018s) [35.116227] [014/170] (957s left) gem_close_race (basic-process) [35.181311] Starting subtest: basic-process [35.205280] Subtest basic-process: SUCCESS (0.024s) [35.372290] [015/170] (957s left) gem_close_race (basic-threads) [35.423758] Starting subtest: basic-threads [36.620354] Subtest basic-threads: SUCCESS (1.196s) [36.814873] [016/170] (955s left) gem_ctx_create (basic) [36.885154] Starting subtest: basic [36.885973] Subtest basic: SUCCESS (0.000s) [37.067597] [017/170] (955s left) gem_ctx_create (basic-files) [37.129643] Starting subtest: basic-files [39.137973] Subtest basic-files: SUCCESS (2.008s) [39.333605] [018/170] (953s left) gem_ctx_exec (basic) [39.393687] Starting subtest: basic [39.395475] Subtest basic: SUCCESS (0.002s) [39.508414] [019/170] (953s left) gem_exec_basic (basic) [39.557382] Starting subtest: basic [39.558156] Starting dynamic subtest: rcs0-smem [39.558875] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [39.561840] Starting dynamic subtest: bcs0-smem [39.562578] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [39.565287] Starting dynamic subtest: vcs0-smem [39.566024] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [39.568691] Starting dynamic subtest: vecs0-smem [39.569351] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [39.569993] Subtest basic: SUCCESS (0.001s) [39.751231] [020/170] (952s left) gem_exec_create (basic) [39.814710] Starting subtest: basic [39.815474] Starting dynamic subtest: smem [41.859157] Dynamic subtest smem: SUCCESS (2.044s) [41.860221] Subtest basic: SUCCESS (2.044s) [42.033509] [021/170] (950s left) gem_exec_fence (basic-busy) [42.220808] Starting subtest: basic-busy [42.222266] Starting dynamic subtest: rcs0 [42.275161] Dynamic subtest rcs0: SUCCESS (0.054s) [42.282832] Starting dynamic subtest: bcs0 [42.317270] Dynamic subtest bcs0: SUCCESS (0.042s) [42.330741] Starting dynamic subtest: vcs0 [42.354232] Dynamic subtest vcs0: SUCCESS (0.037s) [42.367565] Starting dynamic subtest: vecs0 [42.385064] Dynamic subtest vecs0: SUCCESS (0.031s) [42.386821] Subtest basic-busy: SUCCESS (0.164s) [42.869243] [022/170] (949s left) gem_exec_fence (basic-wait) [43.056760] Starting subtest: basic-wait [43.058170] Starting dynamic subtest: rcs0 [43.103384] Dynamic subtest rcs0: SUCCESS (0.046s) [43.119295] Starting dynamic subtest: bcs0 [43.127142] Dynamic subtest bcs0: SUCCESS (0.024s) [43.136194] Starting dynamic subtest: vcs0 [43.161347] Dynamic subtest vcs0: SUCCESS (0.034s) [43.168536] Starting dynamic subtest: vecs0 [43.189181] Dynamic subtest vecs0: SUCCESS (0.027s) [43.191173] Subtest basic-wait: SUCCESS (0.132s) [43.652284] [023/170] (948s left) gem_exec_fence (basic-await) [43.822538] Starting subtest: basic-await [43.823324] Starting dynamic subtest: rcs0 [43.886911] Dynamic subtest rcs0: SUCCESS (0.064s) [43.890047] Starting dynamic subtest: bcs0 [43.950338] Dynamic subtest bcs0: SUCCESS (0.063s) [43.953512] Starting dynamic subtest: vcs0 [44.014403] Dynamic subtest vcs0: SUCCESS (0.064s) [44.017491] Starting dynamic subtest: vecs0 [44.079578] Dynamic subtest vecs0: SUCCESS (0.064s) [44.081303] Subtest basic-await: SUCCESS (0.256s) [44.518397] [024/170] (948s left) gem_exec_fence (nb-await) [44.700200] Starting subtest: nb-await [44.702126] Starting dynamic subtest: rcs0 [44.763469] Dynamic subtest rcs0: SUCCESS (0.063s) [44.771369] Starting dynamic subtest: bcs0 [44.823278] Dynamic subtest bcs0: SUCCESS (0.060s) [44.837483] Starting dynamic subtest: vcs0 [44.887492] Dynamic subtest vcs0: SUCCESS (0.064s) [44.901858] Starting dynamic subtest: vecs0 [44.951268] Dynamic subtest vecs0: SUCCESS (0.064s) [44.953068] Subtest nb-await: SUCCESS (0.252s) [45.402374] [025/170] (947s left) gem_exec_gttfill (basic) [45.466316] Starting subtest: basic [47.941419] Subtest basic: SUCCESS (2.475s) [48.119330] [026/170] (944s left) gem_exec_parallel (engines) [48.209064] Starting subtest: engines [48.209832] Starting dynamic subtest: basic [49.617077] Dynamic subtest basic: SUCCESS (1.408s) [49.620624] Starting dynamic subtest: contexts [51.346466] Dynamic subtest contexts: SUCCESS (1.729s) [51.352018] Starting dynamic subtest: fds [53.123189] Dynamic subtest fds: SUCCESS (1.776s) [53.138685] Starting dynamic subtest: userptr [54.507844] Dynamic subtest userptr: SUCCESS (1.385s) [54.508580] Subtest engines: SUCCESS (6.299s) [54.668128] [027/170] (938s left) gem_exec_store (basic) [54.711467] Starting subtest: basic [54.764093] Subtest basic: SUCCESS (0.052s) [54.936328] [028/170] (937s left) gem_flink_basic (bad-flink) [54.982904] Starting subtest: bad-flink [54.983742] Subtest bad-flink: SUCCESS (0.000s) [55.046286] [029/170] (937s left) gem_flink_basic (bad-open) [55.093114] Starting subtest: bad-open [55.093863] Subtest bad-open: SUCCESS (0.000s) [55.165731] [030/170] (937s left) gem_flink_basic (basic) [55.212475] Starting subtest: basic [55.213222] Subtest basic: SUCCESS (0.000s) [55.301615] [031/170] (937s left) gem_flink_basic (double-flink) [55.357413] Starting subtest: double-flink [55.358294] Subtest double-flink: SUCCESS (0.000s) [55.438380] [032/170] (937s left) gem_flink_basic (flink-lifetime) [55.498569] Starting subtest: flink-lifetime [55.499467] Subtest flink-lifetime: SUCCESS (0.001s) [55.585363] [033/170] (937s left) gem_huc_copy (huc-copy) [55.645514] Starting subtest: huc-copy [55.647168] Subtest huc-copy: SKIP (0.000s) [55.752658] [034/170] (937s left) gem_linear_blits (basic) [55.868395] Starting subtest: basic [55.871900] Subtest basic: SUCCESS (0.004s) [55.994206] [035/170] (936s left) gem_mmap (basic) [56.081778] Starting subtest: basic [56.085130] Subtest basic: SUCCESS (0.000s) [56.180504] [036/170] (936s left) gem_mmap_gtt (basic) [56.232789] Starting subtest: basic [56.233619] Subtest basic: SUCCESS (0.000s) [56.284463] [037/170] (936s left) gem_render_linear_blits (basic) [56.337773] Starting subtest: basic [56.361494] Subtest basic: SUCCESS (0.024s) [56.400920] [038/170] (936s left) gem_render_tiled_blits (basic) [56.449990] Starting subtest: basic [56.469138] Subtest basic: SUCCESS (0.019s) [56.522521] [039/170] (936s left) gem_ringfill (basic-all) [56.736386] Starting subtest: basic-all [57.842793] Subtest basic-all: SUCCESS (1.109s) [57.949912] [040/170] (935s left) gem_softpin (allocator-basic) [58.014012] Starting subtest: allocator-basic [58.061824] Subtest allocator-basic: SUCCESS (0.048s) [58.165211] [041/170] (934s left) gem_softpin (allocator-basic-reserve) [58.207673] Starting subtest: allocator-basic-reserve [58.255137] Subtest allocator-basic-reserve: SUCCESS (0.047s) [58.352135] [042/170] (934s left) gem_softpin (safe-alignment) [58.410190] Starting subtest: safe-alignment [58.416219] Subtest safe-alignment: SUCCESS (0.006s) [58.515164] [043/170] (934s left) gem_sync (basic-all) [58.560564] Starting subtest: basic-all [60.665091] Subtest basic-all: SUCCESS (2.106s) [60.848198] [044/170] (932s left) gem_sync (basic-each) [60.895179] Starting subtest: basic-each [62.954009] Subtest basic-each: SUCCESS (2.060s) [63.165683] [045/170] (929s left) gem_tiled_blits (basic) [63.265436] Starting subtest: basic [63.274398] Subtest basic: SUCCESS (0.009s) [63.375904] [046/170] (929s left) gem_tiled_fence_blits (basic) [63.506771] Starting subtest: basic [63.525758] Subtest basic: SUCCESS (0.020s) [63.626658] [047/170] (929s left) gem_tiled_pread_basic [63.746757] [048/170] (929s left) gem_wait (busy@all-engines) [63.803884] Starting subtest: busy [63.804543] Starting dynamic subtest: all-engines [64.318183] Dynamic subtest all-engines: SUCCESS (0.514s) [64.319023] Subtest busy: SUCCESS (0.514s) [64.520225] [049/170] (928s left) gem_wait (wait@all-engines) [64.581255] Starting subtest: wait [64.582113] Starting dynamic subtest: all-engines [65.622256] Dynamic subtest all-engines: SUCCESS (1.040s) [65.624204] Subtest wait: SUCCESS (1.040s) [65.816705] [050/170] (927s left) i915_getparams_basic (basic-eu-total) [65.871599] Starting subtest: basic-eu-total [65.873103] Subtest basic-eu-total: SUCCESS (0.000s) [65.927065] [051/170] (927s left) i915_getparams_basic (basic-subslice-total) [65.983907] Starting subtest: basic-subslice-total [65.985323] Subtest basic-subslice-total: SUCCESS (0.000s) [66.046444] [052/170] (927s left) i915_hangman (error-state-basic) [66.107238] Starting subtest: error-state-basic [66.110894] Subtest error-state-basic: SUCCESS (0.003s) [66.221609] [053/170] (926s left) i915_pciid [66.349148] [054/170] (926s left) kms_addfb_basic (addfb25-bad-modifier) [66.404154] Starting subtest: addfb25-bad-modifier [66.404819] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [66.528880] [055/170] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [66.574122] Starting subtest: addfb25-framebuffer-vs-set-tiling [66.574899] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [66.666308] [056/170] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [66.706325] Starting subtest: addfb25-modifier-no-flag [66.707101] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [66.799903] [057/170] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [66.840314] Starting subtest: addfb25-x-tiled-legacy [66.841165] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [66.958537] [058/170] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [67.004545] Starting subtest: addfb25-x-tiled-mismatch-legacy [67.005280] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [67.130083] [059/170] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [67.218962] Starting subtest: addfb25-yf-tiled-legacy [67.219724] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [67.282636] [060/170] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [67.357541] Starting subtest: addfb25-y-tiled-legacy [67.358381] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [67.444533] [061/170] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [67.533770] Starting subtest: addfb25-y-tiled-small-legacy [67.534527] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [67.600122] [062/170] (925s left) kms_addfb_basic (bad-pitch-0) [67.651292] Starting subtest: bad-pitch-0 [67.652034] Subtest bad-pitch-0: SUCCESS (0.000s) [67.750630] [063/170] (925s left) kms_addfb_basic (bad-pitch-1024) [67.795134] Starting subtest: bad-pitch-1024 [67.795891] Subtest bad-pitch-1024: SUCCESS (0.000s) [67.906844] [064/170] (925s left) kms_addfb_basic (bad-pitch-128) [67.962528] Starting subtest: bad-pitch-128 [67.963205] Subtest bad-pitch-128: SUCCESS (0.000s) [68.070349] [065/170] (925s left) kms_addfb_basic (bad-pitch-256) [68.116542] Starting subtest: bad-pitch-256 [68.117281] Subtest bad-pitch-256: SUCCESS (0.000s) [68.217370] [066/170] (925s left) kms_addfb_basic (bad-pitch-32) [68.261483] Starting subtest: bad-pitch-32 [68.262387] Subtest bad-pitch-32: SUCCESS (0.000s) [68.372503] [067/170] (925s left) kms_addfb_basic (bad-pitch-63) [68.429222] Starting subtest: bad-pitch-63 [68.430030] Subtest bad-pitch-63: SUCCESS (0.000s) [68.537516] [068/170] (924s left) kms_addfb_basic (bad-pitch-65536) [68.594575] Starting subtest: bad-pitch-65536 [68.595468] Subtest bad-pitch-65536: SUCCESS (0.000s) [68.707907] [069/170] (924s left) kms_addfb_basic (bad-pitch-999) [68.764316] Starting subtest: bad-pitch-999 [68.765058] Subtest bad-pitch-999: SUCCESS (0.000s) [68.902219] [070/170] (924s left) kms_addfb_basic (basic) [68.957967] Starting subtest: basic [68.958712] Subtest basic: SUCCESS (0.000s) [69.049739] [071/170] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [69.089244] Starting subtest: basic-x-tiled-legacy [69.090023] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [69.183162] [072/170] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [69.222263] Starting subtest: basic-y-tiled-legacy [69.223058] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [69.342075] [073/170] (924s left) kms_addfb_basic (bo-too-small) [69.420713] Starting subtest: bo-too-small [69.421505] Subtest bo-too-small: SUCCESS (0.000s) [69.483110] [074/170] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [69.565126] Starting subtest: bo-too-small-due-to-tiling [69.565855] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [69.633839] [075/170] (923s left) kms_addfb_basic (clobberred-modifier) [69.678305] Starting subtest: clobberred-modifier [69.679104] Subtest clobberred-modifier: SUCCESS (0.000s) [69.788644] [076/170] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [69.844796] Starting subtest: framebuffer-vs-set-tiling [69.845552] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [69.954295] [077/170] (923s left) kms_addfb_basic (invalid-get-prop) [70.010253] Starting subtest: invalid-get-prop [70.010994] Subtest invalid-get-prop: SUCCESS (0.000s) [70.099698] [078/170] (923s left) kms_addfb_basic (invalid-get-prop-any) [70.142392] Starting subtest: invalid-get-prop-any [70.143322] Subtest invalid-get-prop-any: SUCCESS (0.000s) [70.256511] [079/170] (923s left) kms_addfb_basic (invalid-set-prop) [70.309201] Starting subtest: invalid-set-prop [70.309942] Subtest invalid-set-prop: SUCCESS (0.000s) [70.399788] [080/170] (923s left) kms_addfb_basic (invalid-set-prop-any) [70.444028] Starting subtest: invalid-set-prop-any [70.444753] Subtest invalid-set-prop-any: SUCCESS (0.000s) [70.555016] [081/170] (923s left) kms_addfb_basic (no-handle) [70.608428] Starting subtest: no-handle [70.609220] Subtest no-handle: SUCCESS (0.000s) [70.728203] [082/170] (922s left) kms_addfb_basic (size-max) [70.807979] Starting subtest: size-max [70.808747] Subtest size-max: SUCCESS (0.000s) [70.891929] [083/170] (922s left) kms_addfb_basic (small-bo) [70.972792] Starting subtest: small-bo [70.973547] Subtest small-bo: SUCCESS (0.000s) [71.062583] [084/170] (922s left) kms_addfb_basic (tile-pitch-mismatch) [71.117382] Starting subtest: tile-pitch-mismatch [71.118259] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [71.250377] [085/170] (922s left) kms_addfb_basic (too-high) [71.337789] Starting subtest: too-high [71.338529] Subtest too-high: SUCCESS (0.000s) [71.399800] [086/170] (922s left) kms_addfb_basic (too-wide) [71.478024] Starting subtest: too-wide [71.478931] Subtest too-wide: SUCCESS (0.000s) [71.532677] [087/170] (922s left) kms_addfb_basic (unused-handle) [71.572919] Starting subtest: unused-handle [71.573721] Subtest unused-handle: SUCCESS (0.000s) [71.665924] [088/170] (922s left) kms_addfb_basic (unused-modifier) [71.714157] Starting subtest: unused-modifier [71.714902] Subtest unused-modifier: SUCCESS (0.000s) [71.818952] [089/170] (921s left) kms_addfb_basic (unused-offsets) [71.871630] Starting subtest: unused-offsets [71.872395] Subtest unused-offsets: SUCCESS (0.000s) [71.966486] [090/170] (921s left) kms_addfb_basic (unused-pitches) [72.007302] Starting subtest: unused-pitches [72.008042] Subtest unused-pitches: SUCCESS (0.000s) [72.130553] [091/170] (921s left) kms_busy (basic) [72.223346] Starting subtest: basic [72.224085] Starting dynamic subtest: flip [72.761327] Dynamic subtest flip: SUCCESS (0.537s) [72.764936] Starting dynamic subtest: modeset [73.394933] Dynamic subtest modeset: SUCCESS (0.632s) [73.395749] Subtest basic: SUCCESS (1.170s) [73.521694] [092/170] (920s left) kms_chamelium_hpd (dp-hpd-fast) [73.665706] Subtest dp-hpd-fast: SKIP (0.000s) [73.726045] [093/170] (920s left) kms_chamelium_edid (dp-edid-read) [73.875589] Subtest dp-edid-read: SKIP (0.000s) [73.938015] [094/170] (919s left) kms_chamelium_frames (dp-crc-fast) [74.086120] Subtest dp-crc-fast: SKIP (0.000s) [74.146761] [095/170] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [74.295824] Subtest hdmi-hpd-fast: SKIP (0.000s) [74.356315] [096/170] (919s left) kms_chamelium_edid (hdmi-edid-read) [74.504735] Subtest hdmi-edid-read: SKIP (0.000s) [74.565024] [097/170] (919s left) kms_chamelium_frames (hdmi-crc-fast) [74.713724] Subtest hdmi-crc-fast: SKIP (0.000s) [74.775153] [098/170] (919s left) kms_chamelium_hpd (vga-hpd-fast) [74.923593] Subtest vga-hpd-fast: SKIP (0.000s) [74.985538] [099/170] (918s left) kms_chamelium_edid (vga-edid-read) [75.133822] Subtest vga-edid-read: SKIP (0.000s) [75.195245] [100/170] (918s left) kms_prop_blob (basic) [75.234181] Starting subtest: basic [75.235035] Subtest basic: SUCCESS (0.000s) [75.281678] [101/170] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [75.354891] Starting subtest: basic-busy-flip-before-cursor-atomic [75.356160] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [75.398605] [102/170] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [75.470995] Starting subtest: basic-busy-flip-before-cursor-legacy [75.472321] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [75.515413] [103/170] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [75.589167] Starting subtest: basic-flip-after-cursor-atomic [76.559388] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.972s) [76.659582] [104/170] (917s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [76.731319] Starting subtest: basic-flip-after-cursor-legacy [77.702541] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.972s) [77.816946] [105/170] (916s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [77.889365] Starting subtest: basic-flip-after-cursor-varying-size [78.860494] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.972s) [78.972769] [106/170] (914s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [79.046469] Starting subtest: basic-flip-before-cursor-atomic [80.016540] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.972s) [80.116102] [107/170] (913s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [80.189030] Starting subtest: basic-flip-before-cursor-legacy [81.159512] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.972s) [81.276105] [108/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [81.347046] Starting subtest: basic-flip-before-cursor-varying-size [82.319567] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.973s) [82.436386] [109/170] (911s left) kms_flip (basic-flip-vs-dpms) [82.503363] Starting subtest: basic-flip-vs-dpms [82.504087] Starting dynamic subtest: A-HDMI-A1 [83.437033] Dynamic subtest A-HDMI-A1: SUCCESS (0.933s) [83.440867] Starting dynamic subtest: B-HDMI-A1 [84.333310] Dynamic subtest B-HDMI-A1: SUCCESS (0.896s) [84.337032] Starting dynamic subtest: C-HDMI-A1 [85.206028] Dynamic subtest C-HDMI-A1: SUCCESS (0.872s) [85.206838] Subtest basic-flip-vs-dpms: SUCCESS (2.703s) [85.326740] [110/170] (908s left) kms_flip (basic-flip-vs-modeset) [85.394499] Starting subtest: basic-flip-vs-modeset [85.395287] Starting dynamic subtest: A-HDMI-A1 [86.346989] Dynamic subtest A-HDMI-A1: SUCCESS (0.952s) [86.352086] Starting dynamic subtest: B-HDMI-A1 [87.132473] Dynamic subtest B-HDMI-A1: SUCCESS (0.785s) [87.136358] Starting dynamic subtest: C-HDMI-A1 [88.024758] Dynamic subtest C-HDMI-A1: SUCCESS (0.891s) [88.025415] Subtest basic-flip-vs-modeset: SUCCESS (2.631s) [88.146401] [111/170] (905s left) kms_flip (basic-flip-vs-wf_vblank) [88.222089] Starting subtest: basic-flip-vs-wf_vblank [88.222843] Starting dynamic subtest: A-HDMI-A1 [89.401962] Dynamic subtest A-HDMI-A1: SUCCESS (1.180s) [89.408553] Starting dynamic subtest: B-HDMI-A1 [90.550393] Dynamic subtest B-HDMI-A1: SUCCESS (1.148s) [90.557416] Starting dynamic subtest: C-HDMI-A1 [91.692549] Dynamic subtest C-HDMI-A1: SUCCESS (1.141s) [91.693587] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.473s) [91.856762] [112/170] (902s left) kms_flip (basic-plain-flip) [91.925196] Starting subtest: basic-plain-flip [91.925955] Starting dynamic subtest: A-HDMI-A1 [92.811433] Dynamic subtest A-HDMI-A1: SUCCESS (0.885s) [92.819338] Starting dynamic subtest: B-HDMI-A1 [93.673967] Dynamic subtest B-HDMI-A1: SUCCESS (0.861s) [93.680696] Starting dynamic subtest: C-HDMI-A1 [94.531225] Dynamic subtest C-HDMI-A1: SUCCESS (0.857s) [94.532284] Subtest basic-plain-flip: SUCCESS (2.608s) [94.693320] [113/170] (899s left) kms_force_connector_basic (force-connector-state) [94.818400] Starting subtest: force-connector-state [95.816630] Subtest force-connector-state: SUCCESS (0.999s) [96.077391] [114/170] (897s left) kms_force_connector_basic (force-edid) [96.200235] Starting subtest: force-edid [96.336368] Subtest force-edid: SUCCESS (0.136s) [96.493573] [115/170] (897s left) kms_force_connector_basic (force-load-detect) [96.614837] Starting subtest: force-load-detect [96.616173] Subtest force-load-detect: SKIP (0.000s) [96.777200] [116/170] (897s left) kms_force_connector_basic (prune-stale-modes) [96.899433] Starting subtest: prune-stale-modes [97.037568] Subtest prune-stale-modes: SUCCESS (0.138s) [97.210344] [117/170] (896s left) kms_frontbuffer_tracking (basic) [97.286022] Starting subtest: basic [100.085705] Subtest basic: SUCCESS (2.800s) [100.200421] [118/170] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [100.291409] Starting subtest: compare-crc-sanitycheck [100.292249] Starting dynamic subtest: pipe-A-HDMI-A-1 [100.721038] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.433s) [100.727069] Starting dynamic subtest: pipe-B-HDMI-A-1 [101.307380] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.583s) [101.313227] Starting dynamic subtest: pipe-C-HDMI-A-1 [102.096543] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.786s) [102.097269] Subtest compare-crc-sanitycheck: SUCCESS (1.810s) [102.217958] [119/170] (891s left) kms_pipe_crc_basic (hang-read-crc) [102.290057] Starting subtest: hang-read-crc [102.290737] Starting dynamic subtest: pipe-A-HDMI-A-1 [103.317352] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.027s) [103.323198] Starting dynamic subtest: pipe-B-HDMI-A-1 [104.688497] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.368s) [104.694353] Starting dynamic subtest: pipe-C-HDMI-A-1 [106.485091] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.793s) [106.485955] Subtest hang-read-crc: SUCCESS (4.195s) [106.578853] [120/170] (887s left) kms_pipe_crc_basic (nonblocking-crc) [106.652573] Starting subtest: nonblocking-crc [106.653309] Starting dynamic subtest: pipe-A-HDMI-A-1 [107.240404] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.588s) [107.246372] Starting dynamic subtest: pipe-B-HDMI-A-1 [107.984516] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.741s) [107.990312] Starting dynamic subtest: pipe-C-HDMI-A-1 [108.951509] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.964s) [108.952197] Subtest nonblocking-crc: SUCCESS (2.300s) [109.045643] [121/170] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [109.118226] Starting subtest: nonblocking-crc-frame-sequence [109.119099] Starting dynamic subtest: pipe-A-HDMI-A-1 [109.739845] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.620s) [109.745191] Starting dynamic subtest: pipe-B-HDMI-A-1 [110.485659] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.743s) [110.491327] Starting dynamic subtest: pipe-C-HDMI-A-1 [111.448610] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.960s) [111.449355] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.331s) [111.542532] [122/170] (882s left) kms_pipe_crc_basic (read-crc) [111.629172] Starting subtest: read-crc [111.629949] Starting dynamic subtest: pipe-A-HDMI-A-1 [112.169495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.541s) [112.175224] Starting dynamic subtest: pipe-B-HDMI-A-1 [112.852615] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.680s) [112.858363] Starting dynamic subtest: pipe-C-HDMI-A-1 [113.750487] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.895s) [113.751155] Subtest read-crc: SUCCESS (2.123s) [113.844404] [123/170] (880s left) kms_pipe_crc_basic (read-crc-frame-sequence) [113.927203] Starting subtest: read-crc-frame-sequence [113.927898] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.456326] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.529s) [114.462222] Starting dynamic subtest: pipe-B-HDMI-A-1 [115.137409] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.678s) [115.143271] Starting dynamic subtest: pipe-C-HDMI-A-1 [116.042564] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.901s) [116.043405] Subtest read-crc-frame-sequence: SUCCESS (2.116s) [116.135540] [124/170] (877s left) kms_psr (primary_page_flip) [116.175778] Subtest primary_page_flip: SKIP (0.000s) [116.197103] [125/170] (877s left) kms_psr (cursor_plane_move) [116.236540] Subtest cursor_plane_move: SKIP (0.000s) [116.247013] [126/170] (877s left) kms_psr (sprite_plane_onoff) [116.288130] Subtest sprite_plane_onoff: SKIP (0.000s) [116.315919] [127/170] (877s left) kms_psr (primary_mmap_gtt) [116.368769] Subtest primary_mmap_gtt: SKIP (0.000s) [116.380426] [128/170] (877s left) kms_setmode (basic-clone-single-crtc) [116.420056] Starting subtest: basic-clone-single-crtc [116.422134] Subtest basic-clone-single-crtc: SKIP (0.000s) [116.496771] [129/170] (877s left) i915_pm_backlight (basic-brightness) [116.580411] Subtest basic-brightness: SKIP (0.000s) [116.597284] [130/170] (877s left) i915_pm_rpm (basic-pci-d3-state) [118.099072] Starting subtest: basic-pci-d3-state [118.582036] Subtest basic-pci-d3-state: SUCCESS (0.484s) [118.730108] [131/170] (875s left) i915_pm_rpm (basic-rte) [118.773948] Starting subtest: basic-rte [120.701840] Subtest basic-rte: SUCCESS (1.928s) [121.294202] [132/170] (872s left) i915_pm_rps (basic-api) [121.334965] Starting subtest: basic-api [121.336827] Subtest basic-api: SUCCESS (0.001s) [121.413723] [133/170] (872s left) prime_self_import (basic-llseek-bad) [121.462618] Starting subtest: basic-llseek-bad [121.464124] Subtest basic-llseek-bad: SUCCESS (0.001s) [121.550435] [134/170] (872s left) prime_self_import (basic-llseek-size) [121.593169] Starting subtest: basic-llseek-size [121.594573] Subtest basic-llseek-size: SUCCESS (0.001s) [121.685052] [135/170] (872s left) prime_self_import (basic-with_fd_dup) [121.735947] Starting subtest: basic-with_fd_dup [121.737324] Subtest basic-with_fd_dup: SUCCESS (0.001s) [121.834741] [136/170] (872s left) prime_self_import (basic-with_one_bo) [121.887181] Starting subtest: basic-with_one_bo [121.888624] Subtest basic-with_one_bo: SUCCESS (0.001s) [121.949194] [137/170] (872s left) prime_self_import (basic-with_one_bo_two_files) [122.000103] Starting subtest: basic-with_one_bo_two_files [122.001532] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [122.099269] [138/170] (872s left) prime_self_import (basic-with_two_bos) [122.152677] Starting subtest: basic-with_two_bos [122.154398] Subtest basic-with_two_bos: SUCCESS (0.001s) [122.249344] [139/170] (872s left) prime_vgem (basic-fence-flip) [122.320423] Starting subtest: basic-fence-flip [122.735234] Subtest basic-fence-flip: SUCCESS (0.414s) [122.833642] [140/170] (871s left) prime_vgem (basic-fence-mmap) [122.915784] Starting subtest: basic-fence-mmap [122.932309] Subtest basic-fence-mmap: SUCCESS (0.017s) [123.033232] [141/170] (871s left) prime_vgem (basic-fence-read) [123.115129] Starting subtest: basic-fence-read [123.120029] Subtest basic-fence-read: SKIP (0.004s) [123.214726] [142/170] (871s left) prime_vgem (basic-gtt) [123.313653] Starting subtest: basic-gtt [123.325142] Subtest basic-gtt: SUCCESS (0.012s) [123.432626] [143/170] (870s left) prime_vgem (basic-read) [123.515814] Starting subtest: basic-read [123.521313] Subtest basic-read: SKIP (0.005s) [123.617337] [144/170] (870s left) prime_vgem (basic-write) [123.686872] Starting subtest: basic-write [123.690508] Subtest basic-write: SKIP (0.003s) [123.798092] [145/170] (870s left) vgem_basic (setversion) [123.868353] Starting subtest: setversion [123.870081] Subtest setversion: SUCCESS (0.000s) [123.934421] [146/170] (870s left) vgem_basic (create) [123.984616] Starting subtest: create [123.985558] Subtest create: SUCCESS (0.000s) [124.042248] [147/170] (870s left) vgem_basic (debugfs) [124.101475] Starting subtest: debugfs [124.102237] Subtest debugfs: SUCCESS (0.000s) [124.157823] [148/170] (870s left) vgem_basic (dmabuf-export) [124.218291] Starting subtest: dmabuf-export [124.219852] Subtest dmabuf-export: SUCCESS (0.001s) [124.316924] [149/170] (870s left) vgem_basic (dmabuf-fence) [124.384881] Starting subtest: dmabuf-fence [124.385659] Subtest dmabuf-fence: SUCCESS (0.000s) [124.445835] [150/170] (870s left) vgem_basic (dmabuf-fence-before) [124.501352] Starting subtest: dmabuf-fence-before [124.502138] Subtest dmabuf-fence-before: SUCCESS (0.000s) [124.561157] [151/170] (870s left) vgem_basic (dmabuf-mmap) [124.617806] Starting subtest: dmabuf-mmap [124.624401] Subtest dmabuf-mmap: SUCCESS (0.007s) [124.666944] [152/170] (869s left) vgem_basic (mmap) [124.717968] Starting subtest: mmap [124.722205] Subtest mmap: SUCCESS (0.005s) [124.771132] [153/170] (869s left) vgem_basic (second-client) [124.834364] Starting subtest: second-client [124.885737] Subtest second-client: SUCCESS (0.051s) [124.949183] [154/170] (869s left) vgem_basic (sysfs) [125.018390] Starting subtest: sysfs [125.019247] Subtest sysfs: SUCCESS (0.000s) [125.079994] [155/170] (869s left) core_hotunplug (unbind-rebind) [125.150646] Starting subtest: unbind-rebind [125.993017] Subtest unbind-rebind: SUCCESS (0.842s) [126.021157] [156/170] (868s left) vgem_basic (unload) [126.062183] Starting subtest: unload [154.953622] Subtest unload: SUCCESS (28.890s) [155.057868] [157/170] (839s left) i915_module_load (reload) [155.109153] Starting subtest: reload [156.649029] Subtest reload: SUCCESS (1.540s) [156.657724] [158/170] (838s left) gem_lmem_swapping (basic) [156.716996] Subtest basic: SKIP (0.000s) [156.737517] [159/170] (837s left) gem_lmem_swapping (parallel-random-engines) [156.778097] Subtest parallel-random-engines: SKIP (0.000s) [156.804389] [160/170] (837s left) gem_lmem_swapping (random-engines) [156.844743] Subtest random-engines: SKIP (0.000s) [156.872505] [161/170] (837s left) gem_lmem_swapping (verify-random) [156.926032] Subtest verify-random: SKIP (0.000s) [156.937449] [162/170] (837s left) i915_pm_rpm (module-reload) [158.757770] Starting subtest: module-reload [166.117082] Subtest module-reload: SUCCESS (7.358s) [166.142740] [163/170] (828s left) i915_selftest (live) [166.194547] Starting subtest: live [166.195483] Starting dynamic subtest: sanitycheck [166.614562] Dynamic subtest sanitycheck: SUCCESS (0.419s) [166.623718] Starting dynamic subtest: uncore [167.086758] Dynamic subtest uncore: SUCCESS (0.471s) [167.097444] Starting dynamic subtest: workarounds [167.720504] Dynamic subtest workarounds: SUCCESS (0.632s) [167.729713] Starting dynamic subtest: gt_engines [168.630519] Dynamic subtest gt_engines: SUCCESS (0.909s) [168.637808] Starting dynamic subtest: gt_timelines [173.914290] Dynamic subtest gt_timelines: SUCCESS (5.283s) [173.923333] Starting dynamic subtest: gt_contexts [174.438042] Dynamic subtest gt_contexts: SUCCESS (0.522s) [174.445487] Starting dynamic subtest: gt_lrc [177.174677] Dynamic subtest gt_lrc: SUCCESS (2.735s) [177.182014] Starting dynamic subtest: gt_mocs [177.705283] Dynamic subtest gt_mocs: SUCCESS (0.530s) [177.712412] Starting dynamic subtest: gt_pm [189.317195] Dynamic subtest gt_pm: SUCCESS (11.610s) [189.329046] Starting dynamic subtest: gt_heartbeat [189.857568] Dynamic subtest gt_heartbeat: SUCCESS (0.539s) [189.867905] Starting dynamic subtest: gt_tlb [191.547068] Dynamic subtest gt_tlb: SUCCESS (1.681s) [191.553346] Starting dynamic subtest: requests [198.260857] Dynamic subtest requests: SUCCESS (6.719s) [198.269131] Starting dynamic subtest: migrate [201.475954] Dynamic subtest migrate: SUCCESS (3.214s) [201.484679] Starting dynamic subtest: active [201.928408] Dynamic subtest active: SUCCESS (0.452s) [201.937528] Starting dynamic subtest: objects [202.903309] Dynamic subtest objects: SUCCESS (0.974s) [202.911383] Starting dynamic subtest: mman [206.736652] Dynamic subtest mman: SUCCESS (3.832s) [206.743913] Starting dynamic subtest: dmabuf [207.242562] Dynamic subtest dmabuf: SUCCESS (0.505s) [207.251633] Starting dynamic subtest: vma [207.706309] Dynamic subtest vma: SUCCESS (0.463s) [207.714972] Starting dynamic subtest: coherency [208.807818] Dynamic subtest coherency: SUCCESS (1.100s) [208.818184] Starting dynamic subtest: gtt [216.452574] Dynamic subtest gtt: SUCCESS (7.644s) [216.461845] Starting dynamic subtest: gem [217.041909] Dynamic subtest gem: SUCCESS (0.588s) [217.049871] Starting dynamic subtest: evict [218.070862] Dynamic subtest evict: SUCCESS (1.027s) [218.078068] Starting dynamic subtest: hugepages [224.129806] Dynamic subtest hugepages: SUCCESS (6.057s) [224.136842] Starting dynamic subtest: gem_contexts [235.358988] Dynamic subtest gem_contexts: SUCCESS (11.228s) [235.366724] Starting dynamic subtest: client [235.816185] Dynamic subtest client: SUCCESS (0.456s) [235.825558] Starting dynamic subtest: gem_migrate [236.236343] Dynamic subtest gem_migrate: SUCCESS (0.419s) [236.245712] Starting dynamic subtest: reset [239.885127] Dynamic subtest reset: SUCCESS (3.648s) [239.893363] Starting dynamic subtest: memory_region [240.332791] Dynamic subtest memory_region: SUCCESS (0.446s) [240.340413] Starting dynamic subtest: hangcheck [263.902331] Dynamic subtest hangcheck: SUCCESS (23.568s) [263.910166] Starting dynamic subtest: execlists [271.678514] Dynamic subtest execlists: SUCCESS (7.775s) [271.685952] Starting dynamic subtest: ring_submission [272.143244] Dynamic subtest ring_submission: SUCCESS (0.464s) [272.150361] Starting dynamic subtest: perf [272.615524] Dynamic subtest perf: SUCCESS (0.471s) [272.622642] Starting dynamic subtest: slpc [273.048486] Dynamic subtest slpc: SUCCESS (0.432s) [273.057655] Starting dynamic subtest: guc [273.482361] Dynamic subtest guc: SUCCESS (0.433s) [273.489290] Starting dynamic subtest: guc_multi_lrc [273.904141] Dynamic subtest guc_multi_lrc: SUCCESS (0.421s) [273.912546] Starting dynamic subtest: guc_hang [274.330268] Dynamic subtest guc_hang: SUCCESS (0.424s) [274.337686] Starting dynamic subtest: late_gt_pm [274.787310] Dynamic subtest late_gt_pm: SUCCESS (0.456s) [274.788806] Subtest live: SUCCESS (108.592s) [274.979507] [164/170] (719s left) dmabuf (all-tests) [275.027606] Starting subtest: all-tests [275.028772] Starting dynamic subtest: sanitycheck [275.089170] Dynamic subtest sanitycheck: SUCCESS (0.061s) [275.095284] Starting dynamic subtest: dma_fence [275.260301] Dynamic subtest dma_fence: SUCCESS (0.170s) [275.273921] Starting dynamic subtest: dma_fence_chain [284.931448] Dynamic subtest dma_fence_chain: SUCCESS (9.670s) [284.939425] Starting dynamic subtest: dma_fence_unwrap [285.008102] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s) [285.021425] Starting dynamic subtest: dma_resv [285.082075] Dynamic subtest dma_resv: SUCCESS (0.073s) [285.083709] Subtest all-tests: SUCCESS (10.054s) [285.112770] [165/170] (709s left) i915_suspend (basic-s2idle-without-i915) [285.163048] Starting subtest: basic-s2idle-without-i915 [301.571327] Subtest basic-s2idle-without-i915: SUCCESS (2.562s) [307.682852] [166/170] (706s left) i915_suspend (basic-s3-without-i915) [307.724988] Starting subtest: basic-s3-without-i915 [342.691630] Subtest basic-s3-without-i915: SUCCESS (16.382s) [347.804362] [167/170] (690s left) gem_exec_suspend (basic-s0) [347.855887] Starting subtest: basic-S0 [347.856623] Starting dynamic subtest: smem [364.821789] Dynamic subtest smem: SUCCESS (4.505s) [364.822707] Subtest basic-S0: SUCCESS (4.505s) [375.972673] [168/170] (685s left) gem_exec_suspend (basic-s3) [376.025144] Starting subtest: basic-S3 [376.025871] Starting dynamic subtest: smem [396.934031] Dynamic subtest smem: SUCCESS (11.462s) [396.934713] Subtest basic-S3: SUCCESS (11.462s) [402.066953] [169/170] (674s left) kms_chamelium_hpd (common-hpd-after-suspend) [402.202275] Subtest common-hpd-after-suspend: SKIP (0.000s) [402.263116] [170/170] (673s left) kms_pipe_crc_basic (suspend-read-crc) [402.329352] Starting subtest: suspend-read-crc [402.330907] Starting dynamic subtest: pipe-A-HDMI-A-1 [429.990627] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.497s) [429.997420] Starting dynamic subtest: pipe-B-HDMI-A-1 [452.183847] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.595s) [452.190784] Starting dynamic subtest: pipe-C-HDMI-A-1 [487.380279] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.560s) [487.380961] Subtest suspend-read-crc: SUCCESS (18.660s) [492.446387] Closing watchdogs Done.