[57.984166] Initializing watchdogs [57.984214] /dev/watchdog0 [57.998845] [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] [58.003191] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.005339] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.008714] [001/131] (960s left) kms_pm_rpm (cursor-dpms) [60.088522] Starting subtest: cursor-dpms [60.094593] Subtest cursor-dpms: SKIP (0.000s) [60.473572] [002/131] (958s left) gem_exec_async (forked-writes) [60.550552] Starting subtest: forked-writes [60.553047] Starting dynamic subtest: rcs0 [60.576583] Dynamic subtest rcs0: SUCCESS (0.025s) [60.584531] Starting dynamic subtest: bcs0 [60.601639] Dynamic subtest bcs0: SUCCESS (0.024s) [60.609704] Starting dynamic subtest: vcs0 [60.622332] Dynamic subtest vcs0: SUCCESS (0.020s) [60.629837] Starting dynamic subtest: vcs1 [60.644738] Dynamic subtest vcs1: SUCCESS (0.022s) [60.652292] Starting dynamic subtest: vecs0 [60.668869] Dynamic subtest vecs0: SUCCESS (0.023s) [60.676907] Starting dynamic subtest: ccs0 [60.690931] Dynamic subtest ccs0: SUCCESS (0.022s) [60.693875] Subtest forked-writes: SUCCESS (0.139s) [60.940195] [003/131] (957s left) kms_cursor_crc (cursor-onscreen-512x512) [61.182763] Starting subtest: cursor-onscreen-512x512 [61.187175] Subtest cursor-onscreen-512x512: SKIP (0.001s) [61.347864] [004/131] (957s left) perf_pmu (frequency) [61.390969] Starting subtest: frequency [61.393192] Starting dynamic subtest: gt0 [63.548395] Dynamic subtest gt0: SUCCESS (2.137s) [63.557610] Starting dynamic subtest: idle-gt0 [64.054141] Dynamic subtest idle-gt0: SUCCESS (0.505s) [64.064833] Starting dynamic subtest: gt1 [68.889311] Dynamic subtest gt1: SUCCESS (4.815s) [68.899128] Starting dynamic subtest: idle-gt1 [69.393988] Dynamic subtest idle-gt1: SUCCESS (0.504s) [69.396420] Subtest frequency: SUCCESS (7.970s) [69.543937] [005/131] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [69.657698] Starting subtest: plane-primary-toggle-with-vblank-wait [69.660057] Starting dynamic subtest: pipe-A-eDP-1 [69.829328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [70.135050] Starting dynamic subtest: pipe-B-eDP-1 [71.004935] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.876s) [71.306083] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.648s) [72.179475] [006/131] (946s left) gem_ctx_persistence (legacy-engines-queued) [72.245429] Starting subtest: legacy-engines-queued [72.247713] Starting dynamic subtest: render [72.348511] Dynamic subtest render: SUCCESS (0.103s) [72.359780] Starting dynamic subtest: bsd1 [73.847258] Dynamic subtest bsd1: SUCCESS (1.493s) [73.855948] Starting dynamic subtest: bsd2 [75.892254] Dynamic subtest bsd2: SUCCESS (2.041s) [75.903736] Starting dynamic subtest: blt [75.964389] Dynamic subtest blt: SUCCESS (0.072s) [75.974644] Starting dynamic subtest: vebox [77.877057] Dynamic subtest vebox: SUCCESS (1.907s) [77.880049] Subtest legacy-engines-queued: SUCCESS (5.624s) [77.976655] [007/131] (940s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [78.075094] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [78.077366] Starting dynamic subtest: pipe-A-eDP-1 [78.136930] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [78.144420] Starting dynamic subtest: pipe-B-eDP-1 [78.202197] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [78.211832] Starting dynamic subtest: pipe-C-eDP-1 [78.268849] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [78.278536] Starting dynamic subtest: pipe-D-eDP-1 [78.335391] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [78.340120] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s) [80.345306] [008/131] (938s left) kms_content_protection (lic-type-1) [80.485920] Starting subtest: lic-type-1 [80.490578] Subtest lic-type-1: SKIP (0.000s) [80.612496] [009/131] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [80.732820] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [80.737131] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [80.875542] [010/131] (937s left) kms_display_modes (extended-mode-basic) [80.977726] Starting subtest: extended-mode-basic [80.981766] Subtest extended-mode-basic: SKIP (0.000s) [81.022332] [011/131] (937s left) gem_exec_schedule (u-lateslice) [81.107716] Starting subtest: u-lateslice [81.109919] Starting dynamic subtest: rcs0 [81.118530] Dynamic subtest rcs0: SUCCESS (0.021s) [81.128186] Starting dynamic subtest: bcs0 [81.139794] Dynamic subtest bcs0: SUCCESS (0.021s) [81.147894] Starting dynamic subtest: vcs0 [81.158602] Dynamic subtest vcs0: SUCCESS (0.018s) [81.166306] Starting dynamic subtest: vcs1 [81.176638] Dynamic subtest vcs1: SUCCESS (0.018s) [81.184330] Starting dynamic subtest: vecs0 [81.193685] Dynamic subtest vecs0: SUCCESS (0.017s) [81.201267] Starting dynamic subtest: ccs0 [81.211756] Dynamic subtest ccs0: SUCCESS (0.018s) [81.214018] Subtest u-lateslice: SUCCESS (0.115s) [83.030541] [012/131] (935s left) kms_flip_event_leak (basic) [83.136871] Starting subtest: basic [83.139085] Starting dynamic subtest: pipe-A-eDP-1 [83.554937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s) [83.563763] Starting dynamic subtest: pipe-B-eDP-1 [84.631924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s) [84.641430] Starting dynamic subtest: pipe-C-eDP-1 [85.747226] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s) [85.756416] Starting dynamic subtest: pipe-D-eDP-1 [86.887071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s) [86.889809] Subtest basic: SUCCESS (3.749s) [87.774403] [013/131] (931s left) gem_ccs (block-copy-compressed) [87.845215] Starting subtest: block-copy-compressed [87.849833] Subtest block-copy-compressed: SKIP (0.000s) [87.976505] [014/131] (931s left) kms_getfb (getfb2-handle-protection) [88.095891] Starting subtest: getfb2-handle-protection [88.123806] Subtest getfb2-handle-protection: SUCCESS (0.028s) [88.277689] [015/131] (930s left) gem_exec_fence (invalid-timeline-fence-array) [88.868555] Starting subtest: invalid-timeline-fence-array [88.873652] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [90.065288] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [90.068595] [016/131] (929s left) kms_psr (fbc-psr-primary-mmap-gtt) [90.182261] Starting subtest: fbc-psr-primary-mmap-gtt [90.184612] Starting dynamic subtest: eDP-1 [90.189134] Dynamic subtest eDP-1: SKIP (0.000s) [90.193651] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [90.279319] [017/131] (928s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [90.381527] Starting subtest: fbc-psr2-cursor-mmap-gtt [90.383712] Starting dynamic subtest: eDP-1 [90.387711] Dynamic subtest eDP-1: SKIP (0.000s) [90.391744] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [90.480183] [018/131] (928s left) syncobj_wait (wait-any-interrupted) [90.549343] Starting subtest: wait-any-interrupted [90.650846] Subtest wait-any-interrupted: SUCCESS (0.101s) [90.748140] [019/131] (928s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [90.845274] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [90.847642] Starting dynamic subtest: pipe-A-eDP-1 [90.870578] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [90.879738] Starting dynamic subtest: pipe-B-eDP-1 [90.900195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [90.907633] Starting dynamic subtest: pipe-C-eDP-1 [90.928096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [90.936222] Starting dynamic subtest: pipe-D-eDP-1 [90.958651] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [90.963088] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s) [93.140871] [020/131] (926s left) gem_eio (unwedge-stress) [93.360860] Starting subtest: unwedge-stress [93.363221] Starting dynamic subtest: render [98.217991] Dynamic subtest render: SUCCESS (4.854s) [98.232688] Starting dynamic subtest: bsd1 [116.405212] Dynamic subtest bsd1: SUCCESS (18.182s) [116.421211] Starting dynamic subtest: bsd2 [134.409448] Dynamic subtest bsd2: SUCCESS (18.002s) [134.423580] Starting dynamic subtest: blt [134.427688] Dynamic subtest blt: SKIP (0.000s) [134.435737] Starting dynamic subtest: vebox [152.388087] Dynamic subtest vebox: SUCCESS (17.978s) [152.390620] Subtest unwedge-stress: SUCCESS (59.018s) [154.006750] [021/131] (865s left) perf_pmu (busy-hang) [154.048350] Starting subtest: busy-hang [154.050723] Starting dynamic subtest: rcs0 [155.314951] Dynamic subtest rcs0: SUCCESS (1.264s) [155.325524] Starting dynamic subtest: bcs0 [156.622252] Dynamic subtest bcs0: SUCCESS (1.309s) [156.633314] Starting dynamic subtest: vcs0 [158.429047] Dynamic subtest vcs0: SUCCESS (1.799s) [158.440928] Starting dynamic subtest: vcs1 [160.412259] Dynamic subtest vcs1: SUCCESS (1.989s) [160.423595] Starting dynamic subtest: vecs0 [162.464234] Dynamic subtest vecs0: SUCCESS (2.049s) [162.475059] Starting dynamic subtest: ccs0 [163.702842] Dynamic subtest ccs0: SUCCESS (1.237s) [163.705262] Subtest busy-hang: SUCCESS (9.652s) [163.838555] [022/131] (855s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [163.897415] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [163.899967] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [164.018861] [023/131] (855s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [164.130301] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [164.132620] Starting dynamic subtest: pipe-A-default-mode [164.419625] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [164.424320] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.288s) [165.272367] [024/131] (854s left) kms_cursor_legacy (cursor-vs-flip-legacy) [165.388995] Starting subtest: cursor-vs-flip-legacy [194.670845] Subtest cursor-vs-flip-legacy: SUCCESS (29.281s) [195.505865] [025/131] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [195.607635] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [202.663568] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.060s) [202.812803] [026/131] (816s left) syncobj_basic (bad-handle-to-fd) [202.882737] Starting subtest: bad-handle-to-fd [202.885051] Subtest bad-handle-to-fd: SUCCESS (0.000s) [203.019253] [027/131] (816s left) kms_content_protection (srm) [203.178818] Starting subtest: srm [203.185832] Subtest srm: SKIP (0.002s) [203.343370] [028/131] (816s left) kms_properties (get_properties-sanity-atomic) [203.449018] Starting subtest: get_properties-sanity-atomic [203.451910] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [203.546073] [029/131] (816s left) gem_request_retire (retire-vma-not-inactive) [203.608196] Starting subtest: retire-vma-not-inactive [203.667309] Subtest retire-vma-not-inactive: SUCCESS (0.057s) [203.806397] [030/131] (815s left) kms_rotation_crc (primary-rotation-180) [203.899054] Starting subtest: primary-rotation-180 [210.979434] Subtest primary-rotation-180: SUCCESS (7.082s) [212.192217] [031/131] (807s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [212.286084] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [212.288536] Starting dynamic subtest: pipe-A-eDP-1 [229.023633] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.516s) [229.033979] Starting dynamic subtest: pipe-B-eDP-1 [246.949636] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.828s) [246.963981] Starting dynamic subtest: pipe-C-eDP-1 [264.926303] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s) [264.938139] Starting dynamic subtest: pipe-D-eDP-1 [282.925282] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.731s) [282.927316] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (13.843s) [294.217793] [032/131] (735s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [294.286195] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [294.355321] [033/131] (735s left) gem_shrink (reclaim) [294.412343] Starting subtest: reclaim [296.859012] Subtest reclaim: SUCCESS (2.360s) [297.041216] [034/131] (732s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [297.115637] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [297.219640] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.100s) [297.365177] [035/131] (732s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [297.485010] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [297.489564] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [297.623529] [036/131] (732s left) kms_dsc (dsc-fractional-bpp) [297.727134] Starting subtest: dsc-fractional-bpp [297.740417] Subtest dsc-fractional-bpp: SKIP (0.000s) [297.827343] [037/131] (732s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [297.965757] Starting subtest: cursorB-vs-flipB-atomic [297.970377] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [298.139379] [038/131] (731s left) prime_vgem (fence-flip-hang) [298.224315] Subtest fence-flip-hang: SKIP (0.000s) [298.366742] [039/131] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [298.476614] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [305.958294] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.365s) [306.120346] [040/131] (724s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [306.207100] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [306.209412] Starting dynamic subtest: pipe-A [306.228907] Dynamic subtest pipe-A: SKIP (0.018s) [306.239156] Starting dynamic subtest: pipe-B [306.260910] Dynamic subtest pipe-B: SKIP (0.032s) [306.270764] Starting dynamic subtest: pipe-C [306.294933] Dynamic subtest pipe-C: SKIP (0.032s) [306.304259] Starting dynamic subtest: pipe-D [306.326910] Dynamic subtest pipe-D: SKIP (0.031s) [306.330704] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.116s) [306.465129] [041/131] (723s left) gem_mmap (pf-nonblock) [306.530684] Subtest pf-nonblock: SKIP (0.000s) [306.601961] [042/131] (723s left) kms_plane_multiple (tiling-y) [306.689853] Starting subtest: tiling-y [306.694198] Subtest tiling-y: SKIP (0.000s) [306.790572] [043/131] (723s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [306.896385] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [306.900011] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [307.035857] [044/131] (723s left) kms_async_flips (alternate-sync-async-flip-atomic) [307.135340] Starting subtest: alternate-sync-async-flip-atomic [307.515805] Starting dynamic subtest: pipe-A-eDP-1 [310.279309] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.745s) [310.678120] Starting dynamic subtest: pipe-B-eDP-1 [313.424737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.743s) [313.804900] Starting dynamic subtest: pipe-C-eDP-1 [316.562200] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s) [316.941368] Starting dynamic subtest: pipe-D-eDP-1 [319.707905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [319.710020] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.521s) [320.921261] [045/131] (709s left) perf (polling) [321.076617] Starting subtest: polling [321.078583] Starting dynamic subtest: 0-rcs0 [331.087173] Dynamic subtest 0-rcs0: SUCCESS (10.002s) [331.097388] Starting dynamic subtest: 1-vcs0 [341.113171] Dynamic subtest 1-vcs0: SUCCESS (10.020s) [341.115899] Subtest polling: SUCCESS (20.025s) [341.163478] [046/131] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [341.277935] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [348.058530] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.780s) [348.231672] [047/131] (682s left) gem_exec_schedule (preempt-engines) [348.311654] Starting subtest: preempt-engines [348.313637] Starting dynamic subtest: rcs0 [350.571831] Dynamic subtest rcs0: SUCCESS (2.265s) [350.583043] Starting dynamic subtest: bcs0 [352.876348] Dynamic subtest bcs0: SUCCESS (2.301s) [352.889860] Starting dynamic subtest: vcs0 [355.141411] Dynamic subtest vcs0: SUCCESS (2.261s) [355.154046] Starting dynamic subtest: vcs1 [357.411302] Dynamic subtest vcs1: SUCCESS (2.266s) [357.423829] Starting dynamic subtest: vecs0 [359.676249] Dynamic subtest vecs0: SUCCESS (2.261s) [359.691294] Starting dynamic subtest: ccs0 [362.039755] Dynamic subtest ccs0: SUCCESS (2.360s) [362.042712] Subtest preempt-engines: SUCCESS (13.728s) [362.368395] [048/131] (668s left) gem_create (create-valid-nonaligned) [362.431234] Starting subtest: create-valid-nonaligned [362.433568] Subtest create-valid-nonaligned: SUCCESS (0.000s) [362.649592] [049/131] (667s left) gem_spin_batch (spin-all) [362.712482] Starting subtest: spin-all [362.732841] Subtest spin-all: SUCCESS (0.019s) [364.785260] [050/131] (665s left) kms_addfb_basic (tile-pitch-mismatch) [364.845923] Starting subtest: tile-pitch-mismatch [364.850493] Subtest tile-pitch-mismatch: SKIP (0.000s) [365.018568] [051/131] (665s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [365.076328] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [365.078224] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [365.201031] [052/131] (665s left) gem_mmap_gtt (basic-write-gtt) [365.258630] Subtest basic-write-gtt: SKIP (0.000s) [365.326279] [053/131] (665s left) kms_sequence (queue-idle) [365.415135] Starting subtest: queue-idle [365.417054] Starting dynamic subtest: pipe-A-eDP-1 [367.225940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s) [367.237891] Starting dynamic subtest: pipe-B-eDP-1 [369.715733] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.484s) [369.731517] Starting dynamic subtest: pipe-C-eDP-1 [372.138848] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s) [372.154492] Starting dynamic subtest: pipe-D-eDP-1 [374.572660] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s) [374.574831] Subtest queue-idle: SUCCESS (9.153s) [375.407511] [054/131] (655s left) kms_psr (psr2-primary-mmap-gtt) [375.511870] Starting subtest: psr2-primary-mmap-gtt [375.514131] Starting dynamic subtest: eDP-1 [376.967938] Dynamic subtest eDP-1: SKIP (1.453s) [376.972513] Subtest psr2-primary-mmap-gtt: SKIP (1.455s) [377.146937] [055/131] (653s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [377.257691] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [378.037779] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s) [378.280041] [056/131] (652s left) gem_ctx_bad_destroy (double-destroy) [378.334097] Starting subtest: double-destroy [378.336502] Subtest double-destroy: SUCCESS (0.000s) [378.436478] [057/131] (652s left) gem_ctx_persistence (engines-hostile) [378.500765] Starting subtest: engines-hostile [378.503024] Starting dynamic subtest: rcs0 [378.665516] Dynamic subtest rcs0: SUCCESS (0.163s) [378.678098] Starting dynamic subtest: bcs0 [378.783615] Dynamic subtest bcs0: SUCCESS (0.117s) [378.794465] Starting dynamic subtest: vcs0 [378.901642] Dynamic subtest vcs0: SUCCESS (0.116s) [378.913773] Starting dynamic subtest: vcs1 [379.005389] Dynamic subtest vcs1: SUCCESS (0.102s) [379.016148] Starting dynamic subtest: vecs0 [379.110370] Dynamic subtest vecs0: SUCCESS (0.103s) [379.122384] Starting dynamic subtest: ccs0 [379.219608] Dynamic subtest ccs0: SUCCESS (0.107s) [379.221966] Subtest engines-hostile: SUCCESS (0.720s) [379.325355] [058/131] (651s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [379.421386] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [379.423141] Starting dynamic subtest: A-eDP1 [388.361038] Dynamic subtest A-eDP1: SUCCESS (8.933s) [388.378801] Starting dynamic subtest: B-eDP1 [397.296762] Dynamic subtest B-eDP1: SUCCESS (8.936s) [397.308596] Starting dynamic subtest: C-eDP1 [406.207633] Dynamic subtest C-eDP1: SUCCESS (8.910s) [406.218739] Starting dynamic subtest: D-eDP1 [415.136108] Dynamic subtest D-eDP1: SUCCESS (8.928s) [415.141923] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.721s) [416.385422] [059/131] (614s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [416.487214] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [416.491710] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [417.608575] [060/131] (613s left) kms_plane_alpha_blend (alpha-transparent-fb) [417.718420] Starting subtest: alpha-transparent-fb [417.999424] Starting dynamic subtest: pipe-A-eDP-1 [418.620963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [418.631738] Starting dynamic subtest: pipe-D-eDP-1 [420.073342] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.449s) [420.075745] Subtest alpha-transparent-fb: SUCCESS (2.356s) [420.962324] [061/131] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [421.058530] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [421.062583] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [421.195045] [062/131] (609s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [426.223055] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [426.225539] Starting dynamic subtest: pipe-A-eDP-1 [427.005756] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s) [427.016475] Starting dynamic subtest: pipe-B-eDP-1 [428.131627] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [428.135590] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.906s) [429.356995] [063/131] (601s left) kms_prop_blob (invalid-set-prop) [429.416136] Starting subtest: invalid-set-prop [429.418212] Subtest invalid-set-prop: SUCCESS (0.000s) [429.558359] [064/131] (601s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [429.654058] Starting subtest: fbcpsr-rgb565-draw-pwrite [436.615319] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.961s) [436.755849] [065/131] (594s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [436.846138] Starting subtest: random-ccs-data-yf-tiled-ccs [436.848376] Starting dynamic subtest: pipe-A-eDP-1 [436.873149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [436.885124] Starting dynamic subtest: pipe-B-eDP-1 [436.908330] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [436.917857] Starting dynamic subtest: pipe-C-eDP-1 [436.940956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [436.950493] Starting dynamic subtest: pipe-D-eDP-1 [436.974223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [436.978222] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s) [439.138711] [066/131] (592s left) i915_query (engine-info-invalid) [439.205534] Starting subtest: engine-info-invalid [439.207617] Subtest engine-info-invalid: SUCCESS (0.000s) [439.348460] [067/131] (591s left) kms_atomic_interruptible (legacy-dpms) [439.445352] Starting subtest: legacy-dpms [439.447542] Starting dynamic subtest: pipe-A-eDP-1 [446.845762] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s) [446.848682] Subtest legacy-dpms: SUCCESS (7.399s) [447.697388] [068/131] (583s left) kms_big_fb (linear-64bpp-rotate-90) [447.809684] Starting subtest: linear-64bpp-rotate-90 [447.828793] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [447.979790] [069/131] (583s left) gem_exec_whisper (basic-fds-forked-all) [448.043769] Starting subtest: basic-fds-forked-all [467.835151] Subtest basic-fds-forked-all: SUCCESS (19.781s) [468.047085] [070/131] (563s left) syncobj_wait (invalid-signal-zero-handles) [468.110662] Starting subtest: invalid-signal-zero-handles [468.113139] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [468.249041] [071/131] (563s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [468.347350] Starting subtest: primary-x-tiled-reflect-x-180 [475.487852] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.137s) [476.771761] [072/131] (554s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [476.875943] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [476.878193] Starting dynamic subtest: pipe-A [476.897600] Dynamic subtest pipe-A: SKIP (0.018s) [476.907924] Starting dynamic subtest: pipe-B [476.938802] Dynamic subtest pipe-B: SKIP (0.039s) [476.949364] Starting dynamic subtest: pipe-C [476.970500] Dynamic subtest pipe-C: SKIP (0.032s) [476.980144] Starting dynamic subtest: pipe-D [477.003043] Dynamic subtest pipe-D: SKIP (0.032s) [477.006679] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.124s) [477.117251] [073/131] (554s left) syncobj_basic (illegal-fd-to-handle) [477.177037] Starting subtest: illegal-fd-to-handle [477.179070] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [477.313259] [074/131] (554s left) i915_drm_fdinfo (isolation) [477.351631] Starting subtest: isolation [477.353520] Starting dynamic subtest: rcs0 [477.384131] Dynamic subtest rcs0: SKIP (0.032s) [477.396168] Starting dynamic subtest: bcs0 [477.400336] Dynamic subtest bcs0: SKIP (0.000s) [477.409999] Starting dynamic subtest: vcs0 [477.414006] Dynamic subtest vcs0: SKIP (0.000s) [477.422757] Starting dynamic subtest: vcs1 [477.426754] Dynamic subtest vcs1: SKIP (0.000s) [477.435447] Starting dynamic subtest: vecs0 [477.439374] Dynamic subtest vecs0: SKIP (0.000s) [477.448118] Starting dynamic subtest: ccs0 [477.452217] Dynamic subtest ccs0: SKIP (0.000s) [477.456252] Subtest isolation: SKIP (0.038s) [477.494761] [075/131] (554s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [479.012651] Starting subtest: modeset-non-lpsp-stress-no-wait [479.064156] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.049s) [479.796629] [076/131] (551s left) kms_psr (pr-cursor-plane-move) [479.889642] Starting subtest: pr-cursor-plane-move [479.893708] Subtest pr-cursor-plane-move: SKIP (0.000s) [479.986383] [077/131] (551s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [480.075524] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [480.079602] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [480.189592] [078/131] (551s left) kms_psr (fbc-pr-cursor-render) [480.285671] Starting subtest: fbc-pr-cursor-render [480.289873] Subtest fbc-pr-cursor-render: SKIP (0.000s) [480.385497] [079/131] (551s left) gem_exec_reloc (basic-cpu-read-noreloc) [480.449102] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [480.523855] [080/131] (551s left) i915_drm_fdinfo (virtual-idle) [480.561018] Starting subtest: virtual-idle [483.646177] Subtest virtual-idle: SUCCESS (3.080s) [483.743318] [081/131] (548s left) i915_pm_rpm (gem-pread) [485.876709] Starting subtest: gem-pread [487.892924] Subtest gem-pread: SUCCESS (2.018s) [488.018011] [082/131] (543s left) gem_linear_blits (interruptible) [488.475027] Starting subtest: interruptible [492.453100] Subtest interruptible: SUCCESS (3.975s) [492.662637] [083/131] (539s left) kms_atomic_transition (modeset-transition) [492.807855] Starting subtest: modeset-transition [492.809692] Starting dynamic subtest: 1x-outputs [503.740743] Dynamic subtest 1x-outputs: SUCCESS (10.930s) [503.743199] Subtest modeset-transition: SUCCESS (10.931s) [504.619064] [084/131] (527s left) kms_cursor_crc (cursor-suspend) [504.761677] Starting subtest: cursor-suspend [504.763814] Starting dynamic subtest: pipe-A-eDP-1 [538.242541] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.951s) [538.253467] Starting dynamic subtest: pipe-D-eDP-1 [573.246927] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.529s) [573.249157] Subtest cursor-suspend: SUCCESS (8.484s) [583.115160] [085/131] (457s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [583.238190] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [583.242567] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [583.369188] [086/131] (457s left) kms_frontbuffer_tracking (fbc-2p-rte) [583.465464] Starting subtest: fbc-2p-rte [583.469415] Subtest fbc-2p-rte: SKIP (0.000s) [583.616098] [087/131] (457s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [583.741878] Starting subtest: verify-pxp-execution-after-suspend-resume [590.846207] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.893s) [606.047904] [088/131] (450s left) gem_exec_balancer (parallel-ordering) [606.304634] Starting subtest: parallel-ordering [607.241378] Subtest parallel-ordering: SUCCESS (0.934s) [607.425411] [089/131] (448s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [607.528110] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [607.532404] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [607.668578] [090/131] (448s left) kms_big_fb (x-tiled-64bpp-rotate-270) [607.791883] Starting subtest: x-tiled-64bpp-rotate-270 [607.810883] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s) [607.978130] [091/131] (448s left) tools_test (sysfs_l3_parity) [608.024621] Starting subtest: sysfs_l3_parity [608.124806] Subtest sysfs_l3_parity: SKIP (0.108s) [608.208655] [092/131] (448s left) perf (blocking) [608.350951] Starting subtest: blocking [608.352927] Starting dynamic subtest: 0-rcs0 [618.363680] Dynamic subtest 0-rcs0: SUCCESS (10.001s) [618.380031] Starting dynamic subtest: 1-vcs1 [628.396553] Dynamic subtest 1-vcs1: SUCCESS (10.022s) [628.398947] Subtest blocking: SUCCESS (20.026s) [628.445877] [093/131] (428s left) gem_exec_suspend (basic) [628.508873] Starting subtest: basic [628.511093] Starting dynamic subtest: smem [629.711324] Dynamic subtest smem: SUCCESS (1.199s) [629.714297] Subtest basic: SUCCESS (1.201s) [629.946163] [094/131] (426s left) gem_mmap_offset (partial-mmap) [630.011426] Starting subtest: partial-mmap [630.013584] Starting dynamic subtest: smem0 [630.015747] Dynamic subtest smem0: SUCCESS (0.006s) [630.017915] Subtest partial-mmap: SUCCESS (0.007s) [630.145414] [095/131] (426s left) kms_hdr (bpc-switch-suspend) [630.245104] Starting subtest: bpc-switch-suspend [631.332018] Starting dynamic subtest: pipe-A-eDP-1 [650.904248] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.033s) [650.907203] Subtest bpc-switch-suspend: SUCCESS (6.119s) [655.072113] [096/131] (405s left) gem_mmap (bad-object) [655.138018] Subtest bad-object: SKIP (0.000s) [655.216353] [097/131] (405s left) syncobj_timeline (invalid-transfer-bad-pad) [655.275730] Starting subtest: invalid-transfer-bad-pad [655.278247] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [655.422579] [098/131] (405s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [655.527871] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [655.532681] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [655.657956] [099/131] (405s left) sysfs_heartbeat_interval (precise) [655.713055] Starting subtest: precise [655.716124] Starting dynamic subtest: vecs0 [663.284728] Dynamic subtest vecs0: SUCCESS (7.476s) [663.299228] Starting dynamic subtest: ccs0 [664.457925] Dynamic subtest ccs0: SUCCESS (1.138s) [664.471154] Starting dynamic subtest: vcs0 [672.240253] Dynamic subtest vcs0: SUCCESS (7.641s) [672.253688] Starting dynamic subtest: bcs0 [673.453510] Dynamic subtest bcs0: SUCCESS (1.200s) [673.466987] Starting dynamic subtest: rcs0 [674.678472] Dynamic subtest rcs0: SUCCESS (1.214s) [674.690596] Starting dynamic subtest: vcs1 [682.289985] Dynamic subtest vcs1: SUCCESS (7.568s) [682.293040] Subtest precise: SUCCESS (26.250s) [682.398499] [100/131] (378s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [682.526691] Starting subtest: basic-flip-after-cursor-varying-size [683.565002] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s) [684.459356] [101/131] (376s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [684.568340] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [689.792833] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.219s) [690.979918] [102/131] (369s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [691.052620] Starting subtest: y-tiled-ccs-to-y-tiled [691.057934] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [691.260811] [103/131] (369s left) gem_vm_create (isolation) [691.322326] Starting subtest: isolation [691.332944] Subtest isolation: SUCCESS (0.010s) [691.516509] [104/131] (369s left) syncobj_wait (invalid-wait-bad-flags) [691.579125] Starting subtest: invalid-wait-bad-flags [691.581769] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [691.698913] [105/131] (369s left) gem_ctx_shared (q-promotion) [691.751195] Starting subtest: Q-promotion [691.753931] Starting dynamic subtest: rcs0 [691.891376] Dynamic subtest rcs0: SUCCESS (0.138s) [691.904188] Starting dynamic subtest: vcs0 [691.990307] Dynamic subtest vcs0: SUCCESS (0.099s) [692.008566] Starting dynamic subtest: vcs1 [692.079143] Dynamic subtest vcs1: SUCCESS (0.088s) [692.098973] Starting dynamic subtest: vecs0 [692.155528] Dynamic subtest vecs0: SUCCESS (0.075s) [692.173798] Starting dynamic subtest: ccs0 [692.236466] Dynamic subtest ccs0: SUCCESS (0.080s) [692.239129] Subtest Q-promotion: SUCCESS (0.485s) [693.441571] [106/131] (367s left) syncobj_timeline (single-wait-available-signaled) [693.497709] Starting subtest: single-wait-available-signaled [693.500441] Subtest single-wait-available-signaled: SUCCESS (0.000s) [693.640935] [107/131] (367s left) drm_buddy (drm_buddy) [693.680108] Starting subtest: drm_buddy [693.689905] Starting dynamic subtest: drm_test_buddy_alloc_limit [693.826194] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.135s) [693.838589] Starting dynamic subtest: drm_test_buddy_alloc_optimistic [693.970135] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.142s) [693.982139] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic [694.122888] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.153s) [694.135004] Starting dynamic subtest: drm_test_buddy_alloc_pathological [694.264483] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.139s) [694.276251] Starting dynamic subtest: drm_test_buddy_alloc_contiguous [694.421225] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.154s) [694.433488] Starting dynamic subtest: drm_test_buddy_alloc_clear [694.602054] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.181s) [694.613994] Starting dynamic subtest: drm_test_buddy_alloc_range_bias [694.733827] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.130s) [694.745257] Starting dynamic subtest: drm_test_buddy_fragmentation_performance [698.980113] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.241s) [698.983118] Subtest drm_buddy: SUCCESS (5.296s) [699.163662] [108/131] (362s left) gem_workarounds (reset-context) [699.226690] Starting subtest: reset-context [699.409834] Subtest reset-context: SUCCESS (0.183s) [699.572326] [109/131] (361s left) gem_exec_reloc (basic-wc-gtt-active) [699.637175] Subtest basic-wc-gtt-active: SKIP (0.000s) [699.726861] [110/131] (361s left) kms_vblank (wait-busy) [699.845207] Starting subtest: wait-busy [699.848113] Starting dynamic subtest: pipe-A-eDP-1 [701.734609] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s) [701.752848] Starting dynamic subtest: pipe-D-eDP-1 [704.310037] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s) [704.313050] Subtest wait-busy: SUCCESS (4.464s) [705.142542] [111/131] (356s left) gen9_exec_parse (bb-oversize) [705.210880] Subtest bb-oversize: SKIP (0.000s) [705.280914] [112/131] (356s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [705.342138] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [705.345021] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [705.463325] [113/131] (356s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [705.568693] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [709.494102] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.928s) [710.649244] [114/131] (350s left) prime_vgem (coherency-gtt) [710.734383] Starting subtest: coherency-gtt [710.740065] Subtest coherency-gtt: SKIP (0.000s) [710.875482] [115/131] (350s left) kms_chamelium_hpd (vga-hpd-without-ddc) [711.264878] Subtest vga-hpd-without-ddc: SKIP (0.000s) [712.115641] [116/131] (349s left) kms_big_fb (y-tiled-64bpp-rotate-270) [712.225161] Starting subtest: y-tiled-64bpp-rotate-270 [712.229955] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [712.355845] [117/131] (349s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [712.458614] Starting subtest: psr-rgb101010-draw-mmap-cpu [719.424857] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.966s) [719.553542] [118/131] (342s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [719.625983] Starting subtest: y-tiled-to-vebox-y-tiled [719.631079] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [719.836619] [119/131] (341s left) perf_pmu (semaphore-busy) [719.882626] Starting subtest: semaphore-busy [719.885116] Starting dynamic subtest: rcs0 [721.545315] Dynamic subtest rcs0: SUCCESS (1.662s) [721.558566] Starting dynamic subtest: bcs0 [723.177672] Dynamic subtest bcs0: SUCCESS (1.629s) [723.191005] Starting dynamic subtest: vcs0 [727.763923] Dynamic subtest vcs0: SUCCESS (4.581s) [727.777872] Starting dynamic subtest: vcs1 [733.714919] Dynamic subtest vcs1: SUCCESS (5.946s) [733.728108] Starting dynamic subtest: vecs0 [739.731036] Dynamic subtest vecs0: SUCCESS (6.010s) [739.744730] Starting dynamic subtest: ccs0 [742.805903] Dynamic subtest ccs0: SUCCESS (3.070s) [742.809126] Subtest semaphore-busy: SUCCESS (22.914s) [742.969082] [120/131] (318s left) kms_flip (2x-flip-vs-fences) [743.082584] Starting subtest: 2x-flip-vs-fences [743.086889] Subtest 2x-flip-vs-fences: SKIP (0.000s) [743.213556] [121/131] (318s left) gem_exec_schedule (deep) [743.381611] Starting subtest: deep [743.383957] Starting dynamic subtest: rcs0 [748.978578] Dynamic subtest rcs0: SKIP (5.590s) [748.992064] Starting dynamic subtest: vcs0 [760.741280] Dynamic subtest vcs0: SUCCESS (11.762s) [760.755003] Starting dynamic subtest: vcs1 [772.482603] Dynamic subtest vcs1: SUCCESS (11.742s) [772.497210] Starting dynamic subtest: vecs0 [785.920295] Dynamic subtest vecs0: SUCCESS (13.439s) [785.934083] Starting dynamic subtest: ccs0 [798.661561] Dynamic subtest ccs0: SUCCESS (12.740s) [798.664320] Subtest deep: SUCCESS (55.278s) [799.940595] [122/131] (261s left) gem_create (hog-create) [800.008651] Starting subtest: hog-create [800.010773] Starting dynamic subtest: smem0 [834.284869] Dynamic subtest smem0: SUCCESS (34.270s) [834.287896] Subtest hog-create: SUCCESS (34.272s) [834.503276] [123/131] (227s left) api_intel_bb (object-reloc-purge-cache) [834.557200] Starting subtest: object-reloc-purge-cache [834.563198] Subtest object-reloc-purge-cache: SKIP (0.006s) [834.676539] [124/131] (227s left) kms_lease (lease-unleased-crtc) [834.774873] Starting subtest: lease-unleased-crtc [834.777923] Starting dynamic subtest: pipe-A-eDP-1 [835.065482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [835.078200] Starting dynamic subtest: pipe-B-eDP-1 [835.803033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.736s) [835.816379] Starting dynamic subtest: pipe-C-eDP-1 [835.819097] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [835.830090] Starting dynamic subtest: pipe-D-eDP-1 [835.832527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [835.834578] Subtest lease-unleased-crtc: SUCCESS (1.046s) [836.220066] [125/131] (225s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [836.337058] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [836.973039] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s) [837.158926] [126/131] (224s left) kms_chamelium_frames (dp-crc-multiple) [837.545856] Subtest dp-crc-multiple: SKIP (0.000s) [838.323122] [127/131] (223s left) gem_partial_pwrite_pread (write) [838.384024] Subtest write: SKIP (0.000s) [838.468562] [128/131] (223s left) kms_psr (psr-primary-page-flip) [838.556992] Starting subtest: psr-primary-page-flip [838.559171] Starting dynamic subtest: eDP-1 [840.268255] Dynamic subtest eDP-1: SUCCESS (1.710s) [840.271245] Subtest psr-primary-page-flip: SUCCESS (1.711s) [841.152897] [129/131] (221s left) gem_exec_whisper (basic-queues-forked) [841.235804] Starting subtest: basic-queues-forked [864.082886] Subtest basic-queues-forked: SUCCESS (22.837s) [864.296060] [130/131] (197s left) prime_vgem (sync) [864.375728] Starting subtest: sync [864.378533] Starting dynamic subtest: rcs0 [864.430029] Dynamic subtest rcs0: SUCCESS (0.054s) [864.440780] Starting dynamic subtest: bcs0 [864.501532] Dynamic subtest bcs0: SUCCESS (0.071s) [864.512061] Starting dynamic subtest: vcs0 [864.552518] Dynamic subtest vcs0: SUCCESS (0.050s) [864.563930] Starting dynamic subtest: vcs1 [864.601696] Dynamic subtest vcs1: SUCCESS (0.048s) [864.612977] Starting dynamic subtest: vecs0 [864.651521] Dynamic subtest vecs0: SUCCESS (0.049s) [864.662523] Starting dynamic subtest: ccs0 [864.701039] Dynamic subtest ccs0: SUCCESS (0.049s) [864.704138] Subtest sync: SUCCESS (0.326s) [864.866353] [131/131] (197s left) kms_properties (crtc-properties-legacy) [864.960804] Starting subtest: crtc-properties-legacy [864.963086] Starting dynamic subtest: pipe-A-eDP-1 [865.434349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s) [865.446200] Starting dynamic subtest: pipe-B-eDP-1 [866.584206] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s) [866.597186] Starting dynamic subtest: pipe-C-eDP-1 [867.711841] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s) [867.723076] Starting dynamic subtest: pipe-D-eDP-1 [868.837112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [868.840007] Subtest crtc-properties-legacy: SUCCESS (3.876s) [869.674102] Closing watchdogs results: parsing output: 0/ for test: kms_pm_rpm results: parsing output: 1/ for test: gem_exec_async results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: gem_ctx_persistence results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_content_protection results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_display_modes results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: kms_flip_event_leak results: parsing output: 12/ for test: gem_ccs results: parsing output: 13/ for test: kms_getfb results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: gem_eio results: parsing output: 20/ for test: perf_pmu results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: kms_flip_scaled_crc results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: syncobj_basic results: parsing output: 26/ for test: kms_content_protection results: parsing output: 27/ for test: kms_properties results: parsing output: 28/ for test: gem_request_retire results: parsing output: 29/ for test: kms_rotation_crc results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: gem_mmap_gtt results: parsing output: 32/ for test: gem_shrink results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_dsc results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: prime_vgem results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: gem_mmap results: parsing output: 41/ for test: kms_plane_multiple results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_async_flips results: parsing output: 44/ for test: perf results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_schedule results: parsing output: 47/ for test: gem_create results: parsing output: 48/ for test: gem_spin_batch results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_ctx_bad_destroy results: parsing output: 56/ for test: gem_ctx_persistence results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_plane_alpha_blend results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_psr2_sf results: parsing output: 62/ for test: kms_prop_blob results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: i915_query results: parsing output: 66/ for test: kms_atomic_interruptible results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_exec_whisper results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: kms_plane_scaling results: parsing output: 72/ for test: syncobj_basic results: parsing output: 73/ for test: i915_drm_fdinfo results: parsing output: 74/ for test: kms_pm_rpm results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: gem_exec_reloc results: parsing output: 79/ for test: i915_drm_fdinfo results: parsing output: 80/ for test: i915_pm_rpm results: parsing output: 81/ for test: gem_linear_blits results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_pxp results: parsing output: 87/ for test: gem_exec_balancer results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: tools_test results: parsing output: 91/ for test: perf results: parsing output: 92/ for test: gem_exec_suspend results: parsing output: 93/ for test: gem_mmap_offset results: parsing output: 94/ for test: kms_hdr results: parsing output: 95/ for test: gem_mmap results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: sysfs_heartbeat_interval results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: gem_vm_create results: parsing output: 103/ for test: syncobj_wait results: parsing output: 104/ for test: gem_ctx_shared results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: drm_buddy results: parsing output: 107/ for test: gem_workarounds results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: gen9_exec_parse results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: prime_vgem results: parsing output: 114/ for test: kms_chamelium_hpd results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_render_copy results: parsing output: 118/ for test: perf_pmu results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: gem_create results: parsing output: 122/ for test: api_intel_bb results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_chamelium_frames results: parsing output: 126/ for test: gem_partial_pwrite_pread results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_exec_whisper results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: kms_properties Done.