[41.553714] Initializing watchdogs [41.553859] /dev/watchdog0 [41.563299] [001/165] (960s left) i915_module_load (load) [41.666062] Starting subtest: load [44.205951] Subtest load: SUCCESS (2.539s) [44.228945] [002/165] (957s left) core_auth (basic-auth) [44.324762] Starting subtest: basic-auth [44.325985] Subtest basic-auth: SUCCESS (0.001s) [44.406864] [003/165] (957s left) debugfs_test (read_all_entries) [44.504923] Starting subtest: read_all_entries [44.577722] Subtest read_all_entries: SUCCESS (0.071s) [44.691762] [004/165] (957s left) debugfs_test (basic-hwmon) [44.786841] Starting subtest: basic-hwmon [44.789103] Subtest basic-hwmon: SKIP (0.000s) [44.890166] [005/165] (957s left) fbdev (eof) [44.990982] Starting subtest: eof [44.994304] Subtest eof: SUCCESS (0.002s) [45.056142] [006/165] (957s left) fbdev (info) [45.169256] Starting subtest: info [45.170428] Subtest info: SUCCESS (0.000s) [45.239751] [007/165] (956s left) fbdev (nullptr) [45.340384] Starting subtest: nullptr [45.341574] Subtest nullptr: SUCCESS (0.000s) [45.406503] [008/165] (956s left) fbdev (read) [45.506558] Starting subtest: read [52.588092] Subtest read: SUCCESS (7.045s) [52.632684] [009/165] (949s left) fbdev (write) [52.731162] Starting subtest: write [56.499823] Subtest write: SUCCESS (3.734s) [56.534448] [010/165] (945s left) gem_basic (bad-close) [56.623971] Starting subtest: bad-close [56.626334] Subtest bad-close: SUCCESS (0.000s) [56.705965] [011/165] (945s left) gem_basic (create-close) [56.793387] Starting subtest: create-close [56.795404] Subtest create-close: SUCCESS (0.000s) [56.889978] [012/165] (945s left) gem_basic (create-fd-close) [56.978727] Starting subtest: create-fd-close [56.980828] Subtest create-fd-close: SUCCESS (0.000s) [57.072579] [013/165] (945s left) gem_busy (busy@all-engines) [57.179621] Starting subtest: busy [57.180889] Starting dynamic subtest: all-engines [57.244380] Dynamic subtest all-engines: SUCCESS (0.065s) [57.245492] Subtest busy: SUCCESS (0.065s) [57.624698] [014/165] (944s left) gem_close_race (basic-process) [57.737570] Starting subtest: basic-process [57.805342] Subtest basic-process: SUCCESS (0.069s) [58.009293] [015/165] (944s left) gem_close_race (basic-threads) [58.125240] Starting subtest: basic-threads [59.307567] Subtest basic-threads: SUCCESS (1.184s) [59.536828] [016/165] (942s left) gem_ctx_create (basic) [59.644958] Starting subtest: basic [59.646112] Subtest basic: SUCCESS (0.000s) [59.843729] [017/165] (942s left) gem_ctx_create (basic-files) [59.948384] Starting subtest: basic-files [61.976362] Subtest basic-files: SUCCESS (2.028s) [62.237434] [018/165] (940s left) gem_ctx_exec (basic) [62.333412] Starting subtest: basic [62.338441] Subtest basic: SUCCESS (0.005s) [62.463669] [019/165] (940s left) gem_exec_basic (basic) [62.569439] Starting subtest: basic [62.570696] Starting dynamic subtest: rcs0-smem [62.571870] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [62.583094] Starting dynamic subtest: bcs0-smem [62.584284] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [62.594786] Starting dynamic subtest: vcs0-smem [62.596294] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [62.606930] Starting dynamic subtest: vecs0-smem [62.608353] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [62.609751] Subtest basic: SUCCESS (0.005s) [62.779821] [020/165] (939s left) gem_exec_create (basic) [62.883583] Starting subtest: basic [62.884794] Starting dynamic subtest: smem [64.948027] Dynamic subtest smem: SUCCESS (2.042s) [64.949224] Subtest basic: SUCCESS (2.042s) [65.161899] [021/165] (937s left) gem_exec_fence (basic-busy) [65.416507] Starting subtest: basic-busy [65.417929] Starting dynamic subtest: rcs0 [65.457053] Dynamic subtest rcs0: SUCCESS (0.048s) [65.472090] Starting dynamic subtest: bcs0 [65.486481] Dynamic subtest bcs0: SUCCESS (0.030s) [65.497774] Starting dynamic subtest: vcs0 [65.515538] Dynamic subtest vcs0: SUCCESS (0.029s) [65.529589] Starting dynamic subtest: vecs0 [65.547389] Dynamic subtest vecs0: SUCCESS (0.032s) [65.548485] Subtest basic-busy: SUCCESS (0.140s) [66.153190] [022/165] (936s left) gem_exec_fence (basic-wait) [66.407835] Starting subtest: basic-wait [66.409311] Starting dynamic subtest: rcs0 [66.434929] Dynamic subtest rcs0: SUCCESS (0.035s) [66.452342] Starting dynamic subtest: bcs0 [66.465558] Dynamic subtest bcs0: SUCCESS (0.031s) [66.478193] Starting dynamic subtest: vcs0 [66.501064] Dynamic subtest vcs0: SUCCESS (0.034s) [66.517440] Starting dynamic subtest: vecs0 [66.537977] Dynamic subtest vecs0: SUCCESS (0.036s) [66.539968] Subtest basic-wait: SUCCESS (0.138s) [67.085102] [023/165] (935s left) gem_exec_fence (basic-await) [67.335163] Starting subtest: basic-await [67.336284] Starting dynamic subtest: rcs0 [67.428228] Dynamic subtest rcs0: SUCCESS (0.100s) [67.452855] Starting dynamic subtest: bcs0 [67.543562] Dynamic subtest bcs0: SUCCESS (0.112s) [67.570947] Starting dynamic subtest: vcs0 [67.680948] Dynamic subtest vcs0: SUCCESS (0.131s) [67.706965] Starting dynamic subtest: vecs0 [67.804622] Dynamic subtest vecs0: SUCCESS (0.130s) [67.806623] Subtest basic-await: SUCCESS (0.476s) [68.359201] [024/165] (934s left) gem_exec_fence (nb-await) [68.609754] Starting subtest: nb-await [68.610929] Starting dynamic subtest: rcs0 [68.667642] Dynamic subtest rcs0: SUCCESS (0.065s) [68.685650] Starting dynamic subtest: bcs0 [68.735701] Dynamic subtest bcs0: SUCCESS (0.067s) [68.755662] Starting dynamic subtest: vcs0 [68.805448] Dynamic subtest vcs0: SUCCESS (0.069s) [68.832556] Starting dynamic subtest: vecs0 [68.879810] Dynamic subtest vecs0: SUCCESS (0.074s) [68.881825] Subtest nb-await: SUCCESS (0.278s) [69.422275] [025/165] (933s left) gem_exec_gttfill (basic) [69.528713] Starting subtest: basic [75.430385] Subtest basic: SUCCESS (5.893s) [75.609984] [026/165] (927s left) gem_exec_parallel (engines) [75.781556] Starting subtest: engines [75.782858] Starting dynamic subtest: basic [78.156809] Dynamic subtest basic: SUCCESS (2.352s) [78.170901] Starting dynamic subtest: contexts [83.915028] Dynamic subtest contexts: SUCCESS (5.774s) [83.929422] Starting dynamic subtest: fds [94.679788] Dynamic subtest fds: SUCCESS (10.772s) [94.712516] Starting dynamic subtest: userptr [97.209093] Dynamic subtest userptr: SUCCESS (2.500s) [97.211153] Subtest engines: SUCCESS (21.400s) [97.402520] [027/165] (905s left) gem_exec_store (basic) [97.510077] Starting subtest: basic [97.573342] Subtest basic: SUCCESS (0.063s) [97.786196] [028/165] (905s left) gem_flink_basic (bad-flink) [97.875537] Starting subtest: bad-flink [97.876684] Subtest bad-flink: SUCCESS (0.000s) [97.970826] [029/165] (904s left) gem_flink_basic (bad-open) [98.057667] Starting subtest: bad-open [98.058837] Subtest bad-open: SUCCESS (0.000s) [98.174570] [030/165] (904s left) gem_flink_basic (basic) [98.279725] Starting subtest: basic [98.281195] Subtest basic: SUCCESS (0.000s) [98.389803] [031/165] (904s left) gem_flink_basic (double-flink) [98.479633] Starting subtest: double-flink [98.480774] Subtest double-flink: SUCCESS (0.000s) [98.585394] [032/165] (904s left) gem_flink_basic (flink-lifetime) [98.683210] Starting subtest: flink-lifetime [98.685621] Subtest flink-lifetime: SUCCESS (0.002s) [98.787587] [033/165] (904s left) gem_huc_copy (huc-copy) [98.883798] Starting subtest: huc-copy [98.886075] Subtest huc-copy: SKIP (0.000s) [99.003315] [034/165] (903s left) gem_linear_blits (basic) [99.239367] Starting subtest: basic [99.252681] Subtest basic: SUCCESS (0.012s) [99.372109] [035/165] (903s left) gem_mmap (basic) [99.526363] Starting subtest: basic [99.531754] Subtest basic: SUCCESS (0.000s) [99.622066] [036/165] (903s left) gem_mmap_gtt (basic) [99.732568] Starting subtest: basic [99.733819] Subtest basic: SUCCESS (0.001s) [99.815511] [037/165] (903s left) gem_render_linear_blits (basic) [99.911733] Starting subtest: basic [99.961045] Subtest basic: SUCCESS (0.049s) [100.012624] [038/165] (903s left) gem_render_tiled_blits (basic) [100.107196] Starting subtest: basic [100.167528] Subtest basic: SUCCESS (0.059s) [100.231077] [039/165] (902s left) gem_ringfill (basic-all) [100.464753] Starting subtest: basic-all [101.696370] Subtest basic-all: SUCCESS (1.224s) [101.774286] [040/165] (901s left) gem_softpin (allocator-basic) [101.871217] Starting subtest: allocator-basic [102.040270] Subtest allocator-basic: SUCCESS (0.160s) [102.156381] [041/165] (901s left) gem_softpin (allocator-basic-reserve) [102.254262] Starting subtest: allocator-basic-reserve [102.422286] Subtest allocator-basic-reserve: SUCCESS (0.159s) [102.541415] [042/165] (900s left) gem_softpin (safe-alignment) [102.638491] Starting subtest: safe-alignment [102.654287] Subtest safe-alignment: SUCCESS (0.017s) [102.775299] [043/165] (900s left) gem_sync (basic-all) [102.882537] Starting subtest: basic-all [105.117434] Subtest basic-all: SUCCESS (2.213s) [105.312273] [044/165] (897s left) gem_sync (basic-each) [105.417628] Starting subtest: basic-each [107.571918] Subtest basic-each: SUCCESS (2.154s) [107.816502] [045/165] (895s left) gem_tiled_blits (basic) [108.031033] Starting subtest: basic [108.059783] Subtest basic: SUCCESS (0.028s) [108.199196] [046/165] (895s left) gem_tiled_fence_blits (basic) [108.489598] Starting subtest: basic [108.517913] Subtest basic: SUCCESS (0.028s) [108.669562] [047/165] (894s left) gem_tiled_pread_basic [109.180575] [048/165] (894s left) gem_wait (busy@all-engines) [109.296498] Starting subtest: busy [109.297750] Starting dynamic subtest: all-engines [109.821527] Dynamic subtest all-engines: SUCCESS (0.525s) [109.822671] Subtest busy: SUCCESS (0.525s) [110.062963] [049/165] (893s left) gem_wait (wait@all-engines) [110.179746] Starting subtest: wait [110.180989] Starting dynamic subtest: all-engines [111.212079] Dynamic subtest all-engines: SUCCESS (1.028s) [111.213915] Subtest wait: SUCCESS (1.029s) [111.452634] [050/165] (892s left) i915_getparams_basic (basic-eu-total) [111.542859] Starting subtest: basic-eu-total [111.545354] Subtest basic-eu-total: SUCCESS (0.000s) [111.632716] [051/165] (891s left) i915_getparams_basic (basic-subslice-total) [111.722374] Starting subtest: basic-subslice-total [111.724777] Subtest basic-subslice-total: SUCCESS (0.000s) [111.818256] [052/165] (891s left) i915_hangman (error-state-basic) [111.921696] Starting subtest: error-state-basic [111.934996] Subtest error-state-basic: SUCCESS (0.014s) [112.033284] [053/165] (891s left) i915_pciid [112.217397] [054/165] (891s left) kms_addfb_basic (addfb25-4-tiled) [112.343258] Starting subtest: addfb25-4-tiled [112.344479] Subtest addfb25-4-tiled: SUCCESS (0.000s) [112.439137] [055/165] (891s left) kms_addfb_basic (addfb25-bad-modifier) [112.531104] Starting subtest: addfb25-bad-modifier [112.532279] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [112.675284] [056/165] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.766231] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.767380] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.901649] [057/165] (890s left) kms_addfb_basic (addfb25-modifier-no-flag) [112.993458] Starting subtest: addfb25-modifier-no-flag [112.994537] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [113.121748] [058/165] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.215195] Starting subtest: addfb25-x-tiled-legacy [113.216381] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [113.352337] [059/165] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [113.442983] Starting subtest: addfb25-x-tiled-mismatch-legacy [113.444129] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [113.588292] [060/165] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [113.707762] Starting subtest: addfb25-yf-tiled-legacy [113.709047] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [113.799205] [061/165] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy) [113.917662] Starting subtest: addfb25-y-tiled-legacy [113.918831] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [114.037070] [062/165] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [114.157697] Starting subtest: addfb25-y-tiled-small-legacy [114.159067] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [114.252838] [063/165] (889s left) kms_addfb_basic (bad-pitch-0) [114.344689] Starting subtest: bad-pitch-0 [114.345785] Subtest bad-pitch-0: SUCCESS (0.000s) [114.470521] [064/165] (889s left) kms_addfb_basic (bad-pitch-1024) [114.558973] Starting subtest: bad-pitch-1024 [114.560244] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.706894] [065/165] (889s left) kms_addfb_basic (bad-pitch-128) [114.796794] Starting subtest: bad-pitch-128 [114.797987] Subtest bad-pitch-128: SUCCESS (0.000s) [114.918402] [066/165] (889s left) kms_addfb_basic (bad-pitch-256) [115.008836] Starting subtest: bad-pitch-256 [115.010190] Subtest bad-pitch-256: SUCCESS (0.000s) [115.136666] [067/165] (888s left) kms_addfb_basic (bad-pitch-32) [115.228260] Starting subtest: bad-pitch-32 [115.229376] Subtest bad-pitch-32: SUCCESS (0.000s) [115.372669] [068/165] (888s left) kms_addfb_basic (bad-pitch-63) [115.461865] Starting subtest: bad-pitch-63 [115.463114] Subtest bad-pitch-63: SUCCESS (0.000s) [115.587537] [069/165] (888s left) kms_addfb_basic (bad-pitch-65536) [115.677233] Starting subtest: bad-pitch-65536 [115.678418] Subtest bad-pitch-65536: SUCCESS (0.000s) [115.805843] [070/165] (888s left) kms_addfb_basic (bad-pitch-999) [115.896918] Starting subtest: bad-pitch-999 [115.898223] Subtest bad-pitch-999: SUCCESS (0.000s) [116.041447] [071/165] (888s left) kms_addfb_basic (basic) [116.132723] Starting subtest: basic [116.133816] Subtest basic: SUCCESS (0.000s) [116.272905] [072/165] (887s left) kms_addfb_basic (basic-x-tiled-legacy) [116.362999] Starting subtest: basic-x-tiled-legacy [116.364173] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.490181] [073/165] (887s left) kms_addfb_basic (basic-y-tiled-legacy) [116.583270] Starting subtest: basic-y-tiled-legacy [116.584355] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [116.706988] [074/165] (887s left) kms_addfb_basic (bo-too-small) [116.827486] Starting subtest: bo-too-small [116.828690] Subtest bo-too-small: SUCCESS (0.000s) [116.940233] [075/165] (887s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.058184] Starting subtest: bo-too-small-due-to-tiling [117.059372] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.150279] [076/165] (887s left) kms_addfb_basic (clobberred-modifier) [117.238195] Starting subtest: clobberred-modifier [117.239288] Subtest clobberred-modifier: SUCCESS (0.000s) [117.374085] [077/165] (886s left) kms_addfb_basic (framebuffer-vs-set-tiling) [117.463533] Starting subtest: framebuffer-vs-set-tiling [117.464714] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [117.590204] [078/165] (886s left) kms_addfb_basic (invalid-get-prop) [117.679519] Starting subtest: invalid-get-prop [117.680722] Subtest invalid-get-prop: SUCCESS (0.000s) [117.817774] [079/165] (886s left) kms_addfb_basic (invalid-get-prop-any) [117.910195] Starting subtest: invalid-get-prop-any [117.911275] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.041097] [080/165] (886s left) kms_addfb_basic (invalid-set-prop) [118.132407] Starting subtest: invalid-set-prop [118.133547] Subtest invalid-set-prop: SUCCESS (0.000s) [118.257527] [081/165] (886s left) kms_addfb_basic (invalid-set-prop-any) [118.349090] Starting subtest: invalid-set-prop-any [118.350167] Subtest invalid-set-prop-any: SUCCESS (0.000s) [118.468594] [082/165] (885s left) kms_addfb_basic (no-handle) [118.558969] Starting subtest: no-handle [118.560101] Subtest no-handle: SUCCESS (0.000s) [118.693175] [083/165] (885s left) kms_addfb_basic (size-max) [118.812309] Starting subtest: size-max [118.813473] Subtest size-max: SUCCESS (0.000s) [118.908901] [084/165] (885s left) kms_addfb_basic (small-bo) [119.028331] Starting subtest: small-bo [119.029596] Subtest small-bo: SUCCESS (0.000s) [119.125110] [085/165] (885s left) kms_addfb_basic (tile-pitch-mismatch) [119.215172] Starting subtest: tile-pitch-mismatch [119.216383] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [119.341264] [086/165] (885s left) kms_addfb_basic (too-high) [119.461030] Starting subtest: too-high [119.462250] Subtest too-high: SUCCESS (0.001s) [119.553143] [087/165] (884s left) kms_addfb_basic (too-wide) [119.672930] Starting subtest: too-wide [119.674213] Subtest too-wide: SUCCESS (0.000s) [119.753840] [088/165] (884s left) kms_addfb_basic (unused-handle) [119.846055] Starting subtest: unused-handle [119.847287] Subtest unused-handle: SUCCESS (0.000s) [119.987654] [089/165] (884s left) kms_addfb_basic (unused-modifier) [120.077425] Starting subtest: unused-modifier [120.078649] Subtest unused-modifier: SUCCESS (0.000s) [120.209959] [090/165] (884s left) kms_addfb_basic (unused-offsets) [120.300856] Starting subtest: unused-offsets [120.302121] Subtest unused-offsets: SUCCESS (0.000s) [120.427899] [091/165] (884s left) kms_addfb_basic (unused-pitches) [120.518911] Starting subtest: unused-pitches [120.520155] Subtest unused-pitches: SUCCESS (0.000s) [120.660785] [092/165] (884s left) kms_busy (basic) [120.786377] Starting subtest: basic [120.787729] Starting dynamic subtest: flip [121.794027] Dynamic subtest flip: SUCCESS (1.007s) [121.810151] Starting dynamic subtest: modeset [125.616248] Dynamic subtest modeset: SUCCESS (3.819s) [125.617410] Subtest basic: SUCCESS (4.829s) [126.589438] [093/165] (878s left) kms_prop_blob (basic) [126.681780] Starting subtest: basic [126.683077] Subtest basic: SUCCESS (0.000s) [126.771248] [094/165] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [126.888448] Starting subtest: basic-busy-flip-before-cursor-atomic [126.891071] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [126.964464] [095/165] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [127.083288] Starting subtest: basic-busy-flip-before-cursor-legacy [127.085580] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [127.168114] [096/165] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [127.286518] Starting subtest: basic-flip-after-cursor-atomic [128.581620] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.296s) [129.532076] [097/165] (875s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [129.651259] Starting subtest: basic-flip-after-cursor-legacy [130.956307] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.305s) [131.898951] [098/165] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [132.018310] Starting subtest: basic-flip-after-cursor-varying-size [133.291533] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.273s) [134.267289] [099/165] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [134.387330] Starting subtest: basic-flip-before-cursor-atomic [135.693288] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.306s) [136.635881] [100/165] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [136.755508] Starting subtest: basic-flip-before-cursor-legacy [138.062958] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.307s) [139.001524] [101/165] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [139.119504] Starting subtest: basic-flip-before-cursor-varying-size [140.427543] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.307s) [141.371886] [102/165] (863s left) kms_dsc (dsc-basic) [141.493723] Subtest dsc-basic: SKIP (0.000s) [141.544999] [103/165] (863s left) kms_flip (basic-flip-vs-dpms) [141.643925] Starting subtest: basic-flip-vs-dpms [141.646535] Starting dynamic subtest: A-eDP1 [144.514181] Dynamic subtest A-eDP1: SUCCESS (2.864s) [144.534290] Starting dynamic subtest: B-eDP1 [146.947365] Dynamic subtest B-eDP1: SUCCESS (2.433s) [146.965618] Starting dynamic subtest: C-eDP1 [149.373098] Dynamic subtest C-eDP1: SUCCESS (2.428s) [149.378631] Subtest basic-flip-vs-dpms: SUCCESS (7.734s) [150.291493] [104/165] (854s left) kms_flip (basic-flip-vs-modeset) [150.390639] Starting subtest: basic-flip-vs-modeset [150.393459] Starting dynamic subtest: A-eDP1 [153.263319] Dynamic subtest A-eDP1: SUCCESS (2.869s) [153.279901] Starting dynamic subtest: B-eDP1 [155.628049] Dynamic subtest B-eDP1: SUCCESS (2.363s) [155.644675] Starting dynamic subtest: C-eDP1 [158.001276] Dynamic subtest C-eDP1: SUCCESS (2.370s) [158.002551] Subtest basic-flip-vs-modeset: SUCCESS (7.612s) [158.973621] [105/165] (846s left) kms_flip (basic-flip-vs-wf_vblank) [159.073201] Starting subtest: basic-flip-vs-wf_vblank [159.077953] Starting dynamic subtest: A-eDP1 [161.433046] Dynamic subtest A-eDP1: SUCCESS (2.355s) [161.451971] Starting dynamic subtest: B-eDP1 [163.717608] Dynamic subtest B-eDP1: SUCCESS (2.282s) [163.734842] Starting dynamic subtest: C-eDP1 [165.962383] Dynamic subtest C-eDP1: SUCCESS (2.242s) [165.967041] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.895s) [167.289965] [106/165] (837s left) kms_flip (basic-plain-flip) [167.390397] Starting subtest: basic-plain-flip [167.393472] Starting dynamic subtest: A-eDP1 [169.468225] Dynamic subtest A-eDP1: SUCCESS (2.073s) [169.487609] Starting dynamic subtest: B-eDP1 [171.431644] Dynamic subtest B-eDP1: SUCCESS (1.961s) [171.450198] Starting dynamic subtest: C-eDP1 [173.418126] Dynamic subtest C-eDP1: SUCCESS (1.984s) [173.424721] Subtest basic-plain-flip: SUCCESS (6.035s) [174.713815] [107/165] (830s left) kms_force_connector_basic (force-connector-state) [174.808945] Starting subtest: force-connector-state [175.401957] Subtest force-connector-state: SUCCESS (0.592s) [176.491806] [108/165] (828s left) kms_force_connector_basic (force-edid) [176.585632] Starting subtest: force-edid [176.846866] Subtest force-edid: SUCCESS (0.262s) [176.968229] [109/165] (828s left) kms_force_connector_basic (force-load-detect) [177.061060] Starting subtest: force-load-detect [177.064718] Subtest force-load-detect: SKIP (0.000s) [177.186279] [110/165] (828s left) kms_force_connector_basic (prune-stale-modes) [177.281432] Starting subtest: prune-stale-modes [177.599741] Subtest prune-stale-modes: SUCCESS (0.320s) [177.719275] [111/165] (827s left) kms_frontbuffer_tracking (basic) [177.849209] Starting subtest: basic [181.205422] Subtest basic: SUCCESS (3.356s) [181.347343] [112/165] (823s left) kms_hdmi_inject (inject-audio) [181.762733] Starting subtest: inject-audio [182.008233] Subtest inject-audio: SUCCESS (0.244s) [182.693746] [113/165] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [182.814404] Starting subtest: compare-crc-sanitycheck-xr24 [182.817471] Starting dynamic subtest: pipe-A-eDP-1 [183.506340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s) [183.526259] Starting dynamic subtest: pipe-B-eDP-1 [184.918778] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s) [184.938807] Starting dynamic subtest: pipe-C-eDP-1 [186.293268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s) [186.294507] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.479s) [187.256608] [114/165] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [187.376408] Starting subtest: compare-crc-sanitycheck-nv12 [187.379500] Starting dynamic subtest: pipe-A-eDP-1 [188.319618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.938s) [188.340450] Starting dynamic subtest: pipe-B-eDP-1 [189.725978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s) [189.747485] Starting dynamic subtest: pipe-C-eDP-1 [191.103104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [191.104262] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.728s) [192.059293] [115/165] (813s left) kms_pipe_crc_basic (hang-read-crc) [192.178361] Starting subtest: hang-read-crc [192.181375] Starting dynamic subtest: pipe-A-eDP-1 [194.589199] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.408s) [194.607648] Starting dynamic subtest: pipe-B-eDP-1 [197.642138] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.050s) [197.662658] Starting dynamic subtest: pipe-C-eDP-1 [200.636525] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.991s) [200.637928] Subtest hang-read-crc: SUCCESS (8.459s) [201.593232] [116/165] (803s left) kms_pipe_crc_basic (nonblocking-crc) [201.713813] Starting subtest: nonblocking-crc [201.716904] Starting dynamic subtest: pipe-A-eDP-1 [202.602442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s) [202.621334] Starting dynamic subtest: pipe-B-eDP-1 [204.237212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.631s) [204.256019] Starting dynamic subtest: pipe-C-eDP-1 [205.781509] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s) [205.782880] Subtest nonblocking-crc: SUCCESS (4.069s) [206.713983] [117/165] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [206.834739] Starting subtest: nonblocking-crc-frame-sequence [206.837853] Starting dynamic subtest: pipe-A-eDP-1 [207.724237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s) [207.742922] Starting dynamic subtest: pipe-B-eDP-1 [209.341406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.613s) [209.360273] Starting dynamic subtest: pipe-C-eDP-1 [210.902455] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.559s) [210.903690] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.069s) [211.834806] [118/165] (793s left) kms_pipe_crc_basic (read-crc) [211.954406] Starting subtest: read-crc [211.958081] Starting dynamic subtest: pipe-A-eDP-1 [212.777853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [212.796687] Starting dynamic subtest: pipe-B-eDP-1 [214.346393] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [214.365159] Starting dynamic subtest: pipe-C-eDP-1 [215.844522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s) [215.845741] Subtest read-crc: SUCCESS (3.891s) [216.767552] [119/165] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence) [216.889346] Starting subtest: read-crc-frame-sequence [216.892664] Starting dynamic subtest: pipe-A-eDP-1 [217.710299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s) [217.729126] Starting dynamic subtest: pipe-B-eDP-1 [219.263135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [219.282021] Starting dynamic subtest: pipe-C-eDP-1 [220.757741] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s) [220.759033] Subtest read-crc-frame-sequence: SUCCESS (3.869s) [221.690154] [120/165] (783s left) kms_pm_backlight (basic-brightness) [221.810220] Starting subtest: basic-brightness [221.924600] Starting dynamic subtest: eDP-1 [222.501068] Dynamic subtest eDP-1: SUCCESS (0.585s) [222.502536] Subtest basic-brightness: SUCCESS (0.692s) [223.419676] [121/165] (782s left) kms_pm_rpm (basic-pci-d3-state) [225.260982] Starting subtest: basic-pci-d3-state [229.649325] Subtest basic-pci-d3-state: SUCCESS (4.392s) [229.881380] [122/165] (775s left) kms_pm_rpm (basic-rte) [229.969899] Starting subtest: basic-rte [236.116826] Subtest basic-rte: SUCCESS (6.145s) [237.610833] [123/165] (767s left) kms_psr (psr_primary_page_flip) [237.732365] Starting subtest: psr_primary_page_flip [237.735730] Starting dynamic subtest: eDP-1 [241.557362] Dynamic subtest eDP-1: SUCCESS (3.823s) [241.558713] Subtest psr_primary_page_flip: SUCCESS (3.826s) [242.489766] [124/165] (763s left) kms_psr (psr_cursor_plane_move) [242.611745] Starting subtest: psr_cursor_plane_move [242.612974] Starting dynamic subtest: eDP-1 [246.398201] Dynamic subtest eDP-1: SUCCESS (3.785s) [246.399520] Subtest psr_cursor_plane_move: SUCCESS (3.788s) [247.353800] [125/165] (758s left) kms_psr (psr_sprite_plane_onoff) [247.474390] Starting subtest: psr_sprite_plane_onoff [247.477984] Starting dynamic subtest: eDP-1 [251.352522] Dynamic subtest eDP-1: SUCCESS (3.875s) [251.353666] Subtest psr_sprite_plane_onoff: SUCCESS (3.878s) [252.282549] [126/165] (753s left) kms_psr (psr_primary_mmap_gtt) [252.402803] Starting subtest: psr_primary_mmap_gtt [252.406763] Starting dynamic subtest: eDP-1 [256.236367] Dynamic subtest eDP-1: SUCCESS (3.827s) [256.237614] Subtest psr_primary_mmap_gtt: SUCCESS (3.830s) [257.211866] [127/165] (748s left) kms_setmode (basic-clone-single-crtc) [257.306672] Starting subtest: basic-clone-single-crtc [257.310128] Subtest basic-clone-single-crtc: SKIP (0.000s) [257.395332] [128/165] (748s left) i915_pm_rps (basic-api) [257.492648] Starting subtest: basic-api [257.497167] Subtest basic-api: SUCCESS (0.004s) [257.593626] [129/165] (748s left) prime_self_import (basic-llseek-bad) [257.683453] Starting subtest: basic-llseek-bad [257.688216] Subtest basic-llseek-bad: SUCCESS (0.003s) [257.814393] [130/165] (748s left) prime_self_import (basic-llseek-size) [257.904081] Starting subtest: basic-llseek-size [257.906467] Subtest basic-llseek-size: SUCCESS (0.004s) [258.011540] [131/165] (747s left) prime_self_import (basic-with_fd_dup) [258.099922] Starting subtest: basic-with_fd_dup [258.104670] Subtest basic-with_fd_dup: SUCCESS (0.004s) [258.215737] [132/165] (747s left) prime_self_import (basic-with_one_bo) [258.303286] Starting subtest: basic-with_one_bo [258.308282] Subtest basic-with_one_bo: SUCCESS (0.005s) [258.391078] [133/165] (747s left) prime_self_import (basic-with_one_bo_two_files) [258.478652] Starting subtest: basic-with_one_bo_two_files [258.483625] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [258.596908] [134/165] (747s left) prime_self_import (basic-with_two_bos) [258.683770] Starting subtest: basic-with_two_bos [258.688555] Subtest basic-with_two_bos: SUCCESS (0.005s) [258.798837] [135/165] (747s left) prime_vgem (basic-fence-flip) [258.926021] Starting subtest: basic-fence-flip [259.468985] Subtest basic-fence-flip: SUCCESS (0.543s) [259.579674] [136/165] (746s left) prime_vgem (basic-fence-mmap) [259.695509] Starting subtest: basic-fence-mmap [259.745135] Subtest basic-fence-mmap: SUCCESS (0.050s) [259.868480] [137/165] (746s left) prime_vgem (basic-fence-read) [259.978922] Starting subtest: basic-fence-read [260.055041] Subtest basic-fence-read: SUCCESS (0.076s) [260.147839] [138/165] (745s left) prime_vgem (basic-gtt) [260.270574] Starting subtest: basic-gtt [260.295809] Subtest basic-gtt: SUCCESS (0.025s) [260.398184] [139/165] (745s left) prime_vgem (basic-read) [260.518962] Starting subtest: basic-read [260.556949] Subtest basic-read: SUCCESS (0.038s) [260.664666] [140/165] (745s left) prime_vgem (basic-write) [260.780105] Starting subtest: basic-write [260.823872] Subtest basic-write: SUCCESS (0.044s) [260.913435] [141/165] (745s left) vgem_basic (setversion) [261.022163] Starting subtest: setversion [261.024652] Subtest setversion: SUCCESS (0.000s) [261.097134] [142/165] (745s left) vgem_basic (create) [261.188466] Starting subtest: create [261.189690] Subtest create: SUCCESS (0.000s) [261.261919] [143/165] (744s left) vgem_basic (debugfs) [261.355569] Starting subtest: debugfs [261.356800] Subtest debugfs: SUCCESS (0.001s) [261.428478] [144/165] (744s left) vgem_basic (dmabuf-export) [261.523091] Starting subtest: dmabuf-export [261.534620] Subtest dmabuf-export: SUCCESS (0.011s) [261.632884] [145/165] (744s left) vgem_basic (dmabuf-fence) [261.739827] Starting subtest: dmabuf-fence [261.741163] Subtest dmabuf-fence: SUCCESS (0.001s) [261.823305] [146/165] (744s left) vgem_basic (dmabuf-fence-before) [261.923255] Starting subtest: dmabuf-fence-before [261.924407] Subtest dmabuf-fence-before: SUCCESS (0.001s) [261.998810] [147/165] (744s left) vgem_basic (dmabuf-mmap) [262.107126] Starting subtest: dmabuf-mmap [262.135512] Subtest dmabuf-mmap: SUCCESS (0.029s) [262.214653] [148/165] (744s left) vgem_basic (mmap) [262.323471] Starting subtest: mmap [262.342780] Subtest mmap: SUCCESS (0.017s) [262.413573] [149/165] (744s left) vgem_basic (second-client) [262.506907] Starting subtest: second-client [262.540864] Subtest second-client: SUCCESS (0.033s) [262.616025] [150/165] (743s left) vgem_basic (sysfs) [262.724367] Starting subtest: sysfs [262.725583] Subtest sysfs: SUCCESS (0.001s) [262.800287] [151/165] (743s left) core_hotunplug (unbind-rebind) [262.940802] Starting subtest: unbind-rebind [267.420466] Subtest unbind-rebind: SUCCESS (4.480s) [267.456884] [152/165] (739s left) vgem_basic (unload) [267.550183] Starting subtest: unload [296.599951] Subtest unload: SUCCESS (29.014s) [296.694401] [153/165] (709s left) i915_module_load (reload) [296.785436] Starting subtest: reload [300.113890] Subtest reload: SUCCESS (3.330s) [300.144539] [154/165] (706s left) gem_lmem_swapping (basic) [300.251854] Subtest basic: SKIP (0.000s) [300.299547] [155/165] (706s left) gem_lmem_swapping (parallel-random-engines) [300.395882] Subtest parallel-random-engines: SKIP (0.000s) [300.449490] [156/165] (706s left) gem_lmem_swapping (random-engines) [300.547076] Subtest random-engines: SKIP (0.000s) [300.601270] [157/165] (706s left) gem_lmem_swapping (verify-random) [300.698517] Subtest verify-random: SKIP (0.000s) [300.749764] [158/165] (705s left) i915_pm_rpm (module-reload) [313.217129] Starting subtest: module-reload [342.514366] Subtest module-reload: SUCCESS (29.291s) [342.538627] [159/165] (664s left) i915_selftest (live) [342.638997] Starting subtest: live [342.640281] Starting dynamic subtest: sanitycheck [344.514376] Dynamic subtest sanitycheck: SUCCESS (1.865s) [344.529269] Starting dynamic subtest: uncore [346.392593] Dynamic subtest uncore: SUCCESS (1.875s) [346.407432] Starting dynamic subtest: workarounds [348.556559] Dynamic subtest workarounds: SUCCESS (2.160s) [348.571425] Starting dynamic subtest: gt_engines [350.859560] Dynamic subtest gt_engines: SUCCESS (2.300s) [350.874433] Starting dynamic subtest: gt_timelines [363.454661] Dynamic subtest gt_timelines: SUCCESS (12.592s) [363.469277] Starting dynamic subtest: gt_contexts [365.392560] Dynamic subtest gt_contexts: SUCCESS (1.934s) [365.407439] Starting dynamic subtest: gt_lrc [369.739800] Dynamic subtest gt_lrc: SUCCESS (4.344s) [369.754859] Starting dynamic subtest: gt_mocs [371.683476] Dynamic subtest gt_mocs: SUCCESS (1.940s) [371.698527] Starting dynamic subtest: gt_pm [376.754879] Dynamic subtest gt_pm: SUCCESS (5.068s) [376.769955] Starting dynamic subtest: gt_heartbeat [378.711503] Dynamic subtest gt_heartbeat: SUCCESS (1.953s) [378.726580] Starting dynamic subtest: gt_tlb [381.831535] Dynamic subtest gt_tlb: SUCCESS (3.116s) [381.846255] Starting dynamic subtest: requests [389.399489] Dynamic subtest requests: SUCCESS (7.564s) [389.414171] Starting dynamic subtest: migrate [393.979512] Dynamic subtest migrate: SUCCESS (4.576s) [393.994474] Starting dynamic subtest: active [395.863729] Dynamic subtest active: SUCCESS (1.881s) [395.878755] Starting dynamic subtest: objects [399.550683] Dynamic subtest objects: SUCCESS (3.684s) [399.565711] Starting dynamic subtest: mman [406.439652] Dynamic subtest mman: SUCCESS (6.886s) [406.454855] Starting dynamic subtest: dmabuf [408.383165] Dynamic subtest dmabuf: SUCCESS (1.940s) [408.398265] Starting dynamic subtest: vma [410.213613] Dynamic subtest vma: SUCCESS (1.828s) [410.228650] Starting dynamic subtest: coherency [414.792631] Dynamic subtest coherency: SUCCESS (4.575s) [414.807775] Starting dynamic subtest: gtt [424.200307] Dynamic subtest gtt: SUCCESS (9.405s) [424.215453] Starting dynamic subtest: gem [426.213414] Dynamic subtest gem: SUCCESS (2.010s) [426.228471] Starting dynamic subtest: evict [430.023505] Dynamic subtest evict: SUCCESS (3.807s) [430.038273] Starting dynamic subtest: hugepages [437.809684] Dynamic subtest hugepages: SUCCESS (7.782s) [437.824975] Starting dynamic subtest: gem_contexts [453.092570] Dynamic subtest gem_contexts: SUCCESS (15.279s) [453.108022] Starting dynamic subtest: client [455.005825] Dynamic subtest client: SUCCESS (1.910s) [455.021080] Starting dynamic subtest: gem_migrate [456.861958] Dynamic subtest gem_migrate: SUCCESS (1.852s) [456.877593] Starting dynamic subtest: reset [462.212450] Dynamic subtest reset: SUCCESS (5.347s) [462.228023] Starting dynamic subtest: memory_region [464.010656] Dynamic subtest memory_region: SUCCESS (1.795s) [464.026182] Starting dynamic subtest: hangcheck [488.489621] Dynamic subtest hangcheck: SUCCESS (24.475s) [488.505287] Starting dynamic subtest: execlists [498.561579] Dynamic subtest execlists: SUCCESS (10.069s) [498.577122] Starting dynamic subtest: ring_submission [500.432473] Dynamic subtest ring_submission: SUCCESS (1.868s) [500.448083] Starting dynamic subtest: perf [502.381533] Dynamic subtest perf: SUCCESS (1.946s) [502.397078] Starting dynamic subtest: slpc [504.209791] Dynamic subtest slpc: SUCCESS (1.825s) [504.225327] Starting dynamic subtest: guc [506.081527] Dynamic subtest guc: SUCCESS (1.868s) [506.096780] Starting dynamic subtest: guc_multi_lrc [507.942797] Dynamic subtest guc_multi_lrc: SUCCESS (1.858s) [507.958492] Starting dynamic subtest: guc_hang [509.770646] Dynamic subtest guc_hang: SUCCESS (1.824s) [509.786446] Starting dynamic subtest: late_gt_pm [511.643529] Dynamic subtest late_gt_pm: SUCCESS (1.872s) [511.645034] Subtest live: SUCCESS (169.000s) [511.671665] [160/165] (495s left) dmabuf (all-tests) [511.775550] Starting subtest: all-tests [511.776905] Starting dynamic subtest: sanitycheck [511.839715] Dynamic subtest sanitycheck: SUCCESS (0.062s) [511.866617] Starting dynamic subtest: dma_fence [512.030994] Dynamic subtest dma_fence: SUCCESS (0.187s) [512.049035] Starting dynamic subtest: dma_fence_chain [529.636446] Dynamic subtest dma_fence_chain: SUCCESS (17.593s) [529.651973] Starting dynamic subtest: dma_fence_unwrap [529.708889] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s) [529.728928] Starting dynamic subtest: dma_resv [529.785673] Dynamic subtest dma_resv: SUCCESS (0.073s) [529.788148] Subtest all-tests: SUCCESS (18.011s) [529.819291] [161/165] (476s left) i915_suspend (basic-s2idle-without-i915) [529.906032] Starting subtest: basic-s2idle-without-i915 [553.022205] Subtest basic-s2idle-without-i915: SUCCESS (8.414s) [553.087330] [162/165] (468s left) i915_suspend (basic-s3-without-i915) [553.182476] Starting subtest: basic-s3-without-i915 [576.035462] Subtest basic-s3-without-i915: SUCCESS (7.073s) [576.117809] [163/165] (461s left) gem_exec_suspend (basic-s0) [576.245247] Starting subtest: basic-S0 [576.246559] Starting dynamic subtest: smem [595.938969] Dynamic subtest smem: SUCCESS (3.896s) [595.940596] Subtest basic-S0: SUCCESS (3.898s) [596.158574] [164/165] (457s left) gem_exec_suspend (basic-s3) [596.266352] Starting subtest: basic-S3 [596.267628] Starting dynamic subtest: smem [614.947678] Dynamic subtest smem: SUCCESS (3.636s) [614.948984] Subtest basic-S3: SUCCESS (3.637s) [615.163919] [165/165] (453s left) kms_pipe_crc_basic (suspend-read-crc) [615.286967] Starting subtest: suspend-read-crc [615.288277] Starting dynamic subtest: pipe-A-eDP-1 [632.911825] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [632.933338] Starting dynamic subtest: pipe-B-eDP-1 [651.882645] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.168s) [651.905497] Starting dynamic subtest: pipe-C-eDP-1 [669.876649] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.111s) [669.878041] Subtest suspend-read-crc: SUCCESS (8.793s) [670.786504] Closing watchdogs Done.