[45.107704] Initializing watchdogs [45.107802] /dev/watchdog0 [45.113512] [001/171] (960s left) i915_module_load (load) [45.324949] Starting subtest: load [46.241514] Subtest load: SUCCESS (0.911s) [46.263728] [002/171] (959s left) core_auth (basic-auth) [46.365427] Starting subtest: basic-auth [46.366481] Subtest basic-auth: SUCCESS (0.000s) [46.415982] [003/171] (959s left) debugfs_test (read_all_entries) [46.483361] Starting subtest: read_all_entries [46.519946] Subtest read_all_entries: SUCCESS (0.036s) [46.596634] [004/171] (959s left) debugfs_test (basic-hwmon) [46.661286] Starting subtest: basic-hwmon [46.663437] Subtest basic-hwmon: SKIP (0.000s) [46.730176] [005/171] (958s left) fbdev (eof) [46.802466] Starting subtest: eof [46.803670] Subtest eof: SUCCESS (0.000s) [46.848562] [006/171] (958s left) fbdev (info) [46.909362] Starting subtest: info [46.910521] Subtest info: SUCCESS (0.000s) [46.966648] [007/171] (958s left) fbdev (nullptr) [47.035458] Starting subtest: nullptr [47.036613] Subtest nullptr: SUCCESS (0.000s) [47.084745] [008/171] (958s left) fbdev (read) [47.152136] Starting subtest: read [47.230316] Subtest read: SUCCESS (0.078s) [47.264419] [009/171] (958s left) fbdev (write) [47.335699] Starting subtest: write [47.375822] Subtest write: SUCCESS (0.040s) [47.414595] [010/171] (958s left) gem_basic (bad-close) [47.476835] Starting subtest: bad-close [47.478849] Subtest bad-close: SUCCESS (0.000s) [47.530715] [011/171] (958s left) gem_basic (create-close) [47.590448] Starting subtest: create-close [47.592505] Subtest create-close: SUCCESS (0.000s) [47.665351] [012/171] (958s left) gem_basic (create-fd-close) [47.730365] Starting subtest: create-fd-close [47.732551] Subtest create-fd-close: SUCCESS (0.000s) [47.797592] [013/171] (957s left) gem_busy (busy@all-engines) [47.871137] Starting subtest: busy [47.872218] Starting dynamic subtest: all-engines [47.902237] Dynamic subtest all-engines: SUCCESS (0.031s) [47.903367] Subtest busy: SUCCESS (0.031s) [48.217745] [014/171] (957s left) gem_close_race (basic-process) [48.288546] Starting subtest: basic-process [48.327099] Subtest basic-process: SUCCESS (0.038s) [48.484731] [015/171] (957s left) gem_close_race (basic-threads) [48.555904] Starting subtest: basic-threads [49.722192] Subtest basic-threads: SUCCESS (1.166s) [49.881941] [016/171] (955s left) gem_ctx_create (basic) [49.953433] Starting subtest: basic [49.954563] Subtest basic: SUCCESS (0.000s) [50.113588] [017/171] (955s left) gem_ctx_create (basic-files) [50.180132] Starting subtest: basic-files [52.192027] Subtest basic-files: SUCCESS (2.012s) [52.414821] [018/171] (953s left) gem_ctx_exec (basic) [52.480148] Starting subtest: basic [52.483179] Subtest basic: SUCCESS (0.003s) [52.563089] [019/171] (953s left) gem_exec_basic (basic) [52.629492] Starting subtest: basic [52.630501] Starting dynamic subtest: rcs0-smem [52.631578] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.636695] Starting dynamic subtest: bcs0-smem [52.637728] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [52.642983] Starting dynamic subtest: vcs0-smem [52.643993] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.648917] Starting dynamic subtest: vecs0-smem [52.650032] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.651165] Subtest basic: SUCCESS (0.002s) [52.798657] [020/171] (953s left) gem_exec_create (basic) [52.869934] Starting subtest: basic [52.870936] Starting dynamic subtest: smem [54.914404] Dynamic subtest smem: SUCCESS (2.044s) [54.915867] Subtest basic: SUCCESS (2.044s) [55.080391] [021/171] (950s left) gem_exec_fence (basic-busy) [55.259595] Starting subtest: basic-busy [55.260750] Starting dynamic subtest: rcs0 [55.288459] Dynamic subtest rcs0: SUCCESS (0.029s) [55.294522] Starting dynamic subtest: bcs0 [55.310516] Dynamic subtest bcs0: SUCCESS (0.022s) [55.316473] Starting dynamic subtest: vcs0 [55.340226] Dynamic subtest vcs0: SUCCESS (0.029s) [55.346305] Starting dynamic subtest: vecs0 [55.362288] Dynamic subtest vecs0: SUCCESS (0.023s) [55.363366] Subtest basic-busy: SUCCESS (0.103s) [55.812743] [022/171] (950s left) gem_exec_fence (basic-wait) [55.994554] Starting subtest: basic-wait [55.995720] Starting dynamic subtest: rcs0 [56.027601] Dynamic subtest rcs0: SUCCESS (0.033s) [56.034418] Starting dynamic subtest: bcs0 [56.056685] Dynamic subtest bcs0: SUCCESS (0.029s) [56.063585] Starting dynamic subtest: vcs0 [56.080455] Dynamic subtest vcs0: SUCCESS (0.024s) [56.087124] Starting dynamic subtest: vecs0 [56.100329] Dynamic subtest vecs0: SUCCESS (0.019s) [56.101771] Subtest basic-wait: SUCCESS (0.105s) [56.529606] [023/171] (949s left) gem_exec_fence (basic-await) [56.711658] Starting subtest: basic-await [56.712850] Starting dynamic subtest: rcs0 [56.782149] Dynamic subtest rcs0: SUCCESS (0.070s) [56.788195] Starting dynamic subtest: bcs0 [56.851726] Dynamic subtest bcs0: SUCCESS (0.069s) [56.857252] Starting dynamic subtest: vcs0 [56.921773] Dynamic subtest vcs0: SUCCESS (0.070s) [56.927354] Starting dynamic subtest: vecs0 [56.992969] Dynamic subtest vecs0: SUCCESS (0.071s) [56.993995] Subtest basic-await: SUCCESS (0.281s) [57.413140] [024/171] (948s left) gem_exec_fence (nb-await) [57.591859] Starting subtest: nb-await [57.592819] Starting dynamic subtest: rcs0 [57.646650] Dynamic subtest rcs0: SUCCESS (0.054s) [57.651961] Starting dynamic subtest: bcs0 [57.700219] Dynamic subtest bcs0: SUCCESS (0.054s) [57.705912] Starting dynamic subtest: vcs0 [57.754253] Dynamic subtest vcs0: SUCCESS (0.054s) [57.760044] Starting dynamic subtest: vecs0 [57.807070] Dynamic subtest vecs0: SUCCESS (0.053s) [57.808177] Subtest nb-await: SUCCESS (0.216s) [58.229984] [025/171] (947s left) gem_exec_gttfill (basic) [58.298469] Starting subtest: basic [61.349621] Subtest basic: SUCCESS (3.051s) [61.512620] [026/171] (944s left) gem_exec_parallel (engines) [61.641674] Starting subtest: engines [61.642685] Starting dynamic subtest: basic [63.035974] Dynamic subtest basic: SUCCESS (1.394s) [63.043560] Starting dynamic subtest: contexts [64.576147] Dynamic subtest contexts: SUCCESS (1.540s) [64.582923] Starting dynamic subtest: fds [66.315042] Dynamic subtest fds: SUCCESS (1.739s) [66.322793] Starting dynamic subtest: userptr [67.776748] Dynamic subtest userptr: SUCCESS (1.461s) [67.777959] Subtest engines: SUCCESS (6.135s) [67.948508] [027/171] (938s left) gem_exec_store (basic) [68.020802] Starting subtest: basic [68.058434] Subtest basic: SUCCESS (0.037s) [68.230898] [028/171] (937s left) gem_flink_basic (bad-flink) [68.293145] Starting subtest: bad-flink [68.294210] Subtest bad-flink: SUCCESS (0.000s) [68.346368] [029/171] (937s left) gem_flink_basic (bad-open) [68.408914] Starting subtest: bad-open [68.409956] Subtest bad-open: SUCCESS (0.000s) [68.463309] [030/171] (937s left) gem_flink_basic (basic) [68.526249] Starting subtest: basic [68.527380] Subtest basic: SUCCESS (0.000s) [68.598747] [031/171] (937s left) gem_flink_basic (double-flink) [68.660176] Starting subtest: double-flink [68.661253] Subtest double-flink: SUCCESS (0.000s) [68.731104] [032/171] (937s left) gem_flink_basic (flink-lifetime) [68.792162] Starting subtest: flink-lifetime [68.793291] Subtest flink-lifetime: SUCCESS (0.001s) [68.861579] [033/171] (937s left) gem_huc_copy (huc-copy) [68.925099] Subtest huc-copy: SKIP (0.000s) [68.956477] [034/171] (937s left) gem_linear_blits (basic) [69.092033] Starting subtest: basic [69.098435] Subtest basic: SUCCESS (0.007s) [69.200189] [035/171] (936s left) gem_mmap (basic) [69.331203] Starting subtest: basic [69.336373] Subtest basic: SUCCESS (0.000s) [69.394739] [036/171] (936s left) gem_mmap_gtt (basic) [69.458239] Starting subtest: basic [69.459360] Subtest basic: SUCCESS (0.001s) [69.505015] [037/171] (936s left) gem_render_linear_blits (basic) [69.567761] Starting subtest: basic [69.583439] Subtest basic: SUCCESS (0.016s) [69.624796] [038/171] (936s left) gem_render_tiled_blits (basic) [69.687396] Starting subtest: basic [69.706632] Subtest basic: SUCCESS (0.019s) [69.739959] [039/171] (936s left) gem_ringfill (basic-all) [69.929513] Starting subtest: basic-all [71.037737] Subtest basic-all: SUCCESS (1.109s) [71.098213] [040/171] (935s left) gem_softpin (allocator-basic) [71.163713] Subtest allocator-basic: SKIP (0.000s) [71.226841] [041/171] (934s left) gem_softpin (allocator-basic-reserve) [71.288994] Subtest allocator-basic-reserve: SKIP (0.000s) [71.343133] [042/171] (934s left) gem_softpin (safe-alignment) [71.405054] Starting subtest: safe-alignment [71.412527] Subtest safe-alignment: SUCCESS (0.008s) [71.495725] [043/171] (934s left) gem_sync (basic-all) [71.565999] Starting subtest: basic-all [73.654777] Subtest basic-all: SUCCESS (2.088s) [73.811922] [044/171] (932s left) gem_sync (basic-each) [73.880576] Starting subtest: basic-each [75.936418] Subtest basic-each: SUCCESS (2.055s) [76.094328] [045/171] (930s left) gem_tiled_blits (basic) [76.228726] Starting subtest: basic [76.239229] Subtest basic: SUCCESS (0.011s) [76.331580] [046/171] (929s left) gem_tiled_fence_blits (basic) [76.534800] Starting subtest: basic [76.540467] Subtest basic: SUCCESS (0.006s) [76.649200] [047/171] (929s left) gem_tiled_pread_basic [76.943782] [048/171] (929s left) gem_wait (busy@all-engines) [77.015610] Starting subtest: busy [77.016731] Starting dynamic subtest: all-engines [77.535586] Dynamic subtest all-engines: SUCCESS (0.519s) [77.536995] Subtest busy: SUCCESS (0.519s) [77.712289] [049/171] (928s left) gem_wait (wait@all-engines) [77.785205] Starting subtest: wait [77.786215] Starting dynamic subtest: all-engines [78.802420] Dynamic subtest all-engines: SUCCESS (1.017s) [78.803588] Subtest wait: SUCCESS (1.017s) [78.976542] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [79.038461] Starting subtest: basic-eu-total [79.040696] Subtest basic-eu-total: SUCCESS (0.000s) [79.091318] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [79.152300] Starting subtest: basic-subslice-total [79.154413] Subtest basic-subslice-total: SUCCESS (0.000s) [79.208659] [052/171] (927s left) i915_hangman (error-state-basic) [79.277107] Starting subtest: error-state-basic [79.281325] Subtest error-state-basic: SUCCESS (0.004s) [79.361711] [053/171] (927s left) i915_pciid [79.474577] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier) [79.537361] Starting subtest: addfb25-bad-modifier [79.539123] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [79.624286] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [79.684937] Starting subtest: addfb25-framebuffer-vs-set-tiling [79.685978] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.774758] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.837860] Starting subtest: addfb25-modifier-no-flag [79.838864] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.924554] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [79.984027] Starting subtest: addfb25-x-tiled-legacy [79.985140] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [80.074829] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [80.135936] Starting subtest: addfb25-x-tiled-mismatch-legacy [80.136924] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [80.224367] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [80.306543] Starting subtest: addfb25-yf-tiled-legacy [80.307644] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [80.374288] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [80.455643] Starting subtest: addfb25-y-tiled-legacy [80.456671] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [80.524462] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [80.608896] Starting subtest: addfb25-y-tiled-small-legacy [80.610967] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [80.676192] [062/171] (925s left) kms_addfb_basic (bad-pitch-0) [80.737141] Starting subtest: bad-pitch-0 [80.738202] Subtest bad-pitch-0: SUCCESS (0.000s) [80.824558] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [80.885481] Starting subtest: bad-pitch-1024 [80.886625] Subtest bad-pitch-1024: SUCCESS (0.000s) [80.974678] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [81.037315] Starting subtest: bad-pitch-128 [81.038409] Subtest bad-pitch-128: SUCCESS (0.000s) [81.124173] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [81.183979] Starting subtest: bad-pitch-256 [81.184994] Subtest bad-pitch-256: SUCCESS (0.000s) [81.274435] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [81.336545] Starting subtest: bad-pitch-32 [81.337678] Subtest bad-pitch-32: SUCCESS (0.000s) [81.423849] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [81.484774] Starting subtest: bad-pitch-63 [81.485843] Subtest bad-pitch-63: SUCCESS (0.000s) [81.573663] [068/171] (925s left) kms_addfb_basic (bad-pitch-65536) [81.635083] Starting subtest: bad-pitch-65536 [81.636154] Subtest bad-pitch-65536: SUCCESS (0.000s) [81.724038] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [81.784370] Starting subtest: bad-pitch-999 [81.785528] Subtest bad-pitch-999: SUCCESS (0.000s) [81.873420] [070/171] (924s left) kms_addfb_basic (basic) [81.935610] Starting subtest: basic [81.936758] Subtest basic: SUCCESS (0.000s) [82.023842] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [82.086650] Starting subtest: basic-x-tiled-legacy [82.087822] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [82.173654] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [82.236230] Starting subtest: basic-y-tiled-legacy [82.237260] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [82.324045] [073/171] (924s left) kms_addfb_basic (bo-too-small) [82.406557] Starting subtest: bo-too-small [82.407672] Subtest bo-too-small: SUCCESS (0.000s) [82.473703] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [82.555888] Starting subtest: bo-too-small-due-to-tiling [82.556952] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [82.623837] [075/171] (924s left) kms_addfb_basic (clobberred-modifier) [82.686388] Starting subtest: clobberred-modifier [82.687475] Subtest clobberred-modifier: SUCCESS (0.000s) [82.777809] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [82.839693] Starting subtest: framebuffer-vs-set-tiling [82.840759] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.940595] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [83.001408] Starting subtest: invalid-get-prop [83.002500] Subtest invalid-get-prop: SUCCESS (0.000s) [83.092776] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [83.156152] Starting subtest: invalid-get-prop-any [83.157206] Subtest invalid-get-prop-any: SUCCESS (0.000s) [83.239922] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [83.301705] Starting subtest: invalid-set-prop [83.302828] Subtest invalid-set-prop: SUCCESS (0.000s) [83.390367] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [83.450288] Starting subtest: invalid-set-prop-any [83.451252] Subtest invalid-set-prop-any: SUCCESS (0.000s) [83.540478] [081/171] (923s left) kms_addfb_basic (no-handle) [83.599776] Starting subtest: no-handle [83.600806] Subtest no-handle: SUCCESS (0.000s) [83.690546] [082/171] (923s left) kms_addfb_basic (size-max) [83.781149] Starting subtest: size-max [83.782226] Subtest size-max: SUCCESS (0.000s) [83.857508] [083/171] (922s left) kms_addfb_basic (small-bo) [83.941402] Starting subtest: small-bo [83.942448] Subtest small-bo: SUCCESS (0.000s) [84.007567] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [84.068070] Starting subtest: tile-pitch-mismatch [84.069129] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [84.156956] [085/171] (922s left) kms_addfb_basic (too-high) [84.237306] Starting subtest: too-high [84.238386] Subtest too-high: SUCCESS (0.000s) [84.306812] [086/171] (922s left) kms_addfb_basic (too-wide) [84.389560] Starting subtest: too-wide [84.390714] Subtest too-wide: SUCCESS (0.000s) [84.457919] [087/171] (922s left) kms_addfb_basic (unused-handle) [84.520889] Starting subtest: unused-handle [84.521976] Subtest unused-handle: SUCCESS (0.000s) [84.625030] [088/171] (922s left) kms_addfb_basic (unused-modifier) [84.687017] Starting subtest: unused-modifier [84.688060] Subtest unused-modifier: SUCCESS (0.000s) [84.773997] [089/171] (922s left) kms_addfb_basic (unused-offsets) [84.835918] Starting subtest: unused-offsets [84.836932] Subtest unused-offsets: SUCCESS (0.000s) [84.923291] [090/171] (921s left) kms_addfb_basic (unused-pitches) [84.984053] Starting subtest: unused-pitches [84.985069] Subtest unused-pitches: SUCCESS (0.000s) [85.073356] [091/171] (921s left) kms_busy (basic) [85.163664] Starting subtest: basic [85.165244] Starting dynamic subtest: flip [85.598715] Dynamic subtest flip: SUCCESS (0.434s) [85.606788] Starting dynamic subtest: modeset [86.099868] Dynamic subtest modeset: SUCCESS (0.501s) [86.100879] Subtest basic: SUCCESS (0.937s) [86.230220] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast) [86.357415] Subtest dp-hpd-fast: SKIP (0.000s) [86.441298] [093/171] (920s left) kms_chamelium_edid (dp-edid-read) [86.567433] Subtest dp-edid-read: SKIP (0.000s) [86.651973] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [86.779922] Subtest dp-crc-fast: SKIP (0.000s) [86.862360] [095/171] (920s left) kms_chamelium_hpd (hdmi-hpd-fast) [86.989621] Subtest hdmi-hpd-fast: SKIP (0.000s) [87.072198] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [87.199987] Subtest hdmi-edid-read: SKIP (0.000s) [87.282234] [097/171] (919s left) kms_chamelium_frames (hdmi-crc-fast) [87.396869] Subtest hdmi-crc-fast: SKIP (0.000s) [87.478155] [098/171] (919s left) kms_chamelium_hpd (vga-hpd-fast) [87.590709] Subtest vga-hpd-fast: SKIP (0.000s) [87.672300] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [87.802026] Subtest vga-edid-read: SKIP (0.000s) [87.883612] [100/171] (919s left) kms_prop_blob (basic) [87.946450] Starting subtest: basic [87.947485] Subtest basic: SUCCESS (0.000s) [88.003357] [101/171] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [88.087236] Starting subtest: basic-busy-flip-before-cursor-atomic [89.009728] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.923s) [89.135884] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [89.218174] Starting subtest: basic-busy-flip-before-cursor-legacy [90.142665] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.925s) [90.269188] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [90.351192] Starting subtest: basic-flip-after-cursor-atomic [91.276627] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s) [91.403786] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [91.488293] Starting subtest: basic-flip-after-cursor-legacy [92.410713] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s) [92.537940] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [92.620344] Starting subtest: basic-flip-after-cursor-varying-size [93.545500] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.926s) [93.675719] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [93.760079] Starting subtest: basic-flip-before-cursor-atomic [94.682620] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s) [94.808509] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [94.891131] Starting subtest: basic-flip-before-cursor-legacy [95.814670] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s) [95.942466] [108/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [96.024898] Starting subtest: basic-flip-before-cursor-varying-size [96.949536] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s) [97.072193] [109/171] (910s left) kms_flip (basic-flip-vs-dpms) [97.144540] Starting subtest: basic-flip-vs-dpms [97.145718] Starting dynamic subtest: A-VGA1 [98.078535] Dynamic subtest A-VGA1: SUCCESS (0.933s) [98.085575] Starting dynamic subtest: B-VGA1 [98.964603] Dynamic subtest B-VGA1: SUCCESS (0.886s) [98.971428] Starting dynamic subtest: C-VGA1 [99.851607] Dynamic subtest C-VGA1: SUCCESS (0.886s) [99.852657] Subtest basic-flip-vs-dpms: SUCCESS (2.708s) [100.004329] [110/171] (907s left) kms_flip (basic-flip-vs-modeset) [100.083052] Starting subtest: basic-flip-vs-modeset [100.085344] Starting dynamic subtest: A-VGA1 [100.934042] Dynamic subtest A-VGA1: SUCCESS (0.848s) [100.940840] Starting dynamic subtest: B-VGA1 [101.718608] Dynamic subtest B-VGA1: SUCCESS (0.784s) [101.725162] Starting dynamic subtest: C-VGA1 [102.504763] Dynamic subtest C-VGA1: SUCCESS (0.787s) [102.506920] Subtest basic-flip-vs-modeset: SUCCESS (2.423s) [102.628620] [111/171] (904s left) kms_flip (basic-flip-vs-wf_vblank) [102.703514] Starting subtest: basic-flip-vs-wf_vblank [102.705541] Starting dynamic subtest: A-VGA1 [103.851792] Dynamic subtest A-VGA1: SUCCESS (1.147s) [103.858597] Starting dynamic subtest: B-VGA1 [104.973717] Dynamic subtest B-VGA1: SUCCESS (1.121s) [104.981682] Starting dynamic subtest: C-VGA1 [106.094785] Dynamic subtest C-VGA1: SUCCESS (1.121s) [106.096210] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.393s) [106.248522] [112/171] (900s left) kms_flip (basic-plain-flip) [106.321287] Starting subtest: basic-plain-flip [106.322297] Starting dynamic subtest: A-VGA1 [107.171247] Dynamic subtest A-VGA1: SUCCESS (0.849s) [107.178106] Starting dynamic subtest: B-VGA1 [108.008583] Dynamic subtest B-VGA1: SUCCESS (0.837s) [108.015167] Starting dynamic subtest: C-VGA1 [108.846904] Dynamic subtest C-VGA1: SUCCESS (0.837s) [108.848791] Subtest basic-plain-flip: SUCCESS (2.529s) [109.002504] [113/171] (898s left) kms_force_connector_basic (force-connector-state) [109.078592] Starting subtest: force-connector-state [109.216415] Subtest force-connector-state: SUCCESS (0.136s) [109.398117] [114/171] (897s left) kms_force_connector_basic (force-edid) [109.468551] Starting subtest: force-edid [109.489343] Subtest force-edid: SUCCESS (0.020s) [109.581457] [115/171] (897s left) kms_force_connector_basic (force-load-detect) [109.653924] Starting subtest: force-load-detect [109.796063] Subtest force-load-detect: SUCCESS (0.143s) [109.983264] [116/171] (897s left) kms_force_connector_basic (prune-stale-modes) [110.056417] Starting subtest: prune-stale-modes [110.073320] Subtest prune-stale-modes: SUCCESS (0.018s) [110.166470] [117/171] (897s left) kms_frontbuffer_tracking (basic) [110.255127] Starting subtest: basic [112.035677] Subtest basic: SUCCESS (1.783s) [112.101287] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [112.185037] Starting subtest: compare-crc-sanitycheck [112.186166] Starting dynamic subtest: pipe-A-VGA-1 [112.455851] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.270s) [112.462649] Starting dynamic subtest: pipe-B-VGA-1 [112.717205] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.260s) [112.723953] Starting dynamic subtest: pipe-C-VGA-1 [112.989862] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.271s) [112.990943] Subtest compare-crc-sanitycheck: SUCCESS (0.805s) [113.118395] [119/171] (894s left) kms_pipe_crc_basic (hang-read-crc) [113.202621] Starting subtest: hang-read-crc [113.203713] Starting dynamic subtest: pipe-A-VGA-1 [113.934934] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.730s) [113.943315] Starting dynamic subtest: pipe-B-VGA-1 [114.659427] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.725s) [114.668031] Starting dynamic subtest: pipe-C-VGA-1 [115.405777] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.744s) [115.406929] Subtest hang-read-crc: SUCCESS (2.203s) [115.519891] [120/171] (891s left) kms_pipe_crc_basic (nonblocking-crc) [115.604603] Starting subtest: nonblocking-crc [115.605645] Starting dynamic subtest: pipe-A-VGA-1 [116.044707] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.440s) [116.051532] Starting dynamic subtest: pipe-B-VGA-1 [116.471972] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.425s) [116.480397] Starting dynamic subtest: pipe-C-VGA-1 [116.907230] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.434s) [116.908327] Subtest nonblocking-crc: SUCCESS (1.302s) [117.020543] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [117.105236] Starting subtest: nonblocking-crc-frame-sequence [117.106219] Starting dynamic subtest: pipe-A-VGA-1 [117.543726] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.438s) [117.550477] Starting dynamic subtest: pipe-B-VGA-1 [117.968971] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.424s) [117.975938] Starting dynamic subtest: pipe-C-VGA-1 [118.405999] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.435s) [118.407115] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.301s) [118.518584] [122/171] (888s left) kms_pipe_crc_basic (read-crc) [118.600491] Starting subtest: read-crc [118.601528] Starting dynamic subtest: pipe-A-VGA-1 [118.958763] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.357s) [118.965803] Starting dynamic subtest: pipe-B-VGA-1 [119.317837] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.358s) [119.324760] Starting dynamic subtest: pipe-C-VGA-1 [119.689319] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [119.690418] Subtest read-crc: SUCCESS (1.088s) [119.804122] [123/171] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence) [119.888949] Starting subtest: read-crc-frame-sequence [119.889937] Starting dynamic subtest: pipe-A-VGA-1 [120.263093] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s) [120.269754] Starting dynamic subtest: pipe-B-VGA-1 [120.622424] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.358s) [120.629166] Starting dynamic subtest: pipe-C-VGA-1 [120.992282] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.369s) [120.993345] Subtest read-crc-frame-sequence: SUCCESS (1.104s) [121.106331] [124/171] (886s left) kms_psr (primary_page_flip) [121.170176] Subtest primary_page_flip: SKIP (0.000s) [121.202713] [125/171] (886s left) kms_psr (cursor_plane_move) [121.265932] Subtest cursor_plane_move: SKIP (0.000s) [121.287167] [126/171] (886s left) kms_psr (sprite_plane_onoff) [121.351154] Subtest sprite_plane_onoff: SKIP (0.000s) [121.368301] [127/171] (886s left) kms_psr (primary_mmap_gtt) [121.430969] Subtest primary_mmap_gtt: SKIP (0.000s) [121.452173] [128/171] (886s left) kms_setmode (basic-clone-single-crtc) [121.513256] Starting subtest: basic-clone-single-crtc [121.516456] Subtest basic-clone-single-crtc: SKIP (0.000s) [121.573337] [129/171] (885s left) i915_pm_backlight (basic-brightness) [121.657448] Subtest basic-brightness: SKIP (0.000s) [121.684205] [130/171] (885s left) i915_pm_rpm (basic-pci-d3-state) [123.048921] Starting subtest: basic-pci-d3-state [123.250641] Subtest basic-pci-d3-state: SUCCESS (0.200s) [123.495381] [131/171] (884s left) i915_pm_rpm (basic-rte) [123.558167] Starting subtest: basic-rte [125.041965] Subtest basic-rte: SUCCESS (1.481s) [125.478950] [132/171] (882s left) i915_pm_rps (basic-api) [125.544945] Starting subtest: basic-api [125.547291] Subtest basic-api: SUCCESS (0.002s) [125.614204] [133/171] (881s left) prime_self_import (basic-llseek-bad) [125.677504] Starting subtest: basic-llseek-bad [125.678686] Subtest basic-llseek-bad: SUCCESS (0.001s) [125.745382] [134/171] (881s left) prime_self_import (basic-llseek-size) [125.804426] Starting subtest: basic-llseek-size [125.806925] Subtest basic-llseek-size: SUCCESS (0.002s) [125.880248] [135/171] (881s left) prime_self_import (basic-with_fd_dup) [125.940680] Starting subtest: basic-with_fd_dup [125.944522] Subtest basic-with_fd_dup: SUCCESS (0.003s) [126.014297] [136/171] (881s left) prime_self_import (basic-with_one_bo) [126.074796] Starting subtest: basic-with_one_bo [126.077181] Subtest basic-with_one_bo: SUCCESS (0.002s) [126.124344] [137/171] (881s left) prime_self_import (basic-with_one_bo_two_files) [126.186142] Starting subtest: basic-with_one_bo_two_files [126.188623] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [126.263079] [138/171] (881s left) prime_self_import (basic-with_two_bos) [126.323146] Starting subtest: basic-with_two_bos [126.325594] Subtest basic-with_two_bos: SUCCESS (0.002s) [126.394927] [139/171] (881s left) prime_vgem (basic-fence-flip) [126.467398] Starting subtest: basic-fence-flip [126.797264] Subtest basic-fence-flip: SUCCESS (0.330s) [126.866464] [140/171] (880s left) prime_vgem (basic-fence-mmap) [126.935669] Starting subtest: basic-fence-mmap [126.957731] Subtest basic-fence-mmap: SUCCESS (0.022s) [127.031647] [141/171] (880s left) prime_vgem (basic-fence-read) [127.101746] Starting subtest: basic-fence-read [127.135504] Subtest basic-fence-read: SUCCESS (0.034s) [127.214399] [142/171] (880s left) prime_vgem (basic-gtt) [127.284774] Starting subtest: basic-gtt [127.295702] Subtest basic-gtt: SUCCESS (0.011s) [127.363134] [143/171] (880s left) prime_vgem (basic-read) [127.434868] Starting subtest: basic-read [127.450596] Subtest basic-read: SUCCESS (0.016s) [127.527983] [144/171] (880s left) prime_vgem (basic-write) [127.600617] Starting subtest: basic-write [127.617864] Subtest basic-write: SUCCESS (0.017s) [127.695800] [145/171] (880s left) prime_vgem (basic-userptr) [127.766903] Starting subtest: basic-userptr [127.776383] Subtest basic-userptr: SKIP (0.008s) [127.849309] [146/171] (879s left) vgem_basic (setversion) [127.914225] Starting subtest: setversion [127.916596] Subtest setversion: SUCCESS (0.000s) [127.962152] [147/171] (879s left) vgem_basic (create) [128.030703] Starting subtest: create [128.031826] Subtest create: SUCCESS (0.000s) [128.079575] [148/171] (879s left) vgem_basic (debugfs) [128.147523] Starting subtest: debugfs [128.148651] Subtest debugfs: SUCCESS (0.000s) [128.196425] [149/171] (879s left) vgem_basic (dmabuf-export) [128.264174] Starting subtest: dmabuf-export [128.266850] Subtest dmabuf-export: SUCCESS (0.001s) [128.346816] [150/171] (879s left) vgem_basic (dmabuf-fence) [128.414156] Starting subtest: dmabuf-fence [128.415207] Subtest dmabuf-fence: SUCCESS (0.001s) [128.462327] [151/171] (879s left) vgem_basic (dmabuf-fence-before) [128.530684] Starting subtest: dmabuf-fence-before [128.531770] Subtest dmabuf-fence-before: SUCCESS (0.000s) [128.581336] [152/171] (879s left) vgem_basic (dmabuf-mmap) [128.647624] Starting subtest: dmabuf-mmap [128.663093] Subtest dmabuf-mmap: SUCCESS (0.015s) [128.712135] [153/171] (879s left) vgem_basic (mmap) [128.780623] Starting subtest: mmap [128.790656] Subtest mmap: SUCCESS (0.010s) [128.832515] [154/171] (879s left) vgem_basic (second-client) [128.897658] Starting subtest: second-client [128.947240] Subtest second-client: SUCCESS (0.050s) [128.996263] [155/171] (878s left) vgem_basic (sysfs) [129.063881] Starting subtest: sysfs [129.064961] Subtest sysfs: SUCCESS (0.001s) [129.112628] [156/171] (878s left) core_hotunplug (unbind-rebind) [129.214740] Starting subtest: unbind-rebind [130.057349] Subtest unbind-rebind: SUCCESS (0.843s) [130.074326] [157/171] (877s left) vgem_basic (unload) [130.142304] Starting subtest: unload [159.009227] Subtest unload: SUCCESS (28.865s) [159.084399] [158/171] (848s left) i915_module_load (reload) [159.144238] Starting subtest: reload [161.074190] Subtest reload: SUCCESS (1.931s) [161.099877] [159/171] (846s left) gem_lmem_swapping (basic) [161.174439] Subtest basic: SKIP (0.000s) [161.198500] [160/171] (846s left) gem_lmem_swapping (parallel-random-engines) [161.262310] Subtest parallel-random-engines: SKIP (0.000s) [161.282233] [161/171] (846s left) gem_lmem_swapping (random-engines) [161.346447] Subtest random-engines: SKIP (0.000s) [161.367148] [162/171] (846s left) gem_lmem_swapping (verify-random) [161.431844] Subtest verify-random: SKIP (0.000s) [161.450805] [163/171] (846s left) i915_pm_rpm (module-reload) [163.076227] Starting subtest: module-reload [169.720253] Subtest module-reload: SUCCESS (6.645s) [169.734816] [164/171] (838s left) i915_selftest (live) [169.804995] Starting subtest: live [169.806263] Starting dynamic subtest: sanitycheck [170.349049] Dynamic subtest sanitycheck: SUCCESS (0.543s) [170.354536] Starting dynamic subtest: uncore [170.904952] Dynamic subtest uncore: SUCCESS (0.555s) [170.910830] Starting dynamic subtest: workarounds [171.623802] Dynamic subtest workarounds: SUCCESS (0.717s) [171.630252] Starting dynamic subtest: gt_engines [172.145143] Dynamic subtest gt_engines: SUCCESS (0.520s) [172.151737] Starting dynamic subtest: gt_timelines [177.653105] Dynamic subtest gt_timelines: SUCCESS (5.508s) [177.658968] Starting dynamic subtest: gt_contexts [178.278199] Dynamic subtest gt_contexts: SUCCESS (0.624s) [178.283882] Starting dynamic subtest: gt_lrc [178.952070] Dynamic subtest gt_lrc: SUCCESS (0.673s) [178.957738] Starting dynamic subtest: gt_mocs [179.590560] Dynamic subtest gt_mocs: SUCCESS (0.637s) [179.597271] Starting dynamic subtest: gt_pm [190.375848] Dynamic subtest gt_pm: SUCCESS (10.785s) [190.384484] Starting dynamic subtest: gt_heartbeat [191.176018] Dynamic subtest gt_heartbeat: SUCCESS (0.799s) [191.181833] Starting dynamic subtest: gt_tlb [191.845750] Dynamic subtest gt_tlb: SUCCESS (0.668s) [191.852272] Starting dynamic subtest: requests [198.131085] Dynamic subtest requests: SUCCESS (6.284s) [198.137458] Starting dynamic subtest: migrate [198.800885] Dynamic subtest migrate: SUCCESS (0.668s) [198.807324] Starting dynamic subtest: active [199.358239] Dynamic subtest active: SUCCESS (0.556s) [199.363908] Starting dynamic subtest: objects [200.236017] Dynamic subtest objects: SUCCESS (0.877s) [200.241450] Starting dynamic subtest: mman [204.303493] Dynamic subtest mman: SUCCESS (4.066s) [204.309739] Starting dynamic subtest: dmabuf [204.852913] Dynamic subtest dmabuf: SUCCESS (0.548s) [204.858458] Starting dynamic subtest: vma [205.495125] Dynamic subtest vma: SUCCESS (0.641s) [205.500910] Starting dynamic subtest: coherency [206.715854] Dynamic subtest coherency: SUCCESS (1.219s) [206.721888] Starting dynamic subtest: gtt [210.744047] Dynamic subtest gtt: SUCCESS (4.027s) [210.750442] Starting dynamic subtest: gem [211.563017] Dynamic subtest gem: SUCCESS (0.818s) [211.568555] Starting dynamic subtest: evict [212.132737] Dynamic subtest evict: SUCCESS (0.568s) [212.138256] Starting dynamic subtest: hugepages [213.236606] Dynamic subtest hugepages: SUCCESS (1.102s) [213.245044] Starting dynamic subtest: gem_contexts [218.143669] Dynamic subtest gem_contexts: SUCCESS (4.906s) [218.149320] Starting dynamic subtest: client [218.673235] Dynamic subtest client: SUCCESS (0.528s) [218.679648] Starting dynamic subtest: gem_migrate [219.366595] Dynamic subtest gem_migrate: SUCCESS (0.693s) [219.372747] Starting dynamic subtest: reset [221.195666] Dynamic subtest reset: SUCCESS (1.828s) [221.201147] Starting dynamic subtest: memory_region [221.859161] Dynamic subtest memory_region: SUCCESS (0.662s) [221.865180] Starting dynamic subtest: hangcheck [239.157381] Dynamic subtest hangcheck: SUCCESS (17.297s) [239.165118] Starting dynamic subtest: execlists [239.779682] Dynamic subtest execlists: SUCCESS (0.621s) [239.785491] Starting dynamic subtest: ring_submission [240.386282] Dynamic subtest ring_submission: SUCCESS (0.605s) [240.392612] Starting dynamic subtest: perf [241.043121] Dynamic subtest perf: SUCCESS (0.656s) [241.050158] Starting dynamic subtest: slpc [241.545430] Dynamic subtest slpc: SUCCESS (0.501s) [241.554590] Starting dynamic subtest: guc [242.076424] Dynamic subtest guc: SUCCESS (0.531s) [242.083243] Starting dynamic subtest: guc_multi_lrc [242.636859] Dynamic subtest guc_multi_lrc: SUCCESS (0.561s) [242.642359] Starting dynamic subtest: guc_hang [243.319644] Dynamic subtest guc_hang: SUCCESS (0.682s) [243.325333] Starting dynamic subtest: late_gt_pm [243.856959] Dynamic subtest late_gt_pm: SUCCESS (0.536s) [243.857985] Subtest live: SUCCESS (74.052s) [244.010094] [165/171] (764s left) dmabuf (all-tests) [244.076319] Starting subtest: all-tests [244.079734] Starting dynamic subtest: sanitycheck [244.141932] Dynamic subtest sanitycheck: SUCCESS (0.065s) [244.149713] Starting dynamic subtest: dma_fence [244.315462] Dynamic subtest dma_fence: SUCCESS (0.173s) [244.321720] Starting dynamic subtest: dma_fence_chain [255.548730] Dynamic subtest dma_fence_chain: SUCCESS (11.233s) [255.555045] Starting dynamic subtest: dma_fence_unwrap [255.611446] Dynamic subtest dma_fence_unwrap: SUCCESS (0.062s) [255.617379] Starting dynamic subtest: dma_resv [255.669063] Dynamic subtest dma_resv: SUCCESS (0.058s) [255.670157] Subtest all-tests: SUCCESS (11.593s) [255.682364] [166/171] (752s left) i915_suspend (basic-s2idle-without-i915) [255.742427] Starting subtest: basic-s2idle-without-i915 [272.738048] Subtest basic-s2idle-without-i915: SUCCESS (1.943s) [278.573218] [167/171] (750s left) i915_suspend (basic-s3-without-i915) [278.643317] Starting subtest: basic-s3-without-i915 [296.861737] Subtest basic-s3-without-i915: SUCCESS (1.994s) [302.828011] [168/171] (748s left) gem_exec_suspend (basic-s0) [302.905307] Starting subtest: basic-S0 [302.906380] Starting dynamic subtest: smem [319.631736] Dynamic subtest smem: SUCCESS (1.223s) [319.632808] Subtest basic-S0: SUCCESS (1.224s) [325.764850] [169/171] (746s left) gem_exec_suspend (basic-s3) [325.834753] Starting subtest: basic-S3 [325.835876] Starting dynamic subtest: smem [343.633107] Dynamic subtest smem: SUCCESS (1.252s) [343.634185] Subtest basic-S3: SUCCESS (1.253s) [350.775381] [170/171] (745s left) kms_chamelium_hpd (common-hpd-after-suspend) [350.903471] Subtest common-hpd-after-suspend: SKIP (0.000s) [350.986479] [171/171] (745s left) kms_pipe_crc_basic (suspend-read-crc) [351.068940] Starting subtest: suspend-read-crc [351.070014] Starting dynamic subtest: pipe-A-VGA-1 [368.810677] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.439s) [368.818892] Starting dynamic subtest: pipe-B-VGA-1 [386.822052] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.449s) [386.830151] Starting dynamic subtest: pipe-C-VGA-1 [404.819225] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.475s) [404.820324] Subtest suspend-read-crc: SUCCESS (4.368s) [407.904551] Closing watchdogs Done.