[56.882716] Initializing watchdogs [56.882766] /dev/watchdog0 [56.897725] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.902016] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.904158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.910074] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [57.047896] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [57.052707] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [57.170264] [002/131] (960s left) gem_exec_fence (submit3) [57.347636] Starting subtest: submit3 [57.351706] Subtest submit3: SKIP (0.000s) [58.977344] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.980399] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.082665] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.086986] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.212889] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.316435] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.937960] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.625s) [65.159067] [005/131] (952s left) gem_exec_balancer (noheartbeat) [65.432520] Starting subtest: noheartbeat [65.437115] Subtest noheartbeat: SKIP (0.000s) [65.566268] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red) [65.670193] Subtest ctm-blue-to-red: SKIP (0.000s) [65.711793] [007/131] (951s left) gem_workarounds (suspend-resume) [65.787222] Starting subtest: suspend-resume [81.481368] Subtest suspend-resume: SUCCESS (5.812s) [81.648994] [008/131] (936s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [81.754452] Starting subtest: planes-downscale-factor-0-75-unity-scaling [81.756810] Starting dynamic subtest: pipe-A [81.818754] Dynamic subtest pipe-A: SUCCESS (0.066s) [81.828721] Starting dynamic subtest: pipe-B [82.972356] Dynamic subtest pipe-B: SUCCESS (1.154s) [82.982850] Starting dynamic subtest: pipe-C [84.080482] Dynamic subtest pipe-C: SUCCESS (1.108s) [84.090132] Starting dynamic subtest: pipe-D [85.211260] Dynamic subtest pipe-D: SUCCESS (1.131s) [85.213689] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.462s) [86.385074] [009/131] (931s left) gem_pxp (create-regular-buffer) [86.515906] Starting subtest: create-regular-buffer [86.517966] Subtest create-regular-buffer: SUCCESS (0.000s) [86.642815] [010/131] (931s left) gem_exec_params (rel-constants-invalid-rel-gen5) [86.706013] Starting subtest: rel-constants-invalid-rel-gen5 [86.708312] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [86.850563] [011/131] (930s left) gem_exec_nop (basic-series) [86.921871] Starting subtest: basic-series [102.771870] Subtest basic-series: SUCCESS (15.858s) [103.048437] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [103.178039] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [103.182207] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [103.297603] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [103.395959] Starting subtest: fbc-psr-primary-page-flip [103.398021] Starting dynamic subtest: eDP-1 [103.402107] Dynamic subtest eDP-1: SKIP (0.000s) [103.406231] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [103.495378] [014/131] (914s left) i915_pm_rps (engine-order) [103.564620] Starting subtest: engine-order [108.629442] Subtest engine-order: SUCCESS (5.063s) [108.807230] [015/131] (909s left) gem_softpin (evict-active) [108.879868] Starting subtest: evict-active [108.888917] Subtest evict-active: SUCCESS (0.011s) [109.065942] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [109.124085] Starting subtest: wait-delayed-signal [109.225460] Subtest wait-delayed-signal: SUCCESS (0.103s) [109.334873] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [109.429618] Starting subtest: atomic-fastset [109.432089] Starting dynamic subtest: pipe-A-eDP-1 [109.572822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s) [109.584135] Starting dynamic subtest: pipe-B-eDP-1 [110.827206] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s) [110.837112] Starting dynamic subtest: pipe-C-eDP-1 [112.012058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s) [112.020508] Starting dynamic subtest: pipe-D-eDP-1 [113.148338] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [113.150788] Subtest atomic-fastset: SUCCESS (3.720s) [114.413850] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [114.516160] Starting subtest: x-tiled-16bpp-rotate-270 [114.535286] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s) [114.694519] [019/131] (903s left) api_intel_bb (render-ccs) [114.752461] Starting subtest: render-ccs [115.187441] Subtest render-ccs: SUCCESS (0.435s) [115.341110] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [115.443803] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [115.446054] Starting dynamic subtest: pipe-A-eDP-1 [115.468616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [115.478206] Starting dynamic subtest: pipe-B-eDP-1 [115.498611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [115.506804] Starting dynamic subtest: pipe-C-eDP-1 [115.527859] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [115.537163] Starting dynamic subtest: pipe-D-eDP-1 [115.558587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [115.562645] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [117.773301] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [117.837921] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [117.939587] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [118.041720] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [118.144002] Starting subtest: psr-2p-primscrn-cur-indfb-move [118.148180] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [118.270563] [023/131] (900s left) gem_lmem_swapping (heavy-multi) [118.308836] Subtest heavy-multi: SKIP (0.000s) [118.356665] [024/131] (899s left) kms_async_flips (test-cursor) [118.456057] Starting subtest: test-cursor [118.460593] Subtest test-cursor: SKIP (0.000s) [119.704301] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [124.755162] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [124.757049] Starting dynamic subtest: pipe-A-eDP-1 [125.543163] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s) [125.553359] Starting dynamic subtest: pipe-B-eDP-1 [126.674160] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s) [126.678811] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.919s) [127.980056] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [128.086110] Starting subtest: 2x-tiling-4 [128.091098] Subtest 2x-tiling-4: SKIP (0.000s) [128.183446] [027/131] (890s left) gem_ctx_param (invalid-param-set) [128.245229] Starting subtest: invalid-param-set [128.247672] Subtest invalid-param-set: SUCCESS (0.000s) [128.345528] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [128.440119] Starting subtest: bad-pixel-format-y-tiled-ccs [128.442447] Starting dynamic subtest: pipe-A-eDP-1 [128.464896] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.478771] Starting dynamic subtest: pipe-B-eDP-1 [128.500803] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.510879] Starting dynamic subtest: pipe-C-eDP-1 [128.531959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.540481] Starting dynamic subtest: pipe-D-eDP-1 [128.563119] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.567639] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [130.645093] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [130.745376] Starting subtest: plane-downscale-factor-0-5-with-modifiers [130.747834] Starting dynamic subtest: pipe-A [130.766764] Dynamic subtest pipe-A: SKIP (0.016s) [130.775830] Starting dynamic subtest: pipe-B [130.795733] Dynamic subtest pipe-B: SKIP (0.030s) [130.805428] Starting dynamic subtest: pipe-C [130.824356] Dynamic subtest pipe-C: SKIP (0.029s) [130.832783] Starting dynamic subtest: pipe-D [130.854268] Dynamic subtest pipe-D: SKIP (0.029s) [130.857928] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.106s) [130.986166] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [131.049274] Starting subtest: multi-wait-all-available-submitted-signaled [131.051682] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [131.190643] [031/131] (887s left) perf (missing-sample-flags) [131.336147] Starting subtest: missing-sample-flags [131.338035] Subtest missing-sample-flags: SUCCESS (0.000s) [131.374186] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [131.471895] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [137.535455] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.067s) [138.739488] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [140.896454] Starting subtest: system-suspend-idle [160.685310] Subtest system-suspend-idle: SUCCESS (4.303s) [161.077299] [034/131] (857s left) kms_vblank (wait-forked) [161.183946] Starting subtest: wait-forked [161.186502] Starting dynamic subtest: pipe-A-eDP-1 [162.984755] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [162.999753] Starting dynamic subtest: pipe-D-eDP-1 [165.432923] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s) [165.435931] Subtest wait-forked: SUCCESS (4.251s) [166.325265] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [166.432860] Starting subtest: y-tiled-32bpp-rotate-0 [166.437800] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [166.572959] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [166.664977] Starting subtest: read-crc [166.667694] Starting dynamic subtest: pipe-A-eDP-1 [167.353954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s) [167.364645] Starting dynamic subtest: pipe-B-eDP-1 [168.766709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s) [168.776961] Starting dynamic subtest: pipe-C-eDP-1 [170.081850] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s) [170.093806] Starting dynamic subtest: pipe-D-eDP-1 [171.446804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.364s) [171.449755] Subtest read-crc: SUCCESS (4.783s) [172.268344] [037/131] (846s left) kms_cursor_legacy (single-move) [172.391820] Starting subtest: single-move [172.394545] Starting dynamic subtest: pipe-A [177.774832] Dynamic subtest pipe-A: SUCCESS (5.380s) [177.784740] Starting dynamic subtest: pipe-B [183.158344] Dynamic subtest pipe-B: SUCCESS (5.381s) [183.167542] Starting dynamic subtest: pipe-C [188.540475] Dynamic subtest pipe-C: SUCCESS (5.380s) [188.549427] Starting dynamic subtest: pipe-D [193.922123] Dynamic subtest pipe-D: SUCCESS (5.380s) [193.932337] Starting dynamic subtest: all-pipes [199.310458] Dynamic subtest all-pipes: SUCCESS (5.387s) [199.313102] Subtest single-move: SUCCESS (26.916s) [199.476498] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [204.505601] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [204.511431] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [205.379836] [039/131] (813s left) gem_unref_active_buffers [205.632474] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [205.732648] Starting subtest: fbc-psr2-primary-mmap-gtt [205.735007] Starting dynamic subtest: eDP-1 [205.740607] Dynamic subtest eDP-1: SKIP (0.000s) [205.745877] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [205.826752] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [205.890825] Starting subtest: invalid-signal-zero-handles [205.893831] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [206.018580] [042/131] (813s left) gen9_exec_parse (bb-oversize) [206.087804] Subtest bb-oversize: SKIP (0.000s) [206.188180] [043/131] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [206.254207] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [206.360393] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [206.464021] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [206.532978] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [206.600370] [045/131] (812s left) gem_mmap_offset (bad-flags) [206.664358] Starting subtest: bad-flags [206.666604] Subtest bad-flags: SUCCESS (0.000s) [206.785228] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [206.901412] Starting subtest: cursor-vs-flip-legacy [236.228010] Subtest cursor-vs-flip-legacy: SUCCESS (29.326s) [237.095735] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [237.198357] Starting subtest: sprite-rotation-90-pos-100-0 [237.202665] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [237.297346] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [237.394730] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [238.394497] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s) [238.569836] [049/131] (780s left) gem_create (busy-create) [238.643940] Starting subtest: busy-create [238.646936] Starting dynamic subtest: smem0 [272.326155] Dynamic subtest smem0: SUCCESS (33.678s) [272.329653] Subtest busy-create: SUCCESS (33.679s) [272.540997] [050/131] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [272.650084] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [276.840226] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.194s) [278.008274] [051/131] (741s left) perf (invalid-open-flags) [278.117636] Starting subtest: invalid-open-flags [278.120713] Subtest invalid-open-flags: SUCCESS (0.000s) [278.164678] [052/131] (741s left) perf (oa-formats) [278.277060] Starting subtest: oa-formats [278.279772] Starting dynamic subtest: 0-rcs0 [278.293654] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [278.303695] Starting dynamic subtest: 1-vcs0 [278.317669] Dynamic subtest 1-vcs0: SUCCESS (0.023s) [278.320372] Subtest oa-formats: SUCCESS (0.041s) [278.358779] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [278.466105] Starting subtest: 4-tiled-8bpp-rotate-270 [278.486802] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [278.625832] [054/131] (740s left) kms_cursor_crc (cursor-onscreen-64x21) [278.817667] Starting subtest: cursor-onscreen-64x21 [278.863380] Subtest cursor-onscreen-64x21: SKIP (0.041s) [279.105155] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [279.202923] Starting subtest: primary-4-tiled-reflect-x-180 [286.640644] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.438s) [287.857665] [056/131] (731s left) kms_cursor_crc (cursor-onscreen-256x256) [288.105973] Starting subtest: cursor-onscreen-256x256 [288.108514] Starting dynamic subtest: pipe-A-eDP-1 [290.313497] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s) [290.349947] Starting dynamic subtest: pipe-D-eDP-1 [293.109601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s) [293.111924] Subtest cursor-onscreen-256x256: SUCCESS (5.003s) [293.925009] [057/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [294.022753] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [301.260658] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.241s) [301.420187] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [301.521719] Starting subtest: async-flip-with-page-flip-events-tiled [301.900716] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [304.706492] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.804s) [304.716709] Starting dynamic subtest: pipe-A-eDP-1-4 [306.905745] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.197s) [306.918661] Starting dynamic subtest: pipe-A-eDP-1-4 [308.914543] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s) [308.925485] Starting dynamic subtest: pipe-A-eDP-1-x [311.105930] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [311.476941] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [314.236610] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s) [314.247826] Starting dynamic subtest: pipe-B-eDP-1-4 [316.423382] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [316.436095] Starting dynamic subtest: pipe-B-eDP-1-4 [318.433986] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [318.446604] Starting dynamic subtest: pipe-B-eDP-1-x [320.635630] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s) [321.002846] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [323.753590] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.759s) [323.763339] Starting dynamic subtest: pipe-C-eDP-1-4 [325.940693] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s) [325.951533] Starting dynamic subtest: pipe-C-eDP-1-4 [327.950830] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [327.962577] Starting dynamic subtest: pipe-C-eDP-1-x [330.163199] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.211s) [330.527483] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [333.282362] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.761s) [333.292804] Starting dynamic subtest: pipe-D-eDP-1-4 [335.476361] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.194s) [335.487801] Starting dynamic subtest: pipe-D-eDP-1-4 [337.486663] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [337.497233] Starting dynamic subtest: pipe-D-eDP-1-x [339.677000] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s) [339.679947] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.154s) [340.893668] [059/131] (678s left) perf (polling) [340.992866] Starting subtest: polling [340.995606] Starting dynamic subtest: 0-rcs0 [351.023993] Dynamic subtest 0-rcs0: SUCCESS (10.028s) [351.033888] Starting dynamic subtest: 1-vecs0 [361.044767] Dynamic subtest 1-vecs0: SUCCESS (10.019s) [361.047785] Subtest polling: SUCCESS (20.050s) [361.096498] [060/131] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [361.199388] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [361.204820] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [361.334442] [061/131] (658s left) syncobj_timeline (reset-signaled) [361.394608] Starting subtest: reset-signaled [361.397142] Subtest reset-signaled: SUCCESS (0.001s) [361.539113] [062/131] (658s left) kms_rmfb (rmfb-ioctl) [361.635684] Starting subtest: rmfb-ioctl [361.638367] Starting dynamic subtest: pipe-A-eDP-1 [361.741927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [361.754941] Starting dynamic subtest: pipe-B-eDP-1 [362.912848] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s) [362.923922] Starting dynamic subtest: pipe-C-eDP-1 [364.027591] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s) [364.037708] Starting dynamic subtest: pipe-D-eDP-1 [365.162363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [365.164934] Subtest rmfb-ioctl: SUCCESS (3.530s) [366.288459] [063/131] (653s left) gem_userptr_blits (create-destroy-sync) [366.363320] Starting subtest: create-destroy-sync [371.380354] Subtest create-destroy-sync: SUCCESS (5.018s) [371.555563] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active) [371.621102] Subtest basic-gtt-cpu-active: SKIP (0.000s) [371.706254] [065/131] (648s left) api_intel_allocator (execbuf-with-allocator) [371.770481] Starting subtest: execbuf-with-allocator [371.777501] Subtest execbuf-with-allocator: SUCCESS (0.010s) [371.935271] [066/131] (648s left) kms_lease (cursor-implicit-plane) [372.040966] Starting subtest: cursor-implicit-plane [372.043791] Starting dynamic subtest: pipe-A-eDP-1 [372.501918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s) [372.517698] Starting dynamic subtest: pipe-B-eDP-1 [373.593790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s) [373.604490] Starting dynamic subtest: pipe-C-eDP-1 [374.707809] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [374.717960] Starting dynamic subtest: pipe-D-eDP-1 [375.841764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [375.844553] Subtest cursor-implicit-plane: SUCCESS (3.803s) [376.722475] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [376.852481] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [376.857442] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [377.018444] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [377.072732] Starting subtest: invalid-signal-illegal-handle [377.075699] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [377.189303] [069/131] (643s left) kms_psr (psr-primary-blt) [377.282165] Starting subtest: psr-primary-blt [377.284469] Starting dynamic subtest: eDP-1 [379.006474] Dynamic subtest eDP-1: SUCCESS (1.723s) [379.008778] Subtest psr-primary-blt: SUCCESS (1.724s) [379.881473] [070/131] (640s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [379.980555] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [379.983071] Starting dynamic subtest: pipe-A-eDP-1 [380.053368] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [380.063968] Starting dynamic subtest: pipe-B-eDP-1 [380.132740] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [380.143546] Starting dynamic subtest: pipe-C-eDP-1 [380.210658] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [380.220900] Starting dynamic subtest: pipe-D-eDP-1 [380.288862] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [380.294659] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [382.148182] [071/131] (638s left) kms_psr (pr-primary-blt) [382.248778] Starting subtest: pr-primary-blt [382.254548] Subtest pr-primary-blt: SKIP (0.000s) [382.354254] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [382.452598] Starting subtest: psr-2p-primscrn-spr-indfb-move [382.457683] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [382.576757] [073/131] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [382.673756] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [382.676443] Starting dynamic subtest: pipe-A-default-mode [383.791250] Dynamic subtest pipe-A-default-mode: SKIP (1.116s) [383.797478] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.118s) [383.987244] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip) [384.082439] Starting subtest: u-semaphore-noskip [384.483369] Subtest u-semaphore-noskip: SUCCESS (0.412s) [385.320717] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle) [385.367938] Starting subtest: memory-info-idle [385.370243] Starting dynamic subtest: smem0 [385.441525] Dynamic subtest smem0: SUCCESS (0.076s) [385.444231] Subtest memory-info-idle: SUCCESS (0.077s) [385.537800] [076/131] (635s left) i915_selftest (live) [387.564914] Starting subtest: live [387.567464] Starting dynamic subtest: sanitycheck [391.660396] Dynamic subtest sanitycheck: SUCCESS (4.095s) [391.669850] Starting dynamic subtest: uncore [395.752244] Dynamic subtest uncore: SUCCESS (4.090s) [395.762241] Starting dynamic subtest: workarounds [400.377971] Dynamic subtest workarounds: SUCCESS (4.624s) [400.387854] Starting dynamic subtest: gt_engines [404.903747] Dynamic subtest gt_engines: SUCCESS (4.523s) [404.913593] Starting dynamic subtest: gt_timelines [420.320053] Dynamic subtest gt_timelines: SUCCESS (15.414s) [420.329847] Starting dynamic subtest: gt_contexts [424.498469] Dynamic subtest gt_contexts: SUCCESS (4.177s) [424.508732] Starting dynamic subtest: gt_lrc [430.247425] Dynamic subtest gt_lrc: SUCCESS (5.747s) [430.257452] Starting dynamic subtest: gt_mocs [434.665944] Dynamic subtest gt_mocs: SUCCESS (4.416s) [434.676065] Starting dynamic subtest: gt_pm [440.840909] Dynamic subtest gt_pm: SUCCESS (6.174s) [440.849513] Starting dynamic subtest: gt_heartbeat [444.905307] Dynamic subtest gt_heartbeat: SUCCESS (4.062s) [444.915590] Starting dynamic subtest: gt_tlb [456.301417] Dynamic subtest gt_tlb: SUCCESS (11.394s) [456.311417] Starting dynamic subtest: requests [469.941569] Dynamic subtest requests: SUCCESS (13.638s) [469.951953] Starting dynamic subtest: migrate [479.306913] Dynamic subtest migrate: SUCCESS (9.363s) [479.316790] Starting dynamic subtest: active [485.078260] Dynamic subtest active: SUCCESS (5.769s) [485.087511] Starting dynamic subtest: objects [489.886260] Dynamic subtest objects: SUCCESS (4.805s) [489.897421] Starting dynamic subtest: mman [496.315536] Dynamic subtest mman: SUCCESS (6.426s) [496.324831] Starting dynamic subtest: dmabuf [500.586492] Dynamic subtest dmabuf: SUCCESS (4.269s) [500.596417] Starting dynamic subtest: vma [504.718362] Dynamic subtest vma: SUCCESS (4.130s) [504.728226] Starting dynamic subtest: coherency [509.793963] Dynamic subtest coherency: SUCCESS (5.074s) [509.804229] Starting dynamic subtest: gtt [521.305862] Dynamic subtest gtt: SUCCESS (11.508s) [521.315316] Starting dynamic subtest: gem [528.205316] Dynamic subtest gem: SUCCESS (6.898s) [528.215394] Starting dynamic subtest: evict [535.076359] Dynamic subtest evict: SUCCESS (6.868s) [535.086306] Starting dynamic subtest: hugepages [548.126942] Dynamic subtest hugepages: SUCCESS (13.048s) [548.136791] Starting dynamic subtest: gem_contexts [577.383231] Dynamic subtest gem_contexts: SUCCESS (29.253s) [577.393086] Starting dynamic subtest: client [581.596478] Dynamic subtest client: SUCCESS (4.211s) [581.611522] Starting dynamic subtest: gem_migrate [585.686595] Dynamic subtest gem_migrate: SUCCESS (4.088s) [585.696768] Starting dynamic subtest: reset [589.846349] Dynamic subtest reset: SUCCESS (4.158s) [589.856333] Starting dynamic subtest: memory_region [594.035168] Dynamic subtest memory_region: SUCCESS (4.187s) [594.051263] Starting dynamic subtest: hangcheck [609.458476] Dynamic subtest hangcheck: SUCCESS (15.420s) [609.468580] Starting dynamic subtest: execlists [613.633438] Dynamic subtest execlists: SUCCESS (4.173s) [613.648435] Starting dynamic subtest: ring_submission [617.847479] Dynamic subtest ring_submission: SUCCESS (4.212s) [617.856942] Starting dynamic subtest: perf [623.524327] Dynamic subtest perf: SUCCESS (5.674s) [623.533432] Starting dynamic subtest: slpc [639.577232] Dynamic subtest slpc: SUCCESS (16.050s) [639.586791] Starting dynamic subtest: guc [644.894250] Dynamic subtest guc: SUCCESS (5.316s) [644.903834] Starting dynamic subtest: guc_multi_lrc [649.032976] Dynamic subtest guc_multi_lrc: SUCCESS (4.136s) [649.043399] Starting dynamic subtest: guc_hang [653.827636] Dynamic subtest guc_hang: SUCCESS (4.792s) [653.838223] Starting dynamic subtest: late_gt_pm [658.018359] Dynamic subtest late_gt_pm: SUCCESS (4.189s) [658.021537] Subtest live: SUCCESS (270.441s) [658.052172] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [658.052948] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [658.056759] [077/131] (362s left) gem_userptr_blits (nohangcheck) [660.958380] Starting subtest: nohangcheck [661.208101] Subtest nohangcheck: SUCCESS (0.253s) [661.287997] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [661.289193] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [661.293335] [078/131] (359s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [661.396615] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [661.398976] Starting dynamic subtest: pipe-A-eDP-1 [662.223172] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s) [662.231877] Starting dynamic subtest: pipe-B-eDP-1 [663.880232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.654s) [663.889662] Starting dynamic subtest: pipe-C-eDP-1 [665.367400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s) [665.376939] Starting dynamic subtest: pipe-D-eDP-1 [666.906861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s) [666.909267] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.501s) [668.107617] [079/131] (352s left) gem_softpin (allocator-nopin) [668.176932] Starting subtest: allocator-nopin [668.277758] Subtest allocator-nopin: SUCCESS (0.105s) [668.433100] [080/131] (352s left) kms_draw_crc (draw-method-pwrite) [668.530433] Starting subtest: draw-method-pwrite [668.532811] Starting dynamic subtest: xrgb8888-untiled [669.062199] Dynamic subtest xrgb8888-untiled: SUCCESS (0.534s) [669.071576] Starting dynamic subtest: rgb565-untiled [669.484526] Dynamic subtest rgb565-untiled: SUCCESS (0.421s) [669.494764] Starting dynamic subtest: xrgb2101010-untiled [670.029583] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [670.038585] Starting dynamic subtest: xbgr16161616f-untiled [670.763718] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.732s) [670.773700] Starting dynamic subtest: xrgb8888-xtiled [672.507213] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.743s) [672.522733] Starting dynamic subtest: rgb565-xtiled [673.550967] Dynamic subtest rgb565-xtiled: SUCCESS (1.042s) [673.559811] Starting dynamic subtest: xrgb2101010-xtiled [675.295922] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.743s) [675.306236] Starting dynamic subtest: xbgr16161616f-xtiled [678.506904] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.209s) [678.516936] Starting dynamic subtest: xrgb8888-4tiled [679.573519] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.066s) [679.582929] Starting dynamic subtest: rgb565-4tiled [680.106572] Dynamic subtest rgb565-4tiled: SUCCESS (0.533s) [680.115948] Starting dynamic subtest: xrgb2101010-4tiled [681.140651] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.031s) [681.150247] Starting dynamic subtest: xbgr16161616f-4tiled [683.984723] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.842s) [683.987733] Subtest draw-method-pwrite: SUCCESS (15.457s) [684.130677] [081/131] (336s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [684.251074] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [684.256501] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [684.394415] [082/131] (336s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [684.512715] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [684.517905] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [684.651856] [083/131] (336s left) syncobj_timeline (host-signal-points) [684.699567] Starting subtest: host-signal-points [684.701686] Subtest host-signal-points: SUCCESS (0.004s) [684.840328] [084/131] (336s left) gem_mmap_gtt (basic-small-bo) [684.903708] Subtest basic-small-bo: SKIP (0.000s) [684.979042] [085/131] (335s left) perf_pmu (semaphore-wait-idle) [685.027642] Starting subtest: semaphore-wait-idle [685.029590] Starting dynamic subtest: rcs0 [685.539960] Dynamic subtest rcs0: SUCCESS (0.514s) [685.552292] Starting dynamic subtest: bcs0 [686.054321] Dynamic subtest bcs0: SUCCESS (0.511s) [686.066963] Starting dynamic subtest: vcs0 [686.566782] Dynamic subtest vcs0: SUCCESS (0.510s) [686.579153] Starting dynamic subtest: vcs1 [687.078658] Dynamic subtest vcs1: SUCCESS (0.510s) [687.090951] Starting dynamic subtest: vecs0 [687.593540] Dynamic subtest vecs0: SUCCESS (0.511s) [687.606274] Starting dynamic subtest: ccs0 [688.109110] Dynamic subtest ccs0: SUCCESS (0.512s) [688.112234] Subtest semaphore-wait-idle: SUCCESS (3.084s) [689.362798] [086/131] (331s left) kms_addfb_basic (no-handle) [689.426830] Starting subtest: no-handle [689.429350] Subtest no-handle: SUCCESS (0.000s) [689.602767] [087/131] (331s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [689.692674] Starting subtest: fbcpsr-rgb101010-draw-pwrite [696.676438] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.987s) [696.818709] [088/131] (324s left) gem_render_copy (yf-tiled-ccs-to-linear) [696.898124] Starting subtest: yf-tiled-ccs-to-linear [696.903411] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [697.104287] [089/131] (324s left) kms_flip (wf_vblank-ts-check) [697.198075] Starting subtest: wf_vblank-ts-check [697.200937] Starting dynamic subtest: A-eDP1 [706.136453] Dynamic subtest A-eDP1: SUCCESS (8.938s) [706.146185] Starting dynamic subtest: B-eDP1 [715.059477] Dynamic subtest B-eDP1: SUCCESS (8.921s) [715.075747] Starting dynamic subtest: C-eDP1 [723.982774] Dynamic subtest C-eDP1: SUCCESS (8.921s) [723.992941] Starting dynamic subtest: D-eDP1 [732.917569] Dynamic subtest D-eDP1: SUCCESS (8.932s) [732.919977] Subtest wf_vblank-ts-check: SUCCESS (35.722s) [734.173575] [090/131] (286s left) gem_exec_schedule (deep) [734.352556] Starting subtest: deep [734.354697] Starting dynamic subtest: rcs0 [739.123798] Dynamic subtest rcs0: SKIP (4.771s) [739.136166] Starting dynamic subtest: vcs0 [749.619489] Dynamic subtest vcs0: SUCCESS (10.497s) [749.633934] Starting dynamic subtest: vcs1 [760.667751] Dynamic subtest vcs1: SUCCESS (11.046s) [760.678588] Starting dynamic subtest: vecs0 [771.781403] Dynamic subtest vecs0: SUCCESS (11.112s) [771.792790] Starting dynamic subtest: ccs0 [784.003774] Dynamic subtest ccs0: SUCCESS (12.199s) [784.009900] Subtest deep: SUCCESS (49.630s) [785.071175] [091/131] (236s left) kms_sequence (queue-idle) [785.168667] Starting subtest: queue-idle [785.170966] Starting dynamic subtest: pipe-A-eDP-1 [786.980692] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s) [786.990625] Starting dynamic subtest: pipe-B-eDP-1 [789.457774] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.477s) [789.467420] Starting dynamic subtest: pipe-C-eDP-1 [791.922162] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.462s) [791.932693] Starting dynamic subtest: pipe-D-eDP-1 [794.350433] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s) [794.352972] Subtest queue-idle: SUCCESS (9.184s) [795.191425] [092/131] (226s left) gem_gtt_cpu_tlb [795.332430] [093/131] (225s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [795.437403] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [801.975667] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.540s) [802.129324] [094/131] (219s left) gem_eio (create-ext) [802.351924] Starting subtest: create-ext [802.677697] Subtest create-ext: SUCCESS (0.325s) [802.838314] [095/131] (218s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [802.901766] Subtest writes-after-reads-uncached: SKIP (0.000s) [802.985067] [096/131] (218s left) sysfs_preempt_timeout (idempotent) [803.046184] Starting subtest: idempotent [803.048345] Starting dynamic subtest: vecs0 [803.050453] Dynamic subtest vecs0: SUCCESS (0.000s) [803.061750] Starting dynamic subtest: ccs0 [803.063822] Dynamic subtest ccs0: SUCCESS (0.000s) [803.072775] Starting dynamic subtest: vcs0 [803.074740] Dynamic subtest vcs0: SUCCESS (0.000s) [803.083826] Starting dynamic subtest: bcs0 [803.086065] Dynamic subtest bcs0: SUCCESS (0.000s) [803.094960] Starting dynamic subtest: rcs0 [803.097254] Dynamic subtest rcs0: SUCCESS (0.000s) [803.105993] Starting dynamic subtest: vcs1 [803.108069] Dynamic subtest vcs1: SUCCESS (0.000s) [803.109791] Subtest idempotent: SUCCESS (0.007s) [803.200241] [097/131] (218s left) gem_busy (semaphore) [803.394806] Subtest semaphore: SKIP (0.000s) [803.664497] [098/131] (217s left) sriov_basic (enable-vfs-bind-unbind-each) [803.729643] Starting subtest: enable-vfs-bind-unbind-each [803.732169] Starting dynamic subtest: numvfs-1 [803.824729] Dynamic subtest numvfs-1: FAIL (0.028s) [803.835246] Starting dynamic subtest: numvfs-2 [803.922873] Dynamic subtest numvfs-2: FAIL (0.004s) [803.934347] Starting dynamic subtest: numvfs-3 [804.023435] Dynamic subtest numvfs-3: FAIL (0.004s) [804.033849] Starting dynamic subtest: numvfs-4 [804.121780] Dynamic subtest numvfs-4: FAIL (0.003s) [804.132805] Starting dynamic subtest: numvfs-5 [804.218754] Dynamic subtest numvfs-5: FAIL (0.004s) [804.229227] Starting dynamic subtest: numvfs-6 [804.315693] Dynamic subtest numvfs-6: FAIL (0.004s) [804.326609] Starting dynamic subtest: numvfs-7 [804.412219] Dynamic subtest numvfs-7: FAIL (0.004s) [804.422576] Starting dynamic subtest: numvfs-random [804.501765] Dynamic subtest numvfs-random: FAIL (0.003s) [804.503601] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s) [804.542150] [099/131] (216s left) kms_pm_lpsp (screens-disabled) [805.646246] Starting subtest: screens-disabled [805.651544] Subtest screens-disabled: SKIP (0.000s) [805.741481] [100/131] (215s left) gem_exec_capture (capture-invisible) [805.815247] Starting subtest: capture-invisible [805.817799] Starting dynamic subtest: smem0 [805.823718] Dynamic subtest smem0: SKIP (0.000s) [805.828771] Subtest capture-invisible: SKIP (0.001s) [805.946538] [101/131] (215s left) gem_lmem_swapping (verify-ccs) [805.992931] Subtest verify-ccs: SKIP (0.000s) [806.045741] [102/131] (215s left) kms_joiner (basic-force-ultra-joiner) [806.152146] Starting subtest: basic-force-ultra-joiner [806.157436] Subtest basic-force-ultra-joiner: SKIP (0.000s) [806.243307] [103/131] (215s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [806.345860] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [812.829880] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.487s) [812.969081] [104/131] (208s left) kms_color (legacy-gamma) [813.069727] Starting subtest: legacy-gamma [813.072151] Starting dynamic subtest: pipe-A-eDP-1 [813.788928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s) [813.801974] Starting dynamic subtest: pipe-B-eDP-1 [815.156928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s) [815.167942] Starting dynamic subtest: pipe-C-eDP-1 [816.528542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [816.541459] Starting dynamic subtest: pipe-D-eDP-1 [817.884958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s) [817.887601] Subtest legacy-gamma: SUCCESS (4.814s) [818.713406] [105/131] (203s left) gem_exec_schedule (wide) [818.907196] Starting subtest: wide [818.909926] Starting dynamic subtest: rcs0 [830.323737] Dynamic subtest rcs0: SUCCESS (11.417s) [830.336623] Starting dynamic subtest: vcs0 [843.418673] Dynamic subtest vcs0: SUCCESS (13.093s) [843.431118] Starting dynamic subtest: vcs1 [856.051831] Dynamic subtest vcs1: SUCCESS (12.632s) [856.069621] Starting dynamic subtest: vecs0 [868.680833] Dynamic subtest vecs0: SUCCESS (12.626s) [868.694360] Starting dynamic subtest: ccs0 [882.224784] Dynamic subtest ccs0: SUCCESS (13.542s) [882.228748] Subtest wide: SUCCESS (63.317s) [883.481995] [106/131] (138s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [883.583512] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [883.586575] Starting dynamic subtest: pipe-A-default-mode [883.873796] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [883.879812] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.289s) [884.740050] [107/131] (137s left) kms_big_fb (linear-64bpp-rotate-180) [884.858833] Starting subtest: linear-64bpp-rotate-180 [886.426980] Subtest linear-64bpp-rotate-180: SUCCESS (1.567s) [886.617321] [108/131] (135s left) gem_ppgtt (blt-vs-render-ctxn) [886.685587] Starting subtest: blt-vs-render-ctxN [919.845906] Subtest blt-vs-render-ctxN: SUCCESS (33.157s) [920.021687] [109/131] (101s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [920.183927] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [920.188811] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [920.316790] [110/131] (101s left) kms_chamelium_frames (dp-frame-dump) [920.700738] Subtest dp-frame-dump: SKIP (0.000s) [921.523655] [111/131] (100s left) kms_psr2_su (page_flip-nv12) [921.587826] Subtest page_flip-NV12: SKIP (0.000s) [921.638412] [112/131] (100s left) gem_tiling_max_stride [921.784079] [113/131] (100s left) perf_pmu (busy-idle) [921.826713] Starting subtest: busy-idle [921.829839] Starting dynamic subtest: rcs0 [922.538850] Dynamic subtest rcs0: SUCCESS (0.713s) [922.561108] Starting dynamic subtest: bcs0 [923.212578] Dynamic subtest bcs0: SUCCESS (0.672s) [923.230643] Starting dynamic subtest: vcs0 [925.292368] Dynamic subtest vcs0: SUCCESS (2.075s) [925.305937] Starting dynamic subtest: vcs1 [927.277649] Dynamic subtest vcs1: SUCCESS (1.982s) [927.290992] Starting dynamic subtest: vecs0 [929.260506] Dynamic subtest vecs0: SUCCESS (1.980s) [929.273615] Starting dynamic subtest: ccs0 [929.925909] Dynamic subtest ccs0: SUCCESS (0.664s) [929.928844] Subtest busy-idle: SUCCESS (8.102s) [930.050309] [114/131] ( 92s left) dmabuf_sync_file (export-before-signal) [930.114829] Starting subtest: export-before-signal [930.117928] Subtest export-before-signal: SUCCESS (0.002s) [930.200128] [115/131] ( 92s left) gem_exec_reloc (basic-cpu-read) [930.270796] Subtest basic-cpu-read: SKIP (0.000s) [930.358279] [116/131] ( 91s left) kms_hdr (bpc-switch) [930.470732] Starting subtest: bpc-switch [931.509937] Starting dynamic subtest: pipe-A-eDP-1 [934.912087] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.401s) [934.914758] Subtest bpc-switch: SUCCESS (4.443s) [935.062304] [117/131] ( 87s left) perf (i915-ref-count) [935.177773] Starting subtest: i915-ref-count [935.249756] Subtest i915-ref-count: SUCCESS (0.069s) [935.307625] [118/131] ( 87s left) gem_ctx_isolation (nonpriv) [935.370679] Starting subtest: nonpriv [935.373753] Starting dynamic subtest: rcs0 [935.634954] Dynamic subtest rcs0: SUCCESS (0.264s) [935.646603] Starting dynamic subtest: bcs0 [935.901983] Dynamic subtest bcs0: SUCCESS (0.265s) [935.919498] Starting dynamic subtest: vcs0 [936.169624] Dynamic subtest vcs0: SUCCESS (0.267s) [936.179940] Starting dynamic subtest: vcs1 [937.468971] Dynamic subtest vcs1: SUCCESS (1.298s) [937.481813] Starting dynamic subtest: vecs0 [939.605447] Dynamic subtest vecs0: SUCCESS (2.135s) [939.618957] Starting dynamic subtest: ccs0 [941.590966] Dynamic subtest ccs0: SUCCESS (1.985s) [941.593699] Subtest nonpriv: SUCCESS (6.221s) [941.868810] [119/131] ( 80s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [941.929393] Starting subtest: y-tiled-to-vebox-x-tiled [941.934767] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [942.146424] [120/131] ( 80s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [942.239044] Starting subtest: plane-use-after-nonblocking-unbind [942.241421] Starting dynamic subtest: pipe-A-eDP-1 [942.299203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [942.611438] Starting dynamic subtest: pipe-B-eDP-1 [943.369642] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s) [943.668938] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.428s) [944.553354] [121/131] ( 77s left) i915_hangman (engine-error-state-capture) [944.620981] Starting subtest: engine-error-state-capture [944.623582] Starting dynamic subtest: rcs0 [948.234505] Dynamic subtest rcs0: SUCCESS (3.613s) [948.248506] Starting dynamic subtest: bcs0 [954.251007] Dynamic subtest bcs0: SUCCESS (6.014s) [954.264688] Starting dynamic subtest: vcs0 [960.202761] Dynamic subtest vcs0: SUCCESS (5.948s) [960.216901] Starting dynamic subtest: vcs1 [966.217515] Dynamic subtest vcs1: SUCCESS (6.012s) [966.235275] Starting dynamic subtest: vecs0 [972.170756] Dynamic subtest vecs0: SUCCESS (5.950s) [972.184967] Starting dynamic subtest: ccs0 [977.227616] Dynamic subtest ccs0: SUCCESS (5.054s) [977.230718] Subtest engine-error-state-capture: SUCCESS (32.608s) [977.398130] [122/131] ( 45s left) gem_exec_schedule (pi-shared-iova) [977.586544] Starting subtest: pi-shared-iova [977.589365] Starting dynamic subtest: rcs0 [977.738271] Dynamic subtest rcs0: SUCCESS (0.154s) [977.751969] Starting dynamic subtest: vcs0 [977.833658] Dynamic subtest vcs0: SUCCESS (0.095s) [977.847553] Starting dynamic subtest: vcs1 [977.928157] Dynamic subtest vcs1: SUCCESS (0.094s) [977.940505] Starting dynamic subtest: vecs0 [978.012636] Dynamic subtest vecs0: SUCCESS (0.082s) [978.025851] Starting dynamic subtest: ccs0 [978.137210] Dynamic subtest ccs0: SUCCESS (0.123s) [978.139793] Subtest pi-shared-iova: SUCCESS (0.554s) [979.376258] [123/131] ( 43s left) syncobj_wait (invalid-reset-illegal-handle) [979.431556] Starting subtest: invalid-reset-illegal-handle [979.434191] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [979.550083] [124/131] ( 43s left) syncobj_wait (single-wait-all-for-submit-signaled) [979.614190] Starting subtest: single-wait-all-for-submit-signaled [979.616953] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [979.743673] [125/131] ( 42s left) kms_cursor_crc (cursor-sliding-512x170) [980.044414] Starting subtest: cursor-sliding-512x170 [980.050376] Subtest cursor-sliding-512x170: SKIP (0.001s) [980.228167] [126/131] ( 42s left) kms_chamelium_hpd (hdmi-hpd-fast) [980.606789] Subtest hdmi-hpd-fast: SKIP (0.000s) [981.434436] [127/131] ( 41s left) gem_ctx_persistence (hostile) [981.493761] Starting subtest: hostile [991.657124] Subtest hostile: SUCCESS (10.158s) [991.823290] [128/131] ( 31s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [991.920952] Starting subtest: fbc-rgb565-draw-blt [996.127634] Subtest fbc-rgb565-draw-blt: SUCCESS (4.211s) [997.282905] [129/131] ( 25s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [997.382923] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1006.598808] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.217s) [1006.772362] [130/131] ( 16s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1006.872730] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1006.877769] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1007.007430] [131/131] ( 15s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1007.110804] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1007.115698] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1007.240339] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.