[58.222683] Initializing watchdogs [58.222728] /dev/watchdog0 [58.237185] [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.241670] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.243911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.247344] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [58.375418] Starting subtest: psr-rgb565-draw-mmap-wc [65.230817] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.830s) [65.364384] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [65.489355] Starting subtest: flip-vs-cursor-atomic-transitions [73.433588] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.932s) [74.316442] [003/132] (944s left) i915_hangman (engine-error-state-capture) [74.394536] Starting subtest: engine-error-state-capture [74.396505] Starting dynamic subtest: rcs0 [77.875404] Dynamic subtest rcs0: SUCCESS (3.479s) [77.885646] Starting dynamic subtest: bcs0 [83.891997] Dynamic subtest bcs0: SUCCESS (6.014s) [83.902211] Starting dynamic subtest: vcs0 [89.908680] Dynamic subtest vcs0: SUCCESS (6.012s) [89.918774] Starting dynamic subtest: vcs1 [95.859343] Dynamic subtest vcs1: SUCCESS (5.948s) [95.869677] Starting dynamic subtest: vecs0 [101.876411] Dynamic subtest vecs0: SUCCESS (6.016s) [101.886732] Starting dynamic subtest: ccs0 [107.892484] Dynamic subtest ccs0: SUCCESS (6.014s) [107.895410] Subtest engine-error-state-capture: SUCCESS (33.490s) [107.991986] [004/132] (910s left) perf_pmu (frequency) [108.037842] Starting subtest: frequency [108.041948] Starting dynamic subtest: gt0 [110.249502] Dynamic subtest gt0: SUCCESS (2.204s) [110.257600] Starting dynamic subtest: idle-gt0 [110.789174] Dynamic subtest idle-gt0: SUCCESS (0.539s) [110.797444] Starting dynamic subtest: gt1 [114.918210] Dynamic subtest gt1: SUCCESS (4.126s) [114.926353] Starting dynamic subtest: idle-gt1 [115.422542] Dynamic subtest idle-gt1: SUCCESS (0.505s) [115.425052] Subtest frequency: SUCCESS (7.385s) [115.555249] [005/132] (903s left) kms_pm_dc (dc5-dpms) [116.658163] Starting subtest: dc5-dpms [118.787834] Subtest dc5-dpms: SUCCESS (2.129s) [118.881907] [006/132] (900s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [118.934582] Starting subtest: multi-wait-all-for-submit-available-submitted [118.936929] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [119.058124] [007/132] (899s left) gen9_exec_parse (basic-rejected) [119.113971] Subtest basic-rejected: SKIP (0.000s) [119.191950] [008/132] (899s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [119.293844] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [119.298294] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [119.416134] [009/132] (899s left) gem_exec_schedule (promotion) [119.489670] Starting subtest: promotion [119.491667] Starting dynamic subtest: rcs0 [119.600201] Dynamic subtest rcs0: SUCCESS (0.112s) [119.611966] Starting dynamic subtest: vcs0 [119.694792] Dynamic subtest vcs0: SUCCESS (0.094s) [119.705791] Starting dynamic subtest: vcs1 [119.779972] Dynamic subtest vcs1: SUCCESS (0.086s) [119.790934] Starting dynamic subtest: vecs0 [119.860294] Dynamic subtest vecs0: SUCCESS (0.080s) [119.871396] Starting dynamic subtest: ccs0 [119.943535] Dynamic subtest ccs0: SUCCESS (0.083s) [119.945696] Subtest promotion: SUCCESS (0.457s) [121.063139] [010/132] (898s left) kms_rotation_crc (exhaust-fences) [121.157444] Starting subtest: exhaust-fences [121.161942] Subtest exhaust-fences: SKIP (0.000s) [121.258101] [011/132] (897s left) syncobj_wait (signal) [121.322858] Starting subtest: signal [121.325574] Subtest signal: SUCCESS (0.000s) [121.444717] [012/132] (897s left) kms_color (deep-color) [121.547016] Starting subtest: deep-color [122.607710] Starting dynamic subtest: pipe-A-eDP-1-gamma [123.323336] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s) [123.331081] Starting dynamic subtest: pipe-A-eDP-1-degamma [124.796507] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.471s) [124.804747] Starting dynamic subtest: pipe-A-eDP-1-ctm [126.246904] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.450s) [127.007198] Starting dynamic subtest: pipe-B-eDP-1-gamma [127.715460] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.715s) [127.723798] Starting dynamic subtest: pipe-B-eDP-1-degamma [129.204878] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.488s) [129.214352] Starting dynamic subtest: pipe-B-eDP-1-ctm [130.623521] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.417s) [131.381339] Starting dynamic subtest: pipe-C-eDP-1-gamma [132.064839] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s) [132.080365] Starting dynamic subtest: pipe-C-eDP-1-degamma [133.439438] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.374s) [133.449094] Starting dynamic subtest: pipe-C-eDP-1-ctm [134.873690] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.431s) [135.687269] Starting dynamic subtest: pipe-D-eDP-1-gamma [136.388764] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.708s) [136.396320] Starting dynamic subtest: pipe-D-eDP-1-degamma [137.763164] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.373s) [137.771492] Starting dynamic subtest: pipe-D-eDP-1-ctm [139.175807] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.413s) [139.178221] Subtest deep-color: SUCCESS (17.628s) [140.055405] [013/132] (879s left) gem_exec_fence (syncobj-signal) [140.512656] Starting subtest: syncobj-signal [140.521823] Subtest syncobj-signal: SUCCESS (0.009s) [141.993846] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [141.996967] [014/132] (877s left) gem_exec_balancer (semaphore) [142.060819] Starting subtest: semaphore [143.908564] Subtest semaphore: SUCCESS (1.848s) [144.268733] [015/132] (875s left) gem_workarounds (suspend-resume-context) [144.350459] Starting subtest: suspend-resume-context [160.693211] Subtest suspend-resume-context: SUCCESS (1.735s) [171.871913] [016/132] (858s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [172.004074] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [172.006757] Starting dynamic subtest: pipe-A-eDP-1 [172.033400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [172.044525] Starting dynamic subtest: pipe-B-eDP-1 [172.070451] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [172.079058] Starting dynamic subtest: pipe-C-eDP-1 [172.105110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [172.113700] Starting dynamic subtest: pipe-D-eDP-1 [172.139442] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [172.144830] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [174.302693] [017/132] (856s left) gem_spin_batch (resubmit-new) [174.369201] Starting subtest: resubmit-new [174.372241] Starting dynamic subtest: rcs0 [174.381427] Dynamic subtest rcs0: SUCCESS (0.012s) [174.392378] Starting dynamic subtest: bcs0 [174.395168] Dynamic subtest bcs0: SUCCESS (0.005s) [174.405447] Starting dynamic subtest: vcs0 [174.407705] Dynamic subtest vcs0: SUCCESS (0.004s) [174.416072] Starting dynamic subtest: vcs1 [174.418211] Dynamic subtest vcs1: SUCCESS (0.004s) [174.426431] Starting dynamic subtest: vecs0 [174.428695] Dynamic subtest vecs0: SUCCESS (0.004s) [174.436902] Starting dynamic subtest: ccs0 [174.439089] Dynamic subtest ccs0: SUCCESS (0.004s) [174.441297] Subtest resubmit-new: SUCCESS (0.035s) [175.578624] [018/132] (854s left) kms_pm_rpm (i2c) [177.621696] Starting subtest: i2c [182.952411] Subtest i2c: SUCCESS (5.286s) [183.064320] [019/132] (847s left) gem_pxp (display-protected-crc) [183.191758] Starting subtest: display-protected-crc [184.987343] Subtest display-protected-crc: SUCCESS (1.789s) [185.164756] [020/132] (845s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [185.273092] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [185.275778] Starting dynamic subtest: pipe-A-eDP-1 [185.302446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [185.313168] Starting dynamic subtest: pipe-B-eDP-1 [185.338667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [185.347976] Starting dynamic subtest: pipe-C-eDP-1 [185.373186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [185.381969] Starting dynamic subtest: pipe-D-eDP-1 [185.407428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [185.411975] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [187.546778] [021/132] (843s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [187.640765] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [187.645328] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [188.783790] [022/132] (841s left) i915_selftest (live) [192.254966] Starting subtest: live [192.257105] Starting dynamic subtest: sanitycheck [196.414695] Dynamic subtest sanitycheck: SUCCESS (4.155s) [196.426182] Starting dynamic subtest: uncore [200.552099] Dynamic subtest uncore: SUCCESS (4.134s) [200.562345] Starting dynamic subtest: workarounds [206.688332] Dynamic subtest workarounds: SUCCESS (6.132s) [206.698208] Starting dynamic subtest: gt_engines [211.262725] Dynamic subtest gt_engines: SUCCESS (4.570s) [211.272727] Starting dynamic subtest: gt_timelines [230.632898] Dynamic subtest gt_timelines: SUCCESS (19.359s) [230.647956] Starting dynamic subtest: gt_contexts [234.914822] Dynamic subtest gt_contexts: SUCCESS (4.279s) [234.924327] Starting dynamic subtest: gt_lrc [240.800747] Dynamic subtest gt_lrc: SUCCESS (5.881s) [240.808913] Starting dynamic subtest: gt_mocs [245.297648] Dynamic subtest gt_mocs: SUCCESS (4.493s) [245.306445] Starting dynamic subtest: gt_pm [253.536667] Dynamic subtest gt_pm: SUCCESS (8.233s) [253.545253] Starting dynamic subtest: gt_heartbeat [257.753897] Dynamic subtest gt_heartbeat: SUCCESS (4.213s) [257.763960] Starting dynamic subtest: gt_tlb [268.539055] Dynamic subtest gt_tlb: SUCCESS (10.787s) [268.549241] Starting dynamic subtest: requests [281.689979] Dynamic subtest requests: SUCCESS (13.151s) [281.700309] Starting dynamic subtest: migrate [289.124742] Dynamic subtest migrate: SUCCESS (7.433s) [289.134877] Starting dynamic subtest: active [293.417809] Dynamic subtest active: SUCCESS (4.291s) [293.433087] Starting dynamic subtest: objects [299.595055] Dynamic subtest objects: SUCCESS (6.174s) [299.604954] Starting dynamic subtest: mman [304.512233] Dynamic subtest mman: SUCCESS (4.914s) [304.522205] Starting dynamic subtest: dmabuf [308.770094] Dynamic subtest dmabuf: SUCCESS (4.254s) [308.781006] Starting dynamic subtest: vma [313.000563] Dynamic subtest vma: SUCCESS (4.228s) [313.010334] Starting dynamic subtest: coherency [317.926999] Dynamic subtest coherency: SUCCESS (4.923s) [317.936780] Starting dynamic subtest: gtt [331.480753] Dynamic subtest gtt: SUCCESS (13.548s) [331.490263] Starting dynamic subtest: gem [339.364912] Dynamic subtest gem: SUCCESS (7.880s) [339.374963] Starting dynamic subtest: evict [344.874609] Dynamic subtest evict: SUCCESS (5.506s) [344.884710] Starting dynamic subtest: hugepages [355.286179] Dynamic subtest hugepages: SUCCESS (10.406s) [355.296009] Starting dynamic subtest: gem_contexts [383.323654] Dynamic subtest gem_contexts: SUCCESS (28.026s) [383.334039] Starting dynamic subtest: client [389.105979] Dynamic subtest client: SUCCESS (5.782s) [389.115796] Starting dynamic subtest: gem_migrate [393.291796] Dynamic subtest gem_migrate: SUCCESS (4.185s) [393.301629] Starting dynamic subtest: reset [399.093970] Dynamic subtest reset: SUCCESS (5.802s) [399.104413] Starting dynamic subtest: memory_region [403.272025] Dynamic subtest memory_region: SUCCESS (4.177s) [403.282256] Starting dynamic subtest: hangcheck [417.852195] Dynamic subtest hangcheck: SUCCESS (14.581s) [417.862423] Starting dynamic subtest: execlists [422.194007] Dynamic subtest execlists: SUCCESS (4.341s) [422.204451] Starting dynamic subtest: ring_submission [426.392688] Dynamic subtest ring_submission: SUCCESS (4.198s) [426.407988] Starting dynamic subtest: perf [430.691880] Dynamic subtest perf: SUCCESS (4.298s) [430.701403] Starting dynamic subtest: slpc [444.261057] Dynamic subtest slpc: SUCCESS (13.567s) [444.271151] Starting dynamic subtest: guc [449.675201] Dynamic subtest guc: SUCCESS (5.411s) [449.685012] Starting dynamic subtest: guc_multi_lrc [453.819027] Dynamic subtest guc_multi_lrc: SUCCESS (4.142s) [453.829282] Starting dynamic subtest: guc_hang [458.704472] Dynamic subtest guc_hang: SUCCESS (4.883s) [458.714682] Starting dynamic subtest: late_gt_pm [462.891985] Dynamic subtest late_gt_pm: SUCCESS (4.185s) [462.894894] Subtest live: SUCCESS (270.592s) [462.928258] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [462.928932] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [462.932490] [023/132] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [465.926456] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [472.717677] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.795s) [472.895842] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [472.897081] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [472.900956] [024/132] (557s left) perf (gen12-oa-tlb-invalidate) [473.056079] Starting subtest: gen12-oa-tlb-invalidate [473.058359] Starting dynamic subtest: 0-rcs0 [483.096127] Dynamic subtest 0-rcs0: SUCCESS (10.037s) [483.105364] Starting dynamic subtest: 1-vcs1 [493.147534] Dynamic subtest 1-vcs1: SUCCESS (10.049s) [493.150346] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s) [493.192506] [025/132] (537s left) kms_addfb_basic (too-wide) [493.316136] Starting subtest: too-wide [493.318814] Subtest too-wide: SUCCESS (0.000s) [493.436355] [026/132] (537s left) kms_big_fb (linear-8bpp-rotate-180) [493.540334] Starting subtest: linear-8bpp-rotate-180 [494.802735] Subtest linear-8bpp-rotate-180: SUCCESS (1.261s) [494.985990] [027/132] (535s left) kms_getfb (getfb-reject-nv12) [495.086551] Starting subtest: getfb-reject-nv12 [495.088921] Subtest getfb-reject-nv12: SUCCESS (0.001s) [495.231496] [028/132] (535s left) kms_plane (plane-panning-bottom-right) [495.332150] Starting subtest: plane-panning-bottom-right [495.334117] Starting dynamic subtest: pipe-A [497.059447] Dynamic subtest pipe-A: SUCCESS (1.728s) [497.068836] Starting dynamic subtest: pipe-B [499.424257] Dynamic subtest pipe-B: SUCCESS (2.361s) [499.427209] Subtest plane-panning-bottom-right: SUCCESS (4.092s) [500.244157] [029/132] (530s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [500.332108] Starting subtest: map-fixed-invalidate-overlap-busy [500.337658] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [500.497615] [030/132] (530s left) prime_vgem (basic-write) [500.564373] Starting subtest: basic-write [500.582684] Subtest basic-write: SKIP (0.017s) [500.721240] [031/132] (530s left) gem_exec_whisper (basic-contexts-forked-all) [500.790190] Starting subtest: basic-contexts-forked-all [523.395370] Subtest basic-contexts-forked-all: SUCCESS (22.597s) [523.607081] [032/132] (507s left) kms_psr (fbc-pr-cursor-blt) [523.719260] Starting subtest: fbc-pr-cursor-blt [523.724378] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [523.819231] [033/132] (507s left) gen7_exec_parse (basic-allowed) [523.876241] Subtest basic-allowed: SKIP (0.000s) [523.934563] [034/132] (507s left) core_auth (getclient-simple) [523.972628] Starting subtest: getclient-simple [524.002440] Subtest getclient-simple: SUCCESS (0.027s) [524.124749] [035/132] (507s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [524.225107] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [524.227634] Starting dynamic subtest: pipe-A-default-mode [524.515583] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [524.520750] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.288s) [525.390964] [036/132] (505s left) gem_create (create-ext-placement-sanity-check) [525.565290] Starting subtest: create-ext-placement-sanity-check [525.568316] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s) [525.693476] [037/132] (505s left) kms_psr (psr2-sprite-blt) [525.785911] Starting subtest: psr2-sprite-blt [525.788440] Starting dynamic subtest: eDP-1 [527.566491] Dynamic subtest eDP-1: SUCCESS (1.778s) [527.568920] Subtest psr2-sprite-blt: SUCCESS (1.779s) [528.462300] [038/132] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [528.577154] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [528.582311] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [528.726332] [039/132] (502s left) gem_ctx_persistence (engines-hang) [528.785663] Starting subtest: engines-hang [528.788168] Starting dynamic subtest: rcs0 [528.882352] Dynamic subtest rcs0: SUCCESS (0.096s) [528.895253] Starting dynamic subtest: bcs0 [528.987484] Dynamic subtest bcs0: SUCCESS (0.103s) [529.000733] Starting dynamic subtest: vcs0 [529.063363] Dynamic subtest vcs0: SUCCESS (0.073s) [529.074968] Starting dynamic subtest: vcs1 [529.192807] Dynamic subtest vcs1: SUCCESS (0.127s) [529.205024] Starting dynamic subtest: vecs0 [529.312749] Dynamic subtest vecs0: SUCCESS (0.117s) [529.325464] Starting dynamic subtest: ccs0 [529.398469] Dynamic subtest ccs0: SUCCESS (0.084s) [529.401093] Subtest engines-hang: SUCCESS (0.614s) [529.503085] [040/132] (501s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [529.619930] Starting subtest: cursorA-vs-flipB-atomic [529.623898] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [529.788286] [041/132] (501s left) gem_exec_reloc (basic-write-gtt) [529.847455] Subtest basic-write-gtt: SKIP (0.000s) [529.921188] [042/132] (501s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [529.974469] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [530.080277] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [530.179291] [043/132] (501s left) gem_render_copy (linear-to-vebox-yf-tiled) [530.241008] Starting subtest: linear-to-vebox-yf-tiled [530.246212] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [530.446161] [044/132] (501s left) kms_addfb_basic (invalid-get-prop-any) [530.499130] Starting subtest: invalid-get-prop-any [530.501841] Subtest invalid-get-prop-any: SUCCESS (0.000s) [530.662198] [045/132] (501s left) kms_flip (busy-flip) [530.747968] Starting subtest: busy-flip [530.750242] Starting dynamic subtest: A-eDP1 [532.452850] Dynamic subtest A-eDP1: SUCCESS (1.706s) [532.463220] Starting dynamic subtest: B-eDP1 [534.176440] Dynamic subtest B-eDP1: SUCCESS (1.720s) [534.188267] Starting dynamic subtest: C-eDP1 [535.893314] Dynamic subtest C-eDP1: SUCCESS (1.715s) [535.903500] Starting dynamic subtest: D-eDP1 [537.515856] Dynamic subtest D-eDP1: SUCCESS (1.621s) [537.518301] Subtest busy-flip: SUCCESS (6.773s) [538.710466] [046/132] (492s left) gem_readwrite (read-bad-handle) [538.777338] Subtest read-bad-handle: SKIP (0.000s) [538.837600] [047/132] (492s left) core_getstats (basic) [538.896299] Starting subtest: basic [538.898687] Subtest basic: SUCCESS (0.000s) [539.016756] [048/132] (492s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [539.114753] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [539.772235] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s) [539.981747] [049/132] (491s left) kms_atomic (plane-invalid-params-fence) [540.078167] Starting subtest: plane-invalid-params-fence [540.080668] Starting dynamic subtest: pipe-A-eDP-1 [540.441304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s) [540.443687] Subtest plane-invalid-params-fence: SUCCESS (0.364s) [541.345288] [050/132] (490s left) kms_pm_rpm (pc8-residency) [543.677379] Starting subtest: pc8-residency [543.683196] Subtest pc8-residency: SKIP (0.000s) [544.054197] [051/132] (487s left) kms_psr2_su (frontbuffer-xrgb8888) [544.121329] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [544.185219] [052/132] (487s left) syncobj_timeline (etime-single-wait-submitted) [544.240241] Starting subtest: etime-single-wait-submitted [544.344601] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [544.445722] [053/132] (487s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [544.540081] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [544.545322] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [544.666633] [054/132] (487s left) kms_chamelium_color (ctm-blue-to-red) [544.763484] Subtest ctm-blue-to-red: SKIP (0.000s) [544.810540] [055/132] (487s left) syncobj_wait (multi-wait-all-signaled) [544.876248] Starting subtest: multi-wait-all-signaled [544.879096] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [545.015770] [056/132] (487s left) prime_mmap (test_correct_cpu_write) [545.076137] Starting subtest: test_correct_cpu_write [545.078837] Starting dynamic subtest: test_correct_cpu_write-smem [545.081286] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [545.084115] Subtest test_correct_cpu_write: SUCCESS (0.001s) [545.207346] [057/132] (486s left) gem_exec_reloc (basic-concurrent16) [545.272208] Subtest basic-concurrent16: SKIP (0.000s) [545.352818] [058/132] (486s left) vgem_basic (bad-handle) [545.395230] Starting subtest: bad-handle [545.397418] Subtest bad-handle: SUCCESS (0.000s) [545.480813] [059/132] (486s left) gem_userptr_blits (readonly-pwrite-unsync) [545.549067] Subtest readonly-pwrite-unsync: SKIP (0.000s) [545.710361] [060/132] (486s left) gem_exec_schedule (implicit-read-write) [545.789922] Starting subtest: implicit-read-write [545.791978] Starting dynamic subtest: rcs0 [545.887283] Dynamic subtest rcs0: SUCCESS (0.108s) [545.899963] Starting dynamic subtest: vcs0 [545.968403] Dynamic subtest vcs0: SUCCESS (0.080s) [545.980933] Starting dynamic subtest: vcs1 [546.047407] Dynamic subtest vcs1: SUCCESS (0.079s) [546.059221] Starting dynamic subtest: vecs0 [546.122680] Dynamic subtest vecs0: SUCCESS (0.075s) [546.134417] Starting dynamic subtest: ccs0 [546.209045] Dynamic subtest ccs0: SUCCESS (0.085s) [546.211770] Subtest implicit-read-write: SUCCESS (0.430s) [547.648081] [061/132] (484s left) gem_tiled_fence_blits (normal) [547.724227] Subtest normal: SKIP (0.000s) [547.806871] [062/132] (484s left) i915_pm_rpm (gem-idle) [549.637890] Starting subtest: gem-idle [555.831700] Subtest gem-idle: SUCCESS (6.190s) [556.199506] [063/132] (476s left) kms_content_protection (content-type-change) [557.527990] Starting subtest: content-type-change [557.533328] Subtest content-type-change: SKIP (0.000s) [557.695707] [064/132] (474s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [557.788688] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [561.518379] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.734s) [562.694182] [065/132] (469s left) kms_vblank (ts-continuation-dpms-suspend) [562.796288] Starting subtest: ts-continuation-dpms-suspend [562.799147] Starting dynamic subtest: pipe-A-eDP-1 [580.222986] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.248s) [580.238772] Starting dynamic subtest: pipe-D-eDP-1 [598.385850] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.030s) [598.388779] Subtest ts-continuation-dpms-suspend: SUCCESS (5.282s) [604.282728] [066/132] (433s left) perf_pmu (most-busy-idle-check-all) [604.366840] Starting subtest: most-busy-idle-check-all [604.368934] Starting dynamic subtest: rcs0 [605.089780] Dynamic subtest rcs0: FAIL (0.644s) [605.101083] Starting dynamic subtest: bcs0 [605.823438] Dynamic subtest bcs0: SUCCESS (0.786s) [605.840448] Starting dynamic subtest: vcs0 [607.806836] Dynamic subtest vcs0: SUCCESS (1.943s) [607.820472] Starting dynamic subtest: vcs1 [609.792311] Dynamic subtest vcs1: SUCCESS (1.953s) [609.806006] Starting dynamic subtest: vecs0 [611.839180] Dynamic subtest vecs0: SUCCESS (2.021s) [611.853110] Starting dynamic subtest: ccs0 [613.823882] Dynamic subtest ccs0: SUCCESS (1.964s) [613.827099] Subtest most-busy-idle-check-all: FAIL (9.325s) [613.951456] [067/132] (423s left) gem_exec_balancer (full-pulse) [614.018041] Starting subtest: full-pulse [618.684331] Subtest full-pulse: SUCCESS (4.639s) [619.047989] [068/132] (418s left) kms_invalid_mode (bad-hsync-end) [619.146580] Starting subtest: bad-hsync-end [619.148891] Starting dynamic subtest: pipe-A-eDP-1 [619.427774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [619.438546] Starting dynamic subtest: pipe-B-eDP-1 [619.441098] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [619.451054] Starting dynamic subtest: pipe-C-eDP-1 [619.453152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [619.462883] Starting dynamic subtest: pipe-D-eDP-1 [619.465209] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [619.467575] Subtest bad-hsync-end: SUCCESS (0.290s) [620.261509] [069/132] (417s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [620.321412] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [620.324109] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [620.438946] [070/132] (417s left) kms_draw_crc (fill-fb) [620.534730] Starting subtest: fill-fb [621.066208] Subtest fill-fb: SUCCESS (0.531s) [621.188637] [071/132] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [621.279129] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [621.284026] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [621.396455] [072/132] (416s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [621.491495] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [628.859839] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.352s) [629.021200] [073/132] (408s left) syncobj_timeline (multi-wait-submitted-signaled) [629.083666] Starting subtest: multi-wait-submitted-signaled [629.086436] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [629.208578] [074/132] (408s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [629.310647] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [629.315477] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [629.440655] [075/132] (408s left) kms_lease (invalid-create-leases) [629.525939] Starting subtest: invalid-create-leases [629.531649] Subtest invalid-create-leases: SUCCESS (0.006s) [629.675165] [076/132] (408s left) gem_render_copy (linear) [629.748251] Starting subtest: linear [629.751185] Starting dynamic subtest: smem [629.794313] Dynamic subtest smem: SUCCESS (0.046s) [629.797015] Subtest linear: SUCCESS (0.047s) [630.060972] [077/132] (407s left) gem_mmap_offset (clear-via-pagefault) [630.129756] Starting subtest: clear-via-pagefault [630.132264] Starting dynamic subtest: smem0 [663.587583] Dynamic subtest smem0: SUCCESS (33.439s) [663.590037] Subtest clear-via-pagefault: SUCCESS (33.442s) [663.737581] [078/132] (374s left) i915_query (query-garbage) [663.804263] Starting subtest: query-garbage [663.807258] Subtest query-garbage: SUCCESS (0.000s) [663.947662] [079/132] (374s left) gem_exec_whisper (basic-queues-forked-all) [664.017422] Starting subtest: basic-queues-forked-all [687.109168] Subtest basic-queues-forked-all: SUCCESS (23.078s) [687.321557] [080/132] (350s left) gem_media_fill (media-fill) [687.382298] Subtest media-fill: SKIP (0.000s) [687.526027] [081/132] (350s left) i915_query (query-topology-kernel-writes) [687.579158] Starting subtest: query-topology-kernel-writes [687.581835] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [687.722102] [082/132] (350s left) kms_flip (2x-flip-vs-rmfb) [687.820416] Starting subtest: 2x-flip-vs-rmfb [687.830081] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [687.939995] [083/132] (350s left) kms_psr (pr-primary-mmap-cpu) [688.034082] Starting subtest: pr-primary-mmap-cpu [688.039105] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [688.130802] [084/132] (350s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [688.238116] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [688.242669] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [688.373625] [085/132] (350s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [688.439096] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [688.443869] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [688.639535] [086/132] (349s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [688.763954] Starting subtest: modeset-atomic-cursor-hotspot [688.767877] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [688.934908] [087/132] (349s left) perf (blocking-parameterized) [689.032709] Starting subtest: blocking-parameterized [709.054592] Subtest blocking-parameterized: SUCCESS (20.018s) [709.107891] [088/132] (329s left) kms_frontbuffer_tracking (psr-1p-rte) [709.208758] Starting subtest: psr-1p-rte [714.643379] Subtest psr-1p-rte: SUCCESS (5.446s) [714.791502] [089/132] (323s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [714.913703] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [714.918678] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [715.019996] [090/132] (323s left) kms_psr2_sf (pr-cursor-plane-update-sf) [719.989729] Starting subtest: pr-cursor-plane-update-sf [719.995077] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [720.866961] [091/132] (317s left) kms_async_flips (async-flip-suspend-resume) [720.964761] Starting subtest: async-flip-suspend-resume [721.337002] Starting dynamic subtest: pipe-A-eDP-1 [739.681713] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.346s) [740.061792] Starting dynamic subtest: pipe-B-eDP-1 [758.695786] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.306s) [759.065037] Starting dynamic subtest: pipe-C-eDP-1 [777.693960] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.283s) [778.088638] Starting dynamic subtest: pipe-D-eDP-1 [796.681470] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.262s) [796.693920] Subtest async-flip-suspend-resume: SUCCESS (14.696s) [801.919160] [092/132] (240s left) prime_mmap_coherency (ioctl-errors) [801.986097] Starting subtest: ioctl-errors [818.300129] Subtest ioctl-errors: SUCCESS (16.329s) [818.505246] [093/132] (224s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [818.670109] Starting subtest: psr-rgb101010-draw-mmap-cpu [825.767185] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.100s) [825.905471] [094/132] (216s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [826.003198] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [826.007301] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [826.142809] [095/132] (216s left) kms_fb_coherency (memset-crc) [826.238652] Starting subtest: memset-crc [826.240967] Starting dynamic subtest: mmap-offset-wc [826.664238] Dynamic subtest mmap-offset-wc: SUCCESS (0.426s) [826.974216] Starting dynamic subtest: mmap-offset-uc [833.167941] Dynamic subtest mmap-offset-uc: SUCCESS (6.206s) [833.459285] Subtest memset-crc: SUCCESS (7.222s) [834.292266] [096/132] (208s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [834.393567] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [834.395922] Starting dynamic subtest: pipe-A-default-mode [837.119059] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s) [837.121439] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.727s) [837.992941] [097/132] (204s left) gem_ppgtt (blt-vs-render-ctxn) [838.059342] Starting subtest: blt-vs-render-ctxN [870.933745] Subtest blt-vs-render-ctxN: SUCCESS (32.870s) [871.098917] [098/132] (171s left) i915_drm_fdinfo (busy-idle) [871.176192] Starting subtest: busy-idle [871.178657] Starting dynamic subtest: rcs0 [871.205244] Dynamic subtest rcs0: SKIP (0.027s) [871.218096] Starting dynamic subtest: bcs0 [871.222278] Dynamic subtest bcs0: SKIP (0.000s) [871.232494] Starting dynamic subtest: vcs0 [871.237083] Dynamic subtest vcs0: SKIP (0.000s) [871.247493] Starting dynamic subtest: vcs1 [871.251697] Dynamic subtest vcs1: SKIP (0.000s) [871.262208] Starting dynamic subtest: vecs0 [871.266443] Dynamic subtest vecs0: SKIP (0.000s) [871.277491] Starting dynamic subtest: ccs0 [871.281831] Dynamic subtest ccs0: SKIP (0.000s) [871.286220] Subtest busy-idle: SKIP (0.031s) [871.326882] [099/132] (171s left) kms_frontbuffer_tracking (fbc-1p-rte) [871.438346] Starting subtest: fbc-1p-rte [876.966981] Subtest fbc-1p-rte: SUCCESS (5.532s) [878.174250] [100/132] (164s left) dumb_buffer (map-valid) [878.232143] Starting subtest: map-valid [878.234144] Subtest map-valid: SUCCESS (0.000s) [878.369673] [101/132] (164s left) kms_chamelium_edid (dp-edid-resolution-list) [878.762175] Subtest dp-edid-resolution-list: SKIP (0.000s) [879.550289] [102/132] (163s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [879.662709] Starting subtest: fbc-dirtyfb-ioctl [879.665078] Starting dynamic subtest: A-eDP-1 [882.234935] Dynamic subtest A-eDP-1: SUCCESS (2.573s) [882.237459] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.575s) [883.053368] [103/132] (160s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [883.156950] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [883.160936] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [883.295936] [104/132] (159s left) prime_vgem (fence-wait) [883.402048] Starting subtest: fence-wait [883.404463] Starting dynamic subtest: rcs0 [884.501159] Dynamic subtest rcs0: SUCCESS (1.097s) [884.515944] Starting dynamic subtest: bcs0 [885.565267] Dynamic subtest bcs0: SUCCESS (1.063s) [885.579541] Starting dynamic subtest: vcs0 [886.608237] Dynamic subtest vcs0: SUCCESS (1.042s) [886.619397] Starting dynamic subtest: vcs1 [887.649081] Dynamic subtest vcs1: SUCCESS (1.040s) [887.660357] Starting dynamic subtest: vecs0 [888.693377] Dynamic subtest vecs0: SUCCESS (1.042s) [888.705311] Starting dynamic subtest: ccs0 [889.736041] Dynamic subtest ccs0: SUCCESS (1.039s) [889.738616] Subtest fence-wait: SUCCESS (6.333s) [889.915302] [105/132] (153s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [890.027279] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [890.031530] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [890.168273] [106/132] (153s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [890.288403] Starting subtest: yf-tiled-64bpp-rotate-0 [890.292829] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [890.419274] [107/132] (152s left) gem_ctx_persistence (legacy-engines-mixed) [890.479103] Starting subtest: legacy-engines-mixed [890.481299] Starting dynamic subtest: render [890.602584] Dynamic subtest render: SUCCESS (0.122s) [890.615890] Starting dynamic subtest: bsd1 [890.659560] Dynamic subtest bsd1: SUCCESS (0.054s) [890.672408] Starting dynamic subtest: bsd2 [890.741495] Dynamic subtest bsd2: SUCCESS (0.079s) [890.754429] Starting dynamic subtest: blt [890.832262] Dynamic subtest blt: SUCCESS (0.088s) [890.849307] Starting dynamic subtest: vebox [890.904818] Dynamic subtest vebox: SUCCESS (0.070s) [890.906978] Subtest legacy-engines-mixed: SUCCESS (0.427s) [891.010273] [108/132] (152s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [891.102565] Starting subtest: fbc-2p-pri-indfb-multidraw [891.106036] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [891.225484] [109/132] (152s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [891.318901] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [891.322282] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [891.448076] [110/132] (152s left) syncobj_wait (wait-any-snapshot) [891.510596] Starting subtest: wait-any-snapshot [891.590401] Subtest wait-any-snapshot: SUCCESS (0.081s) [891.692797] [111/132] (151s left) kms_psr (psr-sprite-blt) [891.783952] Starting subtest: psr-sprite-blt [891.785937] Starting dynamic subtest: eDP-1 [893.549682] Dynamic subtest eDP-1: SUCCESS (1.765s) [893.551885] Subtest psr-sprite-blt: SUCCESS (1.766s) [894.411747] [112/132] (149s left) kms_cursor_crc (cursor-onscreen-256x256) [894.646445] Starting subtest: cursor-onscreen-256x256 [894.648652] Starting dynamic subtest: pipe-A-eDP-1 [896.784302] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s) [896.815624] Starting dynamic subtest: pipe-D-eDP-1 [899.574858] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [899.577124] Subtest cursor-onscreen-256x256: SUCCESS (4.931s) [900.478610] [113/132] (143s left) kms_big_fb (x-tiled-64bpp-rotate-90) [900.595818] Starting subtest: x-tiled-64bpp-rotate-90 [900.617467] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s) [900.779760] [114/132] (142s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [900.907880] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [900.912417] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [901.093715] [115/132] (142s left) gem_ctx_shared (q-in-order) [901.173701] Starting subtest: Q-in-order [901.175982] Starting dynamic subtest: rcs0 [901.275224] Dynamic subtest rcs0: SUCCESS (0.103s) [901.295078] Starting dynamic subtest: vcs0 [901.357150] Dynamic subtest vcs0: SUCCESS (0.081s) [901.377054] Starting dynamic subtest: vcs1 [901.435832] Dynamic subtest vcs1: SUCCESS (0.078s) [901.454411] Starting dynamic subtest: vecs0 [901.506080] Dynamic subtest vecs0: SUCCESS (0.069s) [901.523671] Starting dynamic subtest: ccs0 [901.579982] Dynamic subtest ccs0: SUCCESS (0.073s) [901.582139] Subtest Q-in-order: SUCCESS (0.410s) [902.943563] [116/132] (140s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [903.043125] Starting subtest: fbc-rgb101010-draw-mmap-wc [907.644375] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.605s) [908.772909] [117/132] (135s left) syncobj_wait (invalid-reset-zero-handles) [908.834924] Starting subtest: invalid-reset-zero-handles [908.836876] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [908.977889] [118/132] (134s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [909.069551] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [909.071833] Starting dynamic subtest: pipe-A [909.089623] Dynamic subtest pipe-A: SKIP (0.017s) [909.100962] Starting dynamic subtest: pipe-B [909.124401] Dynamic subtest pipe-B: SKIP (0.032s) [909.135372] Starting dynamic subtest: pipe-C [909.155441] Dynamic subtest pipe-C: SKIP (0.032s) [909.166309] Starting dynamic subtest: pipe-D [909.189254] Dynamic subtest pipe-D: SKIP (0.032s) [909.193671] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.116s) [909.325892] [119/132] (134s left) kms_big_fb (y-tiled-16bpp-rotate-90) [909.429158] Starting subtest: y-tiled-16bpp-rotate-90 [909.433710] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [909.573051] [120/132] (134s left) kms_psr (fbc-psr-cursor-mmap-gtt) [909.686223] Starting subtest: fbc-psr-cursor-mmap-gtt [909.688463] Starting dynamic subtest: eDP-1 [909.692324] Dynamic subtest eDP-1: SKIP (0.000s) [909.695947] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [909.788241] [121/132] (134s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [909.886908] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [909.888501] Starting dynamic subtest: pipe-A-eDP-1 [910.634741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [910.651998] Starting dynamic subtest: pipe-B-eDP-1 [912.455919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.821s) [912.468205] Starting dynamic subtest: pipe-C-eDP-1 [914.288659] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.831s) [914.305212] Starting dynamic subtest: pipe-D-eDP-1 [916.113118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.824s) [916.115019] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.221s) [917.278803] [122/132] (126s left) kms_busy (basic) [917.389885] Starting subtest: basic [917.392247] Starting dynamic subtest: flip [917.979453] Dynamic subtest flip: SUCCESS (0.588s) [917.996495] Starting dynamic subtest: modeset [921.598155] Dynamic subtest modeset: SUCCESS (3.616s) [921.600308] Subtest basic: SUCCESS (4.206s) [922.427639] [123/132] (121s left) kms_cursor_crc (cursor-rapid-movement-512x170) [922.721650] Starting subtest: cursor-rapid-movement-512x170 [922.725545] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [922.907576] [124/132] (121s left) kms_plane_alpha_blend (constant-alpha-min) [923.013955] Starting subtest: constant-alpha-min [923.298208] Starting dynamic subtest: pipe-A-eDP-1 [924.000729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [924.012830] Starting dynamic subtest: pipe-D-eDP-1 [925.486916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.485s) [925.489254] Subtest constant-alpha-min: SUCCESS (2.473s) [926.391769] [125/132] (117s left) prime_self_import (basic-llseek-bad) [926.428141] Starting subtest: basic-llseek-bad [926.460018] Subtest basic-llseek-bad: SUCCESS (0.031s) [926.594215] [126/132] (117s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [926.995630] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [927.771689] [127/132] (116s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [927.876135] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [927.878341] Starting dynamic subtest: A-eDP1 [936.755620] Dynamic subtest A-eDP1: SUCCESS (8.878s) [936.770260] Starting dynamic subtest: B-eDP1 [945.689917] Dynamic subtest B-eDP1: SUCCESS (8.932s) [945.703042] Starting dynamic subtest: C-eDP1 [954.611327] Dynamic subtest C-eDP1: SUCCESS (8.920s) [954.624255] Starting dynamic subtest: D-eDP1 [963.545912] Dynamic subtest D-eDP1: SUCCESS (8.932s) [963.548394] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.673s) [964.802079] [128/132] ( 79s left) gem_exec_parallel (fds) [964.868923] Starting subtest: fds [964.871314] Starting dynamic subtest: rcs0 [967.417464] Dynamic subtest rcs0: SUCCESS (2.547s) [967.431283] Starting dynamic subtest: bcs0 [971.149943] Dynamic subtest bcs0: SUCCESS (3.729s) [971.164132] Starting dynamic subtest: vcs0 [975.078195] Dynamic subtest vcs0: SUCCESS (3.927s) [975.096181] Starting dynamic subtest: vcs1 [979.107423] Dynamic subtest vcs1: SUCCESS (4.027s) [979.121692] Starting dynamic subtest: vecs0 [983.158806] Dynamic subtest vecs0: SUCCESS (4.050s) [983.172473] Starting dynamic subtest: ccs0 [986.789469] Dynamic subtest ccs0: SUCCESS (3.627s) [986.792343] Subtest fds: SUCCESS (21.919s) [987.007059] [129/132] ( 57s left) prime_vgem (fence-write-hang) [987.095239] Subtest fence-write-hang: SKIP (0.000s) [987.222098] [130/132] ( 57s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [987.333853] Starting subtest: fbc-modesetfrombusy [991.034234] Subtest fbc-modesetfrombusy: SUCCESS (3.706s) [992.235893] [131/132] ( 52s left) syncobj_timeline (wait-all-for-submit-snapshot) [992.299484] Starting subtest: wait-all-for-submit-snapshot [992.380995] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [992.487558] [132/132] ( 51s left) kms_scaling_modes (scaling-mode-center) [992.583682] Starting subtest: scaling-mode-center [992.585603] Starting dynamic subtest: pipe-A-eDP-1 [992.677726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s) [992.691749] Starting dynamic subtest: pipe-B-eDP-1 [993.824069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s) [993.836903] Starting dynamic subtest: pipe-C-eDP-1 [994.934638] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [994.946342] Starting dynamic subtest: pipe-D-eDP-1 [996.059553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [996.061829] Subtest scaling-mode-center: SUCCESS (3.479s) [997.244899] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: i915_hangman results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_pm_dc results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gen9_exec_parse results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_exec_schedule results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: gem_workarounds results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: gem_spin_batch results: parsing output: 17/ for test: kms_pm_rpm results: parsing output: 18/ for test: gem_pxp results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: i915_selftest results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_getfb results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: prime_vgem results: parsing output: 30/ for test: gem_exec_whisper results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gen7_exec_parse results: parsing output: 33/ for test: core_auth results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: gem_create results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_ctx_persistence results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: core_getstats results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_atomic results: parsing output: 49/ for test: kms_pm_rpm results: parsing output: 50/ for test: kms_psr2_su results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: prime_mmap results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: vgem_basic results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_tiled_fence_blits results: parsing output: 61/ for test: i915_pm_rpm results: parsing output: 62/ for test: kms_content_protection results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_vblank results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_exec_balancer results: parsing output: 67/ for test: kms_invalid_mode results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_draw_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_lease results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: i915_query results: parsing output: 78/ for test: gem_exec_whisper results: parsing output: 79/ for test: gem_media_fill results: parsing output: 80/ for test: i915_query results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: perf results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: kms_async_flips results: parsing output: 91/ for test: prime_mmap_coherency results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_fb_coherency results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_ppgtt results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: dumb_buffer results: parsing output: 100/ for test: kms_chamelium_edid results: parsing output: 101/ for test: kms_dirtyfb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: prime_vgem results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_ctx_persistence results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_cursor_crc results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_ctx_shared results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_busy results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_plane_alpha_blend results: parsing output: 124/ for test: prime_self_import results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: gem_exec_parallel results: parsing output: 128/ for test: prime_vgem results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_scaling_modes Done.