[35.758331] Initializing watchdogs [35.758426] /dev/watchdog0 [35.784976] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [35.791160] [001/162] (960s left) i915_module_load (load) [35.845649] Starting subtest: load [38.171566] Subtest load: SUCCESS (2.326s) [38.224074] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [38.228296] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [38.231495] [002/162] (958s left) core_auth (basic-auth) [38.374066] Starting subtest: basic-auth [38.399712] Subtest basic-auth: SUCCESS (0.026s) [38.542737] [003/162] (957s left) core_debugfs (read-all-entries) [38.640510] Starting subtest: read-all-entries [38.723753] Subtest read-all-entries: SUCCESS (0.082s) [38.921885] [004/162] (957s left) core_sysfs (read-all-entries) [39.022251] Starting subtest: read-all-entries [39.029621] Subtest read-all-entries: SUCCESS (0.007s) [39.183192] [005/162] (957s left) fbdev (eof) [39.272615] Starting subtest: eof [39.273601] Subtest eof: SUCCESS (0.000s) [39.385388] [006/162] (957s left) fbdev (info) [39.448134] Starting subtest: info [39.449166] Subtest info: SUCCESS (0.000s) [39.602401] [007/162] (957s left) fbdev (nullptr) [39.671697] Starting subtest: nullptr [39.672659] Subtest nullptr: SUCCESS (0.001s) [39.802651] [008/162] (956s left) fbdev (read) [39.871943] Starting subtest: read [51.966957] Subtest read: SUCCESS (12.080s) [52.118192] [009/162] (944s left) fbdev (write) [52.189172] Starting subtest: write [58.277933] Subtest write: SUCCESS (6.069s) [58.408877] [010/162] (938s left) gem_basic (bad-close) [58.509816] Starting subtest: bad-close [58.511754] Subtest bad-close: SUCCESS (0.000s) [58.634790] [011/162] (938s left) gem_basic (create-close) [58.741171] Starting subtest: create-close [58.743181] Subtest create-close: SUCCESS (0.000s) [58.954547] [012/162] (938s left) gem_basic (create-fd-close) [59.052976] Starting subtest: create-fd-close [59.055127] Subtest create-fd-close: SUCCESS (0.000s) [59.252673] [013/162] (937s left) gem_busy (busy@all-engines) [59.372883] Starting subtest: busy [59.373942] Starting dynamic subtest: all-engines [59.503469] Dynamic subtest all-engines: SUCCESS (0.130s) [59.504501] Subtest busy: SUCCESS (0.131s) [60.011543] [014/162] (937s left) gem_close_race (basic-process) [60.171671] Starting subtest: basic-process [60.246479] Subtest basic-process: SUCCESS (0.075s) [60.497571] [015/162] (936s left) gem_close_race (basic-threads) [60.651655] Starting subtest: basic-threads [61.964362] Subtest basic-threads: SUCCESS (1.311s) [62.305779] [016/162] (935s left) gem_ctx_create (basic) [62.422075] Starting subtest: basic [62.423165] Subtest basic: SUCCESS (0.000s) [62.694561] [017/162] (934s left) gem_ctx_create (basic-files) [62.806689] Starting subtest: basic-files [64.822664] Subtest basic-files: SUCCESS (2.014s) [65.452680] [018/162] (932s left) gem_ctx_exec (basic) [65.554043] Starting subtest: basic [65.562198] Subtest basic: SUCCESS (0.009s) [65.745824] [019/162] (931s left) gem_exec_basic (basic) [65.850981] Starting subtest: basic [65.851980] Starting dynamic subtest: rcs0-smem [65.855282] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [65.866046] Starting dynamic subtest: bcs0-smem [65.867024] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [65.877383] Starting dynamic subtest: vcs0-smem [65.878325] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [65.888329] Starting dynamic subtest: vcs1-smem [65.889424] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [65.899329] Starting dynamic subtest: vecs0-smem [65.900424] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [65.910386] Starting dynamic subtest: vecs1-smem [65.911471] Dynamic subtest vecs1-smem: SUCCESS (0.001s) [65.921349] Starting dynamic subtest: ccs0-smem [65.922468] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [65.932583] Starting dynamic subtest: rcs0-lmem0 [65.933631] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [65.943556] Starting dynamic subtest: bcs0-lmem0 [65.944610] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [65.954590] Starting dynamic subtest: vcs0-lmem0 [65.955611] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [65.965469] Starting dynamic subtest: vcs1-lmem0 [65.966473] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [65.976491] Starting dynamic subtest: vecs0-lmem0 [65.977365] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [65.987550] Starting dynamic subtest: vecs1-lmem0 [65.988624] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [65.998869] Starting dynamic subtest: ccs0-lmem0 [65.999951] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [66.000907] Subtest basic: SUCCESS (0.017s) [66.084101] [020/162] (931s left) gem_exec_create (basic) [66.201099] Starting subtest: basic [66.202000] Starting dynamic subtest: smem [68.402984] Dynamic subtest smem: SUCCESS (2.201s) [68.413898] Starting dynamic subtest: lmem0 [70.655363] Dynamic subtest lmem0: SUCCESS (2.251s) [70.656447] Subtest basic: SUCCESS (4.453s) [70.871632] [021/162] (926s left) gem_exec_fence (basic-busy) [71.108533] Starting subtest: basic-busy [71.109604] Starting dynamic subtest: rcs0 [71.232072] Dynamic subtest rcs0: SUCCESS (0.123s) [71.245112] Starting dynamic subtest: bcs0 [71.282421] Dynamic subtest bcs0: SUCCESS (0.050s) [71.303983] Starting dynamic subtest: vcs0 [71.339041] Dynamic subtest vcs0: SUCCESS (0.056s) [71.360090] Starting dynamic subtest: vcs1 [71.399802] Dynamic subtest vcs1: SUCCESS (0.059s) [71.436964] Starting dynamic subtest: vecs0 [71.465299] Dynamic subtest vecs0: SUCCESS (0.064s) [71.481209] Starting dynamic subtest: vecs1 [71.519873] Dynamic subtest vecs1: SUCCESS (0.054s) [71.556872] Starting dynamic subtest: ccs0 [71.579414] Dynamic subtest ccs0: SUCCESS (0.058s) [71.580683] Subtest basic-busy: SUCCESS (0.471s) [72.495115] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [72.497623] [022/162] (925s left) gem_exec_fence (basic-wait) [72.745564] Starting subtest: basic-wait [72.746558] Starting dynamic subtest: rcs0 [72.862436] Dynamic subtest rcs0: SUCCESS (0.116s) [72.876799] Starting dynamic subtest: bcs0 [72.921093] Dynamic subtest bcs0: SUCCESS (0.057s) [72.958308] Starting dynamic subtest: vcs0 [72.988564] Dynamic subtest vcs0: SUCCESS (0.066s) [73.007295] Starting dynamic subtest: vcs1 [73.052102] Dynamic subtest vcs1: SUCCESS (0.061s) [73.091341] Starting dynamic subtest: vecs0 [73.121771] Dynamic subtest vecs0: SUCCESS (0.069s) [73.140499] Starting dynamic subtest: vecs1 [73.178099] Dynamic subtest vecs1: SUCCESS (0.055s) [73.214577] Starting dynamic subtest: ccs0 [73.241466] Dynamic subtest ccs0: SUCCESS (0.062s) [73.242776] Subtest basic-wait: SUCCESS (0.496s) [74.040645] [023/162] (923s left) gem_exec_fence (basic-await) [74.286940] Starting subtest: basic-await [74.288050] Starting dynamic subtest: rcs0 [74.431428] Dynamic subtest rcs0: SUCCESS (0.144s) [74.442230] Starting dynamic subtest: bcs0 [74.534986] Dynamic subtest bcs0: SUCCESS (0.103s) [74.545834] Starting dynamic subtest: vcs0 [74.638068] Dynamic subtest vcs0: SUCCESS (0.102s) [74.650371] Starting dynamic subtest: vcs1 [74.743066] Dynamic subtest vcs1: SUCCESS (0.104s) [74.755164] Starting dynamic subtest: vecs0 [74.847510] Dynamic subtest vecs0: SUCCESS (0.104s) [74.859668] Starting dynamic subtest: vecs1 [74.953269] Dynamic subtest vecs1: SUCCESS (0.105s) [74.964509] Starting dynamic subtest: ccs0 [75.056650] Dynamic subtest ccs0: SUCCESS (0.103s) [75.057647] Subtest basic-await: SUCCESS (0.770s) [75.943852] [024/162] (922s left) gem_exec_fence (nb-await) [76.219139] Starting subtest: nb-await [76.220139] Starting dynamic subtest: rcs0 [76.328278] Dynamic subtest rcs0: SUCCESS (0.109s) [76.345226] Starting dynamic subtest: bcs0 [76.403169] Dynamic subtest bcs0: SUCCESS (0.074s) [76.416481] Starting dynamic subtest: vcs0 [76.471819] Dynamic subtest vcs0: SUCCESS (0.067s) [76.485850] Starting dynamic subtest: vcs1 [76.541665] Dynamic subtest vcs1: SUCCESS (0.069s) [76.555597] Starting dynamic subtest: vecs0 [76.611967] Dynamic subtest vecs0: SUCCESS (0.069s) [76.641539] Starting dynamic subtest: vecs1 [76.704275] Dynamic subtest vecs1: SUCCESS (0.091s) [76.744914] Starting dynamic subtest: ccs0 [76.802518] Dynamic subtest ccs0: SUCCESS (0.097s) [76.803958] Subtest nb-await: SUCCESS (0.585s) [77.690900] [025/162] (920s left) gem_exec_gttfill (basic) [77.821300] Starting subtest: basic [85.582895] Subtest basic: SUCCESS (7.760s) [85.903903] [026/162] (912s left) gem_exec_parallel (engines) [86.112225] Starting subtest: engines [86.113200] Starting dynamic subtest: basic [87.920562] Dynamic subtest basic: SUCCESS (1.809s) [87.935478] Starting dynamic subtest: contexts [92.606288] Dynamic subtest contexts: SUCCESS (4.684s) [92.617854] Starting dynamic subtest: fds [96.773073] Dynamic subtest fds: SUCCESS (4.166s) [96.785068] Starting dynamic subtest: userptr [98.426083] Dynamic subtest userptr: SUCCESS (1.653s) [98.427219] Subtest engines: SUCCESS (12.315s) [98.781465] [027/162] (899s left) gem_exec_store (basic) [98.916591] Starting subtest: basic [99.076432] Subtest basic: SUCCESS (0.160s) [99.374386] [028/162] (898s left) gem_flink_basic (bad-flink) [99.486776] Starting subtest: bad-flink [99.487760] Subtest bad-flink: SUCCESS (0.000s) [99.693325] [029/162] (898s left) gem_flink_basic (bad-open) [99.804714] Starting subtest: bad-open [99.805637] Subtest bad-open: SUCCESS (0.000s) [100.039137] [030/162] (898s left) gem_flink_basic (basic) [100.148875] Starting subtest: basic [100.149840] Subtest basic: SUCCESS (0.000s) [100.340909] [031/162] (898s left) gem_flink_basic (double-flink) [100.449048] Starting subtest: double-flink [100.449978] Subtest double-flink: SUCCESS (0.000s) [100.610660] [032/162] (898s left) gem_flink_basic (flink-lifetime) [100.718790] Starting subtest: flink-lifetime [100.769353] Subtest flink-lifetime: SUCCESS (0.051s) [100.900342] [033/162] (897s left) gem_huc_copy (huc-copy) [101.059077] Starting subtest: huc-copy [101.066455] Subtest huc-copy: SUCCESS (0.008s) [101.272782] [034/162] (897s left) gem_linear_blits (basic) [101.518581] Starting subtest: basic [101.577334] Subtest basic: SUCCESS (0.059s) [101.742329] [035/162] (897s left) gem_mmap (basic) [101.903373] Subtest basic: SKIP (0.000s) [102.009781] [036/162] (896s left) gem_mmap_gtt (basic) [102.121459] Subtest basic: SKIP (0.000s) [102.228402] [037/162] (896s left) gem_render_linear_blits (basic) [102.349842] Starting subtest: basic [102.454953] Subtest basic: SUCCESS (0.105s) [102.622796] [038/162] (896s left) gem_render_tiled_blits (basic) [102.743947] Subtest basic: SKIP (0.000s) [102.823837] [039/162] (896s left) gem_ringfill (basic-all) [103.331724] Starting subtest: basic-all [105.219374] Subtest basic-all: SUCCESS (1.888s) [105.410888] [040/162] (893s left) gem_softpin (allocator-basic) [105.533461] Starting subtest: allocator-basic [105.883179] Subtest allocator-basic: SUCCESS (0.349s) [106.071702] [041/162] (893s left) gem_softpin (allocator-basic-reserve) [106.192398] Starting subtest: allocator-basic-reserve [106.536895] Subtest allocator-basic-reserve: SUCCESS (0.344s) [106.760353] [042/162] (892s left) gem_softpin (safe-alignment) [106.884068] Starting subtest: safe-alignment [106.968245] Subtest safe-alignment: SUCCESS (0.084s) [107.138890] [043/162] (892s left) gem_sync (basic-all) [107.268084] Starting subtest: basic-all [109.658591] Subtest basic-all: SUCCESS (2.391s) [109.926543] [044/162] (889s left) gem_sync (basic-each) [110.059081] Starting subtest: basic-each [112.306669] Subtest basic-each: SUCCESS (2.248s) [112.640047] [045/162] (887s left) gem_tiled_blits (basic) [112.760430] Subtest basic: SKIP (0.000s) [112.874026] [046/162] (886s left) gem_tiled_fence_blits (basic) [112.996278] Subtest basic: SKIP (0.000s) [113.107013] [047/162] (886s left) gem_tiled_pread_basic (basic) [113.218482] Subtest basic: SKIP (0.000s) [113.321960] [048/162] (886s left) gem_wait (busy@all-engines) [113.456011] Starting subtest: busy [113.456953] Starting dynamic subtest: all-engines [114.058362] Dynamic subtest all-engines: SUCCESS (0.602s) [114.059425] Subtest busy: SUCCESS (0.603s) [114.358743] [049/162] (885s left) gem_wait (wait@all-engines) [114.490835] Starting subtest: wait [114.491874] Starting dynamic subtest: all-engines [115.608386] Dynamic subtest all-engines: SUCCESS (1.117s) [115.609550] Subtest wait: SUCCESS (1.118s) [115.958069] [050/162] (884s left) i915_getparams_basic (basic-eu-total) [116.069959] Starting subtest: basic-eu-total [116.071864] Subtest basic-eu-total: SUCCESS (0.000s) [116.214676] [051/162] (883s left) i915_getparams_basic (basic-subslice-total) [116.326978] Starting subtest: basic-subslice-total [116.328825] Subtest basic-subslice-total: SUCCESS (0.000s) [116.457071] [052/162] (883s left) i915_hangman (error-state-basic) [116.594530] Starting subtest: error-state-basic [116.786449] Subtest error-state-basic: SUCCESS (0.192s) [116.921246] [053/162] (883s left) i915_pciid [117.202555] [054/162] (883s left) intel_hwmon (hwmon-read) [117.317048] Starting subtest: hwmon-read [117.317993] Subtest hwmon-read: SUCCESS (0.001s) [117.509837] [055/162] (883s left) intel_hwmon (hwmon-write) [117.617265] Starting subtest: hwmon-write [117.642151] Subtest hwmon-write: SUCCESS (0.025s) [117.771727] [056/162] (882s left) kms_addfb_basic (addfb25-4-tiled) [117.992548] Starting subtest: addfb25-4-tiled [117.993520] Subtest addfb25-4-tiled: SUCCESS (0.000s) [118.201153] [057/162] (882s left) kms_addfb_basic (addfb25-bad-modifier) [118.421134] Starting subtest: addfb25-bad-modifier [118.422213] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [118.568189] [058/162] (882s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [118.782637] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [118.946969] [059/162] (881s left) kms_addfb_basic (addfb25-modifier-no-flag) [119.160051] Starting subtest: addfb25-modifier-no-flag [119.160956] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [119.335578] [060/162] (881s left) kms_addfb_basic (addfb25-x-tiled-legacy) [119.547647] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [119.745118] [061/162] (881s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [119.957955] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [120.178777] [062/162] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [120.395110] Starting subtest: addfb25-yf-tiled-legacy [120.396192] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [120.594953] [063/162] (880s left) kms_addfb_basic (addfb25-y-tiled-legacy) [120.812164] Starting subtest: addfb25-y-tiled-legacy [120.813176] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [121.000014] [064/162] (880s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [121.224393] Starting subtest: addfb25-y-tiled-small-legacy [121.226152] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [121.384490] [065/162] (880s left) kms_addfb_basic (bad-pitch-0) [121.494163] Starting subtest: bad-pitch-0 [121.495171] Subtest bad-pitch-0: SUCCESS (0.000s) [121.763228] [066/162] (879s left) kms_addfb_basic (bad-pitch-1024) [121.871214] Starting subtest: bad-pitch-1024 [121.872236] Subtest bad-pitch-1024: SUCCESS (0.000s) [122.122619] [067/162] (879s left) kms_addfb_basic (bad-pitch-128) [122.232957] Starting subtest: bad-pitch-128 [122.233951] Subtest bad-pitch-128: SUCCESS (0.000s) [122.545571] [068/162] (879s left) kms_addfb_basic (bad-pitch-256) [122.656227] Starting subtest: bad-pitch-256 [122.657199] Subtest bad-pitch-256: SUCCESS (0.000s) [122.901332] [069/162] (878s left) kms_addfb_basic (bad-pitch-32) [123.014066] Starting subtest: bad-pitch-32 [123.014963] Subtest bad-pitch-32: SUCCESS (0.000s) [123.280456] [070/162] (878s left) kms_addfb_basic (bad-pitch-63) [123.391066] Starting subtest: bad-pitch-63 [123.391972] Subtest bad-pitch-63: SUCCESS (0.000s) [123.676539] [071/162] (878s left) kms_addfb_basic (bad-pitch-65536) [123.796164] Starting subtest: bad-pitch-65536 [123.797137] Subtest bad-pitch-65536: SUCCESS (0.000s) [124.096384] [072/162] (877s left) kms_addfb_basic (bad-pitch-999) [124.217200] Starting subtest: bad-pitch-999 [124.218546] Subtest bad-pitch-999: SUCCESS (0.000s) [124.508095] [073/162] (877s left) kms_addfb_basic (basic) [124.617123] Starting subtest: basic [124.618105] Subtest basic: SUCCESS (0.000s) [124.915197] [074/162] (877s left) kms_addfb_basic (basic-x-tiled-legacy) [125.025050] Starting subtest: basic-x-tiled-legacy [125.026865] Subtest basic-x-tiled-legacy: SKIP (0.000s) [125.335613] [075/162] (876s left) kms_addfb_basic (basic-y-tiled-legacy) [125.448277] Starting subtest: basic-y-tiled-legacy [125.450200] Subtest basic-y-tiled-legacy: SKIP (0.000s) [125.720129] [076/162] (876s left) kms_addfb_basic (bo-too-small) [125.933561] Starting subtest: bo-too-small [125.934539] Subtest bo-too-small: SUCCESS (0.000s) [126.095518] [077/162] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling) [126.309083] Starting subtest: bo-too-small-due-to-tiling [126.311177] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [126.511501] [078/162] (876s left) kms_addfb_basic (clobberred-modifier) [126.620246] Starting subtest: clobberred-modifier [126.622217] Subtest clobberred-modifier: SKIP (0.000s) [126.910577] [079/162] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling) [127.020148] Starting subtest: framebuffer-vs-set-tiling [127.022072] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [127.270679] [080/162] (875s left) kms_addfb_basic (invalid-get-prop) [127.383142] Starting subtest: invalid-get-prop [127.384164] Subtest invalid-get-prop: SUCCESS (0.000s) [127.665281] [081/162] (875s left) kms_addfb_basic (invalid-get-prop-any) [127.776185] Starting subtest: invalid-get-prop-any [127.777142] Subtest invalid-get-prop-any: SUCCESS (0.000s) [128.053128] [082/162] (874s left) kms_addfb_basic (invalid-set-prop) [128.164312] Starting subtest: invalid-set-prop [128.165309] Subtest invalid-set-prop: SUCCESS (0.000s) [128.461611] [083/162] (874s left) kms_addfb_basic (invalid-set-prop-any) [128.573174] Starting subtest: invalid-set-prop-any [128.574176] Subtest invalid-set-prop-any: SUCCESS (0.000s) [128.878909] [084/162] (874s left) kms_addfb_basic (no-handle) [128.992115] Starting subtest: no-handle [128.993114] Subtest no-handle: SUCCESS (0.000s) [129.269893] [085/162] (873s left) kms_addfb_basic (size-max) [129.483173] Starting subtest: size-max [129.484209] Subtest size-max: SUCCESS (0.000s) [129.644598] [086/162] (873s left) kms_addfb_basic (small-bo) [129.857481] Starting subtest: small-bo [129.858464] Subtest small-bo: SUCCESS (0.000s) [130.038880] [087/162] (873s left) kms_addfb_basic (tile-pitch-mismatch) [130.153126] Starting subtest: tile-pitch-mismatch [130.155070] Subtest tile-pitch-mismatch: SKIP (0.000s) [130.406960] [088/162] (873s left) kms_addfb_basic (too-high) [130.618137] Starting subtest: too-high [130.619077] Subtest too-high: SUCCESS (0.001s) [130.773933] [089/162] (872s left) kms_addfb_basic (too-wide) [130.987572] Starting subtest: too-wide [130.988556] Subtest too-wide: SUCCESS (0.000s) [131.178734] [090/162] (872s left) kms_addfb_basic (unused-handle) [131.291202] Starting subtest: unused-handle [131.292174] Subtest unused-handle: SUCCESS (0.000s) [131.611350] [091/162] (872s left) kms_addfb_basic (unused-modifier) [131.721229] Starting subtest: unused-modifier [131.722177] Subtest unused-modifier: SUCCESS (0.000s) [132.014463] [092/162] (871s left) kms_addfb_basic (unused-offsets) [132.127243] Starting subtest: unused-offsets [132.128202] Subtest unused-offsets: SUCCESS (0.000s) [132.406467] [093/162] (871s left) kms_addfb_basic (unused-pitches) [132.518151] Starting subtest: unused-pitches [132.519061] Subtest unused-pitches: SUCCESS (0.000s) [132.802088] [094/162] (871s left) kms_busy (basic) [133.034355] Starting subtest: basic [133.036509] Starting dynamic subtest: flip [133.825134] Dynamic subtest flip: SUCCESS (0.788s) [133.841601] Starting dynamic subtest: modeset [134.971940] Dynamic subtest modeset: SUCCESS (1.147s) [134.973039] Subtest basic: SUCCESS (1.938s) [135.348011] [095/162] (868s left) kms_prop_blob (basic) [135.458062] Starting subtest: basic [135.459184] Subtest basic: SUCCESS (0.000s) [135.656585] [096/162] (868s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [135.869161] Starting subtest: basic-busy-flip-before-cursor-atomic [135.871105] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [136.015151] [097/162] (868s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [136.225044] Starting subtest: basic-busy-flip-before-cursor-legacy [136.226992] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [136.356481] [098/162] (868s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [136.574118] Starting subtest: basic-flip-after-cursor-atomic [137.666978] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.093s) [138.036596] [099/162] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [138.250180] Starting subtest: basic-flip-after-cursor-legacy [139.360176] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.110s) [139.685894] [100/162] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [139.896211] Starting subtest: basic-flip-after-cursor-varying-size [140.995981] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.100s) [141.319488] [101/162] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [141.530133] Starting subtest: basic-flip-before-cursor-atomic [142.631326] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.102s) [142.984913] [102/162] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [143.201029] Starting subtest: basic-flip-before-cursor-legacy [144.343131] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.142s) [144.639239] [103/162] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [144.852160] Starting subtest: basic-flip-before-cursor-varying-size [145.960438] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.109s) [146.350206] [104/162] (858s left) kms_dsc (dsc-basic) [146.564674] Starting subtest: dsc-basic [146.565660] Starting dynamic subtest: pipe-A-DP-1 [147.129248] Dynamic subtest pipe-A-DP-1: SUCCESS (0.564s) [147.143172] Starting dynamic subtest: pipe-B-DP-1 [147.566897] Dynamic subtest pipe-B-DP-1: SUCCESS (0.436s) [147.581704] Starting dynamic subtest: pipe-C-DP-1 [147.999960] Dynamic subtest pipe-C-DP-1: SUCCESS (0.432s) [148.014354] Starting dynamic subtest: pipe-D-DP-1 [148.455835] Dynamic subtest pipe-D-DP-1: SUCCESS (0.455s) [148.456806] Subtest dsc-basic: SUCCESS (1.892s) [148.843997] [105/162] (856s left) kms_flip (basic-flip-vs-dpms) [149.060995] Starting subtest: basic-flip-vs-dpms [149.066365] Starting dynamic subtest: A-DP1 [150.164176] Dynamic subtest A-DP1: SUCCESS (1.097s) [150.179265] Starting dynamic subtest: B-DP1 [151.061829] Dynamic subtest B-DP1: SUCCESS (0.896s) [151.075282] Starting dynamic subtest: C-DP1 [151.951627] Dynamic subtest C-DP1: SUCCESS (0.888s) [151.965390] Starting dynamic subtest: D-DP1 [152.844706] Dynamic subtest D-DP1: SUCCESS (0.892s) [152.848278] Subtest basic-flip-vs-dpms: SUCCESS (3.787s) [153.175973] [106/162] (851s left) kms_flip (basic-flip-vs-modeset) [153.393062] Starting subtest: basic-flip-vs-modeset [153.398515] Starting dynamic subtest: A-DP1 [154.318483] Dynamic subtest A-DP1: SUCCESS (0.919s) [154.333740] Starting dynamic subtest: B-DP1 [155.229590] Dynamic subtest B-DP1: SUCCESS (0.910s) [155.245062] Starting dynamic subtest: C-DP1 [156.145443] Dynamic subtest C-DP1: SUCCESS (0.913s) [156.158564] Starting dynamic subtest: D-DP1 [157.075537] Dynamic subtest D-DP1: SUCCESS (0.929s) [157.079898] Subtest basic-flip-vs-modeset: SUCCESS (3.687s) [157.382647] [107/162] (847s left) kms_flip (basic-flip-vs-wf_vblank) [157.596445] Starting subtest: basic-flip-vs-wf_vblank [157.600929] Starting dynamic subtest: A-DP1 [159.018392] Dynamic subtest A-DP1: SUCCESS (1.417s) [159.046077] Starting dynamic subtest: B-DP1 [160.197747] Dynamic subtest B-DP1: SUCCESS (1.176s) [160.213061] Starting dynamic subtest: C-DP1 [161.347786] Dynamic subtest C-DP1: SUCCESS (1.148s) [161.363375] Starting dynamic subtest: D-DP1 [162.495671] Dynamic subtest D-DP1: SUCCESS (1.146s) [162.501097] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.905s) [162.860553] [108/162] (842s left) kms_flip (basic-plain-flip) [163.083216] Starting subtest: basic-plain-flip [163.090207] Starting dynamic subtest: A-DP1 [164.068173] Dynamic subtest A-DP1: SUCCESS (0.978s) [164.085990] Starting dynamic subtest: B-DP1 [164.930331] Dynamic subtest B-DP1: SUCCESS (0.858s) [164.945059] Starting dynamic subtest: C-DP1 [165.809448] Dynamic subtest C-DP1: SUCCESS (0.877s) [165.824538] Starting dynamic subtest: D-DP1 [166.678139] Dynamic subtest D-DP1: SUCCESS (0.866s) [166.699470] Subtest basic-plain-flip: SUCCESS (3.616s) [167.061646] [109/162] (838s left) kms_force_connector_basic (force-connector-state) [167.207709] Starting subtest: force-connector-state [167.582374] Subtest force-connector-state: SUCCESS (0.375s) [168.015211] [110/162] (837s left) kms_force_connector_basic (force-edid) [168.163970] Starting subtest: force-edid [168.189952] Subtest force-edid: SUCCESS (0.026s) [168.487462] [111/162] (837s left) kms_force_connector_basic (force-load-detect) [168.632773] Starting subtest: force-load-detect [168.634559] Subtest force-load-detect: SKIP (0.000s) [168.921358] [112/162] (836s left) kms_force_connector_basic (prune-stale-modes) [169.066469] Starting subtest: prune-stale-modes [169.089354] Subtest prune-stale-modes: SUCCESS (0.024s) [169.384700] [113/162] (836s left) kms_frontbuffer_tracking (basic) [169.606788] Starting subtest: basic [173.527963] Subtest basic: SUCCESS (3.922s) [173.751394] [114/162] (832s left) kms_hdmi_inject (inject-audio) [173.938532] Starting subtest: inject-audio [174.067660] Subtest inject-audio: SUCCESS (0.130s) [174.452680] [115/162] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [174.668651] Starting subtest: compare-crc-sanitycheck-xr24 [174.669850] Starting dynamic subtest: pipe-A-DP-1 [175.298686] Dynamic subtest pipe-A-DP-1: SUCCESS (0.627s) [175.319365] Starting dynamic subtest: pipe-B-DP-1 [175.891448] Dynamic subtest pipe-B-DP-1: SUCCESS (0.589s) [175.907146] Starting dynamic subtest: pipe-C-DP-1 [176.466487] Dynamic subtest pipe-C-DP-1: SUCCESS (0.572s) [176.481930] Starting dynamic subtest: pipe-D-DP-1 [177.050392] Dynamic subtest pipe-D-DP-1: SUCCESS (0.581s) [177.051316] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.382s) [177.376057] [116/162] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [177.594578] Starting subtest: compare-crc-sanitycheck-nv12 [177.595519] Starting dynamic subtest: pipe-A-DP-1 [179.063372] Dynamic subtest pipe-A-DP-1: SUCCESS (1.466s) [179.078618] Starting dynamic subtest: pipe-B-DP-1 [180.450346] Dynamic subtest pipe-B-DP-1: SUCCESS (1.384s) [180.465780] Starting dynamic subtest: pipe-C-DP-1 [181.719279] Dynamic subtest pipe-C-DP-1: SUCCESS (1.266s) [181.734661] Starting dynamic subtest: pipe-D-DP-1 [183.001190] Dynamic subtest pipe-D-DP-1: SUCCESS (1.280s) [183.002158] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.408s) [183.332448] [117/162] (822s left) kms_pipe_crc_basic (hang-read-crc) [183.543594] Starting subtest: hang-read-crc [183.546246] Starting dynamic subtest: pipe-A-DP-1 [185.269609] Dynamic subtest pipe-A-DP-1: SUCCESS (1.724s) [185.285719] Starting dynamic subtest: pipe-B-DP-1 [186.912244] Dynamic subtest pipe-B-DP-1: SUCCESS (1.638s) [186.927383] Starting dynamic subtest: pipe-C-DP-1 [188.484501] Dynamic subtest pipe-C-DP-1: SUCCESS (1.570s) [188.500380] Starting dynamic subtest: pipe-D-DP-1 [190.060067] Dynamic subtest pipe-D-DP-1: SUCCESS (1.559s) [190.061385] Subtest hang-read-crc: SUCCESS (6.505s) [190.374500] [118/162] (815s left) kms_pipe_crc_basic (nonblocking-crc) [190.588616] Starting subtest: nonblocking-crc [190.589575] Starting dynamic subtest: pipe-A-DP-1 [191.425525] Dynamic subtest pipe-A-DP-1: SUCCESS (0.834s) [191.439377] Starting dynamic subtest: pipe-B-DP-1 [192.141373] Dynamic subtest pipe-B-DP-1: SUCCESS (0.713s) [192.155486] Starting dynamic subtest: pipe-C-DP-1 [192.843498] Dynamic subtest pipe-C-DP-1: SUCCESS (0.701s) [192.860442] Starting dynamic subtest: pipe-D-DP-1 [193.570780] Dynamic subtest pipe-D-DP-1: SUCCESS (0.723s) [193.571676] Subtest nonblocking-crc: SUCCESS (2.983s) [193.888853] [119/162] (812s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.102470] Starting subtest: nonblocking-crc-frame-sequence [194.105040] Starting dynamic subtest: pipe-A-DP-1 [194.929169] Dynamic subtest pipe-A-DP-1: SUCCESS (0.823s) [194.944475] Starting dynamic subtest: pipe-B-DP-1 [195.674423] Dynamic subtest pipe-B-DP-1: SUCCESS (0.743s) [195.690939] Starting dynamic subtest: pipe-C-DP-1 [196.429128] Dynamic subtest pipe-C-DP-1: SUCCESS (0.751s) [196.444546] Starting dynamic subtest: pipe-D-DP-1 [197.160918] Dynamic subtest pipe-D-DP-1: SUCCESS (0.728s) [197.161841] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.058s) [197.447167] [120/162] (808s left) kms_pipe_crc_basic (read-crc) [197.664617] Starting subtest: read-crc [197.665578] Starting dynamic subtest: pipe-A-DP-1 [198.424396] Dynamic subtest pipe-A-DP-1: SUCCESS (0.758s) [198.439547] Starting dynamic subtest: pipe-B-DP-1 [199.105675] Dynamic subtest pipe-B-DP-1: SUCCESS (0.678s) [199.120695] Starting dynamic subtest: pipe-C-DP-1 [199.791563] Dynamic subtest pipe-C-DP-1: SUCCESS (0.682s) [199.805954] Starting dynamic subtest: pipe-D-DP-1 [200.485622] Dynamic subtest pipe-D-DP-1: SUCCESS (0.691s) [200.486523] Subtest read-crc: SUCCESS (2.822s) [200.753711] [121/162] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence) [200.967646] Starting subtest: read-crc-frame-sequence [200.969058] Starting dynamic subtest: pipe-A-DP-1 [201.725531] Dynamic subtest pipe-A-DP-1: SUCCESS (0.749s) [201.741863] Starting dynamic subtest: pipe-B-DP-1 [202.391171] Dynamic subtest pipe-B-DP-1: SUCCESS (0.668s) [202.406650] Starting dynamic subtest: pipe-C-DP-1 [203.043403] Dynamic subtest pipe-C-DP-1: SUCCESS (0.651s) [203.058790] Starting dynamic subtest: pipe-D-DP-1 [203.702822] Dynamic subtest pipe-D-DP-1: SUCCESS (0.655s) [203.703797] Subtest read-crc-frame-sequence: SUCCESS (2.735s) [203.979975] [122/162] (802s left) kms_pm_backlight (basic-brightness) [204.194045] Subtest basic-brightness: SKIP (0.000s) [204.276976] [123/162] (802s left) kms_pm_rpm (basic-pci-d3-state) [205.981919] Starting subtest: basic-pci-d3-state [206.658060] Subtest basic-pci-d3-state: SUCCESS (0.680s) [206.881340] [124/162] (799s left) kms_pm_rpm (basic-rte) [206.952451] Starting subtest: basic-rte [209.742312] Subtest basic-rte: SUCCESS (2.790s) [210.418169] [125/162] (796s left) kms_psr (psr-primary-page-flip) [210.631677] Subtest psr-primary-page-flip: SKIP (0.000s) [210.722225] [126/162] (796s left) kms_psr (psr-cursor-plane-move) [210.935383] Subtest psr-cursor-plane-move: SKIP (0.000s) [211.041606] [127/162] (795s left) kms_psr (psr-sprite-plane-onoff) [211.256793] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [211.337678] [128/162] (795s left) kms_psr (psr-primary-mmap-gtt) [211.550674] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [211.636925] [129/162] (795s left) kms_setmode (basic-clone-single-crtc) [211.757954] Starting subtest: basic-clone-single-crtc [211.761079] Subtest basic-clone-single-crtc: SKIP (0.001s) [211.924292] [130/162] (795s left) i915_pm_rps (basic-api) [212.048396] Starting subtest: basic-api [212.050361] Subtest basic-api: SKIP (0.001s) [212.187149] [131/162] (795s left) prime_self_import (basic-llseek-bad) [212.258752] Starting subtest: basic-llseek-bad [212.298894] Subtest basic-llseek-bad: SUCCESS (0.040s) [212.481930] [132/162] (794s left) prime_self_import (basic-llseek-size) [212.552484] Starting subtest: basic-llseek-size [212.593389] Subtest basic-llseek-size: SUCCESS (0.041s) [212.792464] [133/162] (794s left) prime_self_import (basic-with_fd_dup) [212.862979] Starting subtest: basic-with_fd_dup [212.929336] Subtest basic-with_fd_dup: SUCCESS (0.066s) [213.140560] [134/162] (794s left) prime_self_import (basic-with_one_bo) [213.212447] Starting subtest: basic-with_one_bo [213.276530] Subtest basic-with_one_bo: SUCCESS (0.066s) [213.463217] [135/162] (794s left) prime_self_import (basic-with_one_bo_two_files) [213.535151] Starting subtest: basic-with_one_bo_two_files [213.600894] Subtest basic-with_one_bo_two_files: SUCCESS (0.067s) [213.827881] [136/162] (793s left) prime_self_import (basic-with_two_bos) [213.899362] Starting subtest: basic-with_two_bos [213.962189] Subtest basic-with_two_bos: SUCCESS (0.063s) [214.180203] [137/162] (793s left) prime_vgem (basic-fence-flip) [214.323747] Starting subtest: basic-fence-flip [214.496107] Subtest basic-fence-flip: SKIP (0.172s) [214.709916] [138/162] (793s left) prime_vgem (basic-fence-mmap) [214.841573] Starting subtest: basic-fence-mmap [214.843468] Subtest basic-fence-mmap: SKIP (0.000s) [215.056212] [139/162] (792s left) prime_vgem (basic-fence-read) [215.192842] Starting subtest: basic-fence-read [215.210196] Subtest basic-fence-read: SKIP (0.016s) [215.408254] [140/162] (792s left) prime_vgem (basic-gtt) [215.541261] Starting subtest: basic-gtt [215.543256] Subtest basic-gtt: SKIP (0.000s) [215.752306] [141/162] (792s left) prime_vgem (basic-read) [215.888111] Starting subtest: basic-read [215.896939] Subtest basic-read: SKIP (0.010s) [216.081736] [142/162] (792s left) prime_vgem (basic-write) [216.221478] Starting subtest: basic-write [216.230330] Subtest basic-write: SKIP (0.008s) [216.396302] [143/162] (791s left) vgem_basic (setversion) [216.474158] Starting subtest: setversion [216.476045] Subtest setversion: SUCCESS (0.000s) [216.579690] [144/162] (791s left) vgem_basic (create) [216.657276] Starting subtest: create [216.658216] Subtest create: SUCCESS (0.000s) [216.762333] [145/162] (791s left) vgem_basic (debugfs) [216.857305] Starting subtest: debugfs [216.858308] Subtest debugfs: SUCCESS (0.000s) [216.998428] [146/162] (791s left) vgem_basic (dmabuf-export) [217.090526] Starting subtest: dmabuf-export [217.133199] Subtest dmabuf-export: SUCCESS (0.044s) [217.295387] [147/162] (791s left) vgem_basic (dmabuf-fence) [217.373570] Starting subtest: dmabuf-fence [217.374527] Subtest dmabuf-fence: SUCCESS (0.001s) [217.508223] [148/162] (791s left) vgem_basic (dmabuf-fence-before) [217.588952] Starting subtest: dmabuf-fence-before [217.589953] Subtest dmabuf-fence-before: SUCCESS (0.000s) [217.695349] [149/162] (791s left) vgem_basic (dmabuf-mmap) [217.773481] Starting subtest: dmabuf-mmap [217.784645] Subtest dmabuf-mmap: SUCCESS (0.012s) [217.926637] [150/162] (790s left) vgem_basic (mmap) [218.007251] Starting subtest: mmap [218.013738] Subtest mmap: SUCCESS (0.008s) [218.112158] [151/162] (790s left) vgem_basic (second-client) [218.190662] Starting subtest: second-client [218.223777] Subtest second-client: SUCCESS (0.032s) [218.338625] [152/162] (790s left) vgem_basic (sysfs) [218.423537] Starting subtest: sysfs [218.424501] Subtest sysfs: SUCCESS (0.001s) [218.528592] [153/162] (790s left) core_hotunplug (unbind-rebind) [218.722773] Starting subtest: unbind-rebind [222.650381] Subtest unbind-rebind: SUCCESS (3.928s) [222.724664] [154/162] (786s left) vgem_basic (unload) [222.797451] Starting subtest: unload [251.834476] Subtest unload: SUCCESS (29.036s) [252.013568] [155/162] (757s left) i915_module_load (reload) [252.085342] Starting subtest: reload [255.409482] Subtest reload: SUCCESS (3.325s) [255.479268] [156/162] (753s left) gem_lmem_swapping (basic) [261.092448] Starting subtest: basic [261.093354] Starting dynamic subtest: lmem0 [292.769644] Dynamic subtest lmem0: SUCCESS (31.676s) [292.770635] Subtest basic: SUCCESS (31.678s) [295.014401] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [295.016073] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true [295.018655] [157/162] (714s left) gem_lmem_swapping (parallel-random-engines) [297.081540] Starting subtest: parallel-random-engines [297.082618] Starting dynamic subtest: lmem0 [325.837646] Dynamic subtest lmem0: SUCCESS (28.754s) [325.839371] Subtest parallel-random-engines: SUCCESS (28.756s) [326.945849] [158/162] (682s left) gem_lmem_swapping (random-engines) [328.924142] Starting subtest: random-engines [328.925077] Starting dynamic subtest: lmem0 [330.485753] Dynamic subtest lmem0: SUCCESS (1.562s) [330.486770] Subtest random-engines: SUCCESS (1.564s) [332.857010] [159/162] (676s left) gem_lmem_swapping (verify-random) [334.890427] Starting subtest: verify-random [334.895449] Starting dynamic subtest: lmem0 [345.439123] Dynamic subtest lmem0: SUCCESS (10.547s) [345.440149] Subtest verify-random: SUCCESS (10.549s) [346.520518] [160/162] (663s left) i915_pm_rpm (module-reload) [350.371375] Starting subtest: module-reload [363.460091] Subtest module-reload: SUCCESS (13.089s) [363.509287] [161/162] (646s left) i915_selftest (live)