[74.625528] Initializing watchdogs [74.625698] /dev/watchdog0 [74.636843] [001/171] (960s left) i915_module_load (load) [74.784863] Starting subtest: load [77.361053] Subtest load: SUCCESS (2.574s) [77.394699] [002/171] (957s left) core_auth (basic-auth) [77.536437] Starting subtest: basic-auth [77.537564] Subtest basic-auth: SUCCESS (0.001s) [77.621222] [003/171] (957s left) debugfs_test (read_all_entries) [77.769690] Starting subtest: read_all_entries [77.840683] Subtest read_all_entries: SUCCESS (0.071s) [77.954656] [004/171] (957s left) debugfs_test (basic-hwmon) [78.097406] Starting subtest: basic-hwmon [78.099484] Subtest basic-hwmon: SKIP (0.000s) [78.209192] [005/171] (957s left) fbdev (eof) [78.373928] Starting subtest: eof [78.378372] Subtest eof: SUCCESS (0.002s) [78.454649] [006/171] (956s left) fbdev (info) [78.590452] Starting subtest: info [78.591621] Subtest info: SUCCESS (0.000s) [78.680279] [007/171] (956s left) fbdev (nullptr) [78.823149] Starting subtest: nullptr [78.824408] Subtest nullptr: SUCCESS (0.000s) [78.890658] [008/171] (956s left) fbdev (read) [79.040505] Starting subtest: read [86.120350] Subtest read: SUCCESS (7.045s) [86.158452] [009/171] (949s left) fbdev (write) [86.307630] Starting subtest: write [90.090793] Subtest write: SUCCESS (3.748s) [90.139772] [010/171] (945s left) gem_basic (bad-close) [90.274788] Starting subtest: bad-close [90.277142] Subtest bad-close: SUCCESS (0.000s) [90.355547] [011/171] (945s left) gem_basic (create-close) [90.493595] Starting subtest: create-close [90.495711] Subtest create-close: SUCCESS (0.000s) [90.590303] [012/171] (944s left) gem_basic (create-fd-close) [90.729454] Starting subtest: create-fd-close [90.731552] Subtest create-fd-close: SUCCESS (0.000s) [90.822146] [013/171] (944s left) gem_busy (busy@all-engines) [90.980848] Starting subtest: busy [90.981979] Starting dynamic subtest: all-engines [91.048392] Dynamic subtest all-engines: SUCCESS (0.068s) [91.049492] Subtest busy: SUCCESS (0.068s) [91.440308] [014/171] (944s left) gem_close_race (basic-process) [91.600195] Starting subtest: basic-process [91.672238] Subtest basic-process: SUCCESS (0.071s) [91.873565] [015/171] (943s left) gem_close_race (basic-threads) [92.033384] Starting subtest: basic-threads [93.236215] Subtest basic-threads: SUCCESS (1.203s) [93.448518] [016/171] (942s left) gem_ctx_create (basic) [93.603478] Starting subtest: basic [93.604596] Subtest basic: SUCCESS (0.000s) [93.807710] [017/171] (941s left) gem_ctx_create (basic-files) [93.961288] Starting subtest: basic-files [95.986300] Subtest basic-files: SUCCESS (2.025s) [96.257143] [018/171] (939s left) gem_ctx_exec (basic) [96.398303] Starting subtest: basic [96.403170] Subtest basic: SUCCESS (0.005s) [96.505942] [019/171] (939s left) gem_exec_basic (basic) [96.654568] Starting subtest: basic [96.655667] Starting dynamic subtest: rcs0-smem [96.656770] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [96.668282] Starting dynamic subtest: bcs0-smem [96.669468] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [96.680174] Starting dynamic subtest: vcs0-smem [96.681470] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [96.691990] Starting dynamic subtest: vecs0-smem [96.693241] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [96.694493] Subtest basic: SUCCESS (0.006s) [96.856207] [020/171] (938s left) gem_exec_create (basic) [97.009767] Starting subtest: basic [97.010953] Starting dynamic subtest: smem [99.074763] Dynamic subtest smem: SUCCESS (2.042s) [99.076141] Subtest basic: SUCCESS (2.042s) [99.261655] [021/171] (936s left) gem_exec_fence (basic-busy) [99.579664] Starting subtest: basic-busy [99.581076] Starting dynamic subtest: rcs0 [99.597965] Dynamic subtest rcs0: SUCCESS (0.026s) [99.610270] Starting dynamic subtest: bcs0 [99.623637] Dynamic subtest bcs0: SUCCESS (0.026s) [99.634869] Starting dynamic subtest: vcs0 [99.658024] Dynamic subtest vcs0: SUCCESS (0.034s) [99.669243] Starting dynamic subtest: vecs0 [99.702713] Dynamic subtest vecs0: SUCCESS (0.044s) [99.704787] Subtest basic-busy: SUCCESS (0.130s) [100.307533] [022/171] (935s left) gem_exec_fence (basic-wait) [100.617277] Starting subtest: basic-wait [100.618473] Starting dynamic subtest: rcs0 [100.639495] Dynamic subtest rcs0: SUCCESS (0.026s) [100.651893] Starting dynamic subtest: bcs0 [100.663135] Dynamic subtest bcs0: SUCCESS (0.023s) [100.675122] Starting dynamic subtest: vcs0 [100.688614] Dynamic subtest vcs0: SUCCESS (0.025s) [100.700412] Starting dynamic subtest: vecs0 [100.716573] Dynamic subtest vecs0: SUCCESS (0.028s) [100.717707] Subtest basic-wait: SUCCESS (0.103s) [101.282861] [023/171] (934s left) gem_exec_fence (basic-await) [101.579737] Starting subtest: basic-await [101.580962] Starting dynamic subtest: rcs0 [101.671883] Dynamic subtest rcs0: SUCCESS (0.099s) [101.700417] Starting dynamic subtest: bcs0 [101.800570] Dynamic subtest bcs0: SUCCESS (0.127s) [101.828684] Starting dynamic subtest: vcs0 [101.928662] Dynamic subtest vcs0: SUCCESS (0.129s) [101.957109] Starting dynamic subtest: vecs0 [102.068838] Dynamic subtest vecs0: SUCCESS (0.131s) [102.070882] Subtest basic-await: SUCCESS (0.489s) [102.674567] [024/171] (933s left) gem_exec_fence (nb-await) [102.974914] Starting subtest: nb-await [102.976171] Starting dynamic subtest: rcs0 [103.034183] Dynamic subtest rcs0: SUCCESS (0.065s) [103.051099] Starting dynamic subtest: bcs0 [103.101091] Dynamic subtest bcs0: SUCCESS (0.067s) [103.129193] Starting dynamic subtest: vcs0 [103.175277] Dynamic subtest vcs0: SUCCESS (0.074s) [103.204245] Starting dynamic subtest: vecs0 [103.250622] Dynamic subtest vecs0: SUCCESS (0.075s) [103.252784] Subtest nb-await: SUCCESS (0.283s) [103.807426] [025/171] (931s left) gem_exec_gttfill (basic) [103.960342] Starting subtest: basic [110.267448] Subtest basic: SUCCESS (6.298s) [110.460028] [026/171] (925s left) gem_exec_parallel (engines) [110.678570] Starting subtest: engines [110.679894] Starting dynamic subtest: basic [113.208919] Dynamic subtest basic: SUCCESS (2.529s) [113.222312] Starting dynamic subtest: contexts [116.624769] Dynamic subtest contexts: SUCCESS (3.407s) [116.639676] Starting dynamic subtest: fds [121.199769] Dynamic subtest fds: SUCCESS (4.578s) [121.230689] Starting dynamic subtest: userptr [123.827442] Dynamic subtest userptr: SUCCESS (2.609s) [123.829590] Subtest engines: SUCCESS (13.125s) [124.029892] [027/171] (911s left) gem_exec_store (basic) [124.186604] Starting subtest: basic [124.242822] Subtest basic: SUCCESS (0.056s) [124.444180] [028/171] (911s left) gem_flink_basic (bad-flink) [124.581279] Starting subtest: bad-flink [124.582518] Subtest bad-flink: SUCCESS (0.000s) [124.659301] [029/171] (911s left) gem_flink_basic (bad-open) [124.798228] Starting subtest: bad-open [124.799464] Subtest bad-open: SUCCESS (0.000s) [124.875462] [030/171] (911s left) gem_flink_basic (basic) [125.013668] Starting subtest: basic [125.014832] Subtest basic: SUCCESS (0.000s) [125.109070] [031/171] (910s left) gem_flink_basic (double-flink) [125.246705] Starting subtest: double-flink [125.247865] Subtest double-flink: SUCCESS (0.000s) [125.359417] [032/171] (910s left) gem_flink_basic (flink-lifetime) [125.498816] Starting subtest: flink-lifetime [125.500174] Subtest flink-lifetime: SUCCESS (0.002s) [125.592834] [033/171] (910s left) gem_huc_copy (huc-copy) [125.731335] Starting subtest: huc-copy [125.733572] Subtest huc-copy: SKIP (0.000s) [125.842953] [034/171] (910s left) gem_linear_blits (basic) [126.143247] Starting subtest: basic [126.155758] Subtest basic: SUCCESS (0.013s) [126.294483] [035/171] (909s left) gem_mmap (basic) [126.494933] Starting subtest: basic [126.500790] Subtest basic: SUCCESS (0.001s) [126.593740] [036/171] (909s left) gem_mmap_gtt (basic) [126.733874] Starting subtest: basic [126.735276] Subtest basic: SUCCESS (0.001s) [126.825850] [037/171] (909s left) gem_render_linear_blits (basic) [126.963406] Starting subtest: basic [127.012806] Subtest basic: SUCCESS (0.050s) [127.075906] [038/171] (909s left) gem_render_tiled_blits (basic) [127.216921] Starting subtest: basic [127.272131] Subtest basic: SUCCESS (0.058s) [127.326982] [039/171] (908s left) gem_ringfill (basic-all) [127.609234] Starting subtest: basic-all [128.825773] Subtest basic-all: SUCCESS (1.208s) [128.913199] [040/171] (907s left) gem_softpin (allocator-basic) [129.053592] Starting subtest: allocator-basic [129.222603] Subtest allocator-basic: SUCCESS (0.160s) [129.328193] [041/171] (906s left) gem_softpin (allocator-basic-reserve) [129.491081] Starting subtest: allocator-basic-reserve [129.659410] Subtest allocator-basic-reserve: SUCCESS (0.160s) [129.781713] [042/171] (906s left) gem_softpin (safe-alignment) [129.936569] Starting subtest: safe-alignment [129.954611] Subtest safe-alignment: SUCCESS (0.018s) [130.076706] [043/171] (906s left) gem_sync (basic-all) [130.231535] Starting subtest: basic-all [132.450976] Subtest basic-all: SUCCESS (2.195s) [132.627314] [044/171] (903s left) gem_sync (basic-each) [132.778622] Starting subtest: basic-each [134.996664] Subtest basic-each: SUCCESS (2.217s) [135.223721] [045/171] (901s left) gem_tiled_blits (basic) [135.527949] Starting subtest: basic [135.555910] Subtest basic: SUCCESS (0.028s) [135.692890] [046/171] (900s left) gem_tiled_fence_blits (basic) [136.050470] Starting subtest: basic [136.078428] Subtest basic: SUCCESS (0.028s) [136.207948] [047/171] (900s left) gem_tiled_pread_basic [136.760765] [048/171] (899s left) gem_wait (busy@all-engines) [136.924802] Starting subtest: busy [136.926070] Starting dynamic subtest: all-engines [137.455427] Dynamic subtest all-engines: SUCCESS (0.531s) [137.456705] Subtest busy: SUCCESS (0.531s) [137.711457] [049/171] (898s left) gem_wait (wait@all-engines) [137.873255] Starting subtest: wait [137.874594] Starting dynamic subtest: all-engines [138.908195] Dynamic subtest all-engines: SUCCESS (1.029s) [138.909454] Subtest wait: SUCCESS (1.030s) [139.144156] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [139.279834] Starting subtest: basic-eu-total [139.282342] Subtest basic-eu-total: SUCCESS (0.000s) [139.359804] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [139.490055] Starting subtest: basic-subslice-total [139.492555] Subtest basic-subslice-total: SUCCESS (0.000s) [139.575918] [052/171] (896s left) i915_hangman (error-state-basic) [139.728637] Starting subtest: error-state-basic [139.743274] Subtest error-state-basic: SUCCESS (0.013s) [139.826662] [053/171] (896s left) i915_pciid [140.043807] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [140.183211] Starting subtest: addfb25-bad-modifier [140.184318] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [140.309808] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [140.438816] Starting subtest: addfb25-framebuffer-vs-set-tiling [140.439943] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [140.559665] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [140.697619] Starting subtest: addfb25-modifier-no-flag [140.698820] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [140.826785] [057/171] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [140.964327] Starting subtest: addfb25-x-tiled-legacy [140.965452] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [141.093359] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [141.231832] Starting subtest: addfb25-x-tiled-mismatch-legacy [141.233154] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [141.360139] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [141.526158] Starting subtest: addfb25-yf-tiled-legacy [141.527354] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [141.626570] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [141.794663] Starting subtest: addfb25-y-tiled-legacy [141.796048] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [141.893523] [061/171] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [142.061331] Starting subtest: addfb25-y-tiled-small-legacy [142.062500] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [142.159658] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [142.291899] Starting subtest: bad-pitch-0 [142.293272] Subtest bad-pitch-0: SUCCESS (0.000s) [142.426547] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [142.565368] Starting subtest: bad-pitch-1024 [142.566446] Subtest bad-pitch-1024: SUCCESS (0.000s) [142.693296] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [142.831771] Starting subtest: bad-pitch-128 [142.832971] Subtest bad-pitch-128: SUCCESS (0.000s) [142.959057] [065/171] (893s left) kms_addfb_basic (bad-pitch-256) [143.098899] Starting subtest: bad-pitch-256 [143.100192] Subtest bad-pitch-256: SUCCESS (0.000s) [143.226420] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [143.356134] Starting subtest: bad-pitch-32 [143.357267] Subtest bad-pitch-32: SUCCESS (0.000s) [143.493904] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [143.631869] Starting subtest: bad-pitch-63 [143.633314] Subtest bad-pitch-63: SUCCESS (0.000s) [143.759939] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [143.897817] Starting subtest: bad-pitch-65536 [143.899356] Subtest bad-pitch-65536: SUCCESS (0.000s) [144.026491] [069/171] (892s left) kms_addfb_basic (bad-pitch-999) [144.165272] Starting subtest: bad-pitch-999 [144.166464] Subtest bad-pitch-999: SUCCESS (0.000s) [144.293189] [070/171] (892s left) kms_addfb_basic (basic) [144.431612] Starting subtest: basic [144.432803] Subtest basic: SUCCESS (0.000s) [144.559876] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [144.700215] Starting subtest: basic-x-tiled-legacy [144.701379] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [144.826311] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [144.966418] Starting subtest: basic-y-tiled-legacy [144.967497] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [145.093279] [073/171] (892s left) kms_addfb_basic (bo-too-small) [145.261821] Starting subtest: bo-too-small [145.262985] Subtest bo-too-small: SUCCESS (0.000s) [145.361642] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [145.529489] Starting subtest: bo-too-small-due-to-tiling [145.530649] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [145.625866] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [145.758066] Starting subtest: clobberred-modifier [145.759287] Subtest clobberred-modifier: SUCCESS (0.000s) [145.893484] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [146.034162] Starting subtest: framebuffer-vs-set-tiling [146.035266] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [146.178257] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [146.317638] Starting subtest: invalid-get-prop [146.318823] Subtest invalid-get-prop: SUCCESS (0.000s) [146.442679] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [146.574476] Starting subtest: invalid-get-prop-any [146.575617] Subtest invalid-get-prop-any: SUCCESS (0.000s) [146.710790] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [146.853534] Starting subtest: invalid-set-prop [146.854655] Subtest invalid-set-prop: SUCCESS (0.000s) [146.976597] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [147.115783] Starting subtest: invalid-set-prop-any [147.117126] Subtest invalid-set-prop-any: SUCCESS (0.000s) [147.243413] [081/171] (890s left) kms_addfb_basic (no-handle) [147.384076] Starting subtest: no-handle [147.385249] Subtest no-handle: SUCCESS (0.000s) [147.509763] [082/171] (889s left) kms_addfb_basic (size-max) [147.679649] Starting subtest: size-max [147.680963] Subtest size-max: SUCCESS (0.000s) [147.776324] [083/171] (889s left) kms_addfb_basic (small-bo) [147.943927] Starting subtest: small-bo [147.945259] Subtest small-bo: SUCCESS (0.000s) [148.042971] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [148.183909] Starting subtest: tile-pitch-mismatch [148.185055] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [148.310598] [085/171] (889s left) kms_addfb_basic (too-high) [148.478988] Starting subtest: too-high [148.480427] Subtest too-high: SUCCESS (0.001s) [148.576239] [086/171] (888s left) kms_addfb_basic (too-wide) [148.743639] Starting subtest: too-wide [148.745071] Subtest too-wide: SUCCESS (0.000s) [148.842670] [087/171] (888s left) kms_addfb_basic (unused-handle) [148.981826] Starting subtest: unused-handle [148.983035] Subtest unused-handle: SUCCESS (0.000s) [149.111424] [088/171] (888s left) kms_addfb_basic (unused-modifier) [149.250633] Starting subtest: unused-modifier [149.251828] Subtest unused-modifier: SUCCESS (0.000s) [149.376488] [089/171] (888s left) kms_addfb_basic (unused-offsets) [149.516491] Starting subtest: unused-offsets [149.517689] Subtest unused-offsets: SUCCESS (0.000s) [149.642515] [090/171] (887s left) kms_addfb_basic (unused-pitches) [149.781691] Starting subtest: unused-pitches [149.782878] Subtest unused-pitches: SUCCESS (0.000s) [149.910140] [091/171] (887s left) kms_busy (basic) [150.084463] Starting subtest: basic [150.087289] Starting dynamic subtest: flip [151.193554] Dynamic subtest flip: SUCCESS (1.105s) [151.211916] Starting dynamic subtest: modeset [155.129273] Dynamic subtest modeset: SUCCESS (3.938s) [155.130685] Subtest basic: SUCCESS (5.046s) [156.105351] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [156.591644] Subtest dp-hpd-fast: SKIP (0.000s) [157.459316] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [157.937897] Subtest dp-edid-read: SKIP (0.000s) [158.802547] [094/171] (878s left) kms_chamelium_frames (dp-crc-fast) [159.285935] Subtest dp-crc-fast: SKIP (0.000s) [160.146585] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [160.627816] Subtest hdmi-hpd-fast: SKIP (0.000s) [161.492406] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [161.972482] Subtest hdmi-edid-read: SKIP (0.000s) [162.834966] [097/171] (874s left) kms_chamelium_frames (hdmi-crc-fast) [163.312123] Subtest hdmi-crc-fast: SKIP (0.000s) [164.178119] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [164.655512] Subtest vga-hpd-fast: SKIP (0.000s) [165.522852] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [166.003915] Subtest vga-edid-read: SKIP (0.000s) [166.887927] [100/171] (871s left) kms_prop_blob (basic) [167.019251] Starting subtest: basic [167.020547] Subtest basic: SUCCESS (0.000s) [167.110822] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [167.277097] Starting subtest: basic-busy-flip-before-cursor-atomic [167.279303] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [167.353340] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [167.511505] Starting subtest: basic-busy-flip-before-cursor-legacy [167.513790] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [167.588097] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [167.752249] Starting subtest: basic-flip-after-cursor-atomic [169.030746] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.278s) [169.990190] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [170.155721] Starting subtest: basic-flip-after-cursor-legacy [171.445942] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.290s) [172.420962] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [172.577681] Starting subtest: basic-flip-after-cursor-varying-size [173.880762] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.302s) [174.860066] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [175.041824] Starting subtest: basic-flip-before-cursor-atomic [176.332564] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.295s) [177.283776] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [177.450427] Starting subtest: basic-flip-before-cursor-legacy [178.748165] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.292s) [179.717342] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [179.884383] Starting subtest: basic-flip-before-cursor-varying-size [181.160365] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.277s) [182.086606] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [182.232798] Starting subtest: basic-flip-vs-dpms [182.236448] Starting dynamic subtest: A-eDP1 [185.106350] Dynamic subtest A-eDP1: SUCCESS (2.870s) [185.132929] Starting dynamic subtest: B-eDP1 [187.524897] Dynamic subtest B-eDP1: SUCCESS (2.415s) [187.541350] Starting dynamic subtest: C-eDP1 [189.889349] Dynamic subtest C-eDP1: SUCCESS (2.366s) [189.894267] Subtest basic-flip-vs-dpms: SUCCESS (7.660s) [190.798077] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [190.946051] Starting subtest: basic-flip-vs-modeset [190.949706] Starting dynamic subtest: A-eDP1 [193.788917] Dynamic subtest A-eDP1: SUCCESS (2.839s) [193.810069] Starting dynamic subtest: B-eDP1 [196.158478] Dynamic subtest B-eDP1: SUCCESS (2.368s) [196.175978] Starting dynamic subtest: C-eDP1 [198.524403] Dynamic subtest C-eDP1: SUCCESS (2.364s) [198.525564] Subtest basic-flip-vs-modeset: SUCCESS (7.581s) [199.493841] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [199.639884] Starting subtest: basic-flip-vs-wf_vblank [199.643449] Starting dynamic subtest: A-eDP1 [201.957445] Dynamic subtest A-eDP1: SUCCESS (2.314s) [201.976202] Starting dynamic subtest: B-eDP1 [204.180276] Dynamic subtest B-eDP1: SUCCESS (2.221s) [204.200464] Starting dynamic subtest: C-eDP1 [206.420901] Dynamic subtest C-eDP1: SUCCESS (2.239s) [206.426434] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.785s) [207.750599] [112/171] (830s left) kms_flip (basic-plain-flip) [207.896729] Starting subtest: basic-plain-flip [207.900495] Starting dynamic subtest: A-eDP1 [209.945166] Dynamic subtest A-eDP1: SUCCESS (2.044s) [209.966113] Starting dynamic subtest: B-eDP1 [211.896432] Dynamic subtest B-eDP1: SUCCESS (1.950s) [211.915076] Starting dynamic subtest: C-eDP1 [213.880450] Dynamic subtest C-eDP1: SUCCESS (1.983s) [213.883397] Subtest basic-plain-flip: SUCCESS (5.987s) [215.174966] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [215.320238] Starting subtest: force-connector-state [217.045869] Subtest force-connector-state: SUCCESS (1.726s) [217.670236] [114/171] (820s left) kms_force_connector_basic (force-edid) [217.813456] Starting subtest: force-edid [218.068594] Subtest force-edid: SUCCESS (0.255s) [218.203961] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [218.347587] Starting subtest: force-load-detect [218.350245] Subtest force-load-detect: SKIP (0.000s) [218.470577] [116/171] (819s left) kms_force_connector_basic (prune-stale-modes) [218.605252] Starting subtest: prune-stale-modes [218.918608] Subtest prune-stale-modes: SUCCESS (0.310s) [219.053443] [117/171] (819s left) kms_frontbuffer_tracking (basic) [219.231628] Starting subtest: basic [222.502613] Subtest basic: SUCCESS (3.269s) [222.622434] [118/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [222.787243] Starting subtest: compare-crc-sanitycheck-xr24 [222.788512] Starting dynamic subtest: pipe-A-eDP-1 [223.468089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s) [223.486654] Starting dynamic subtest: pipe-B-eDP-1 [224.851363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s) [224.868556] Starting dynamic subtest: pipe-C-eDP-1 [226.384161] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.540s) [226.385395] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.598s) [227.327545] [119/171] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [227.495221] Starting subtest: compare-crc-sanitycheck-nv12 [227.498406] Starting dynamic subtest: pipe-A-eDP-1 [228.426746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s) [228.443635] Starting dynamic subtest: pipe-B-eDP-1 [229.889201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s) [229.910467] Starting dynamic subtest: pipe-C-eDP-1 [231.666680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.772s) [231.667990] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.172s) [232.591396] [120/171] (805s left) kms_pipe_crc_basic (hang-read-crc) [232.759434] Starting subtest: hang-read-crc [232.762707] Starting dynamic subtest: pipe-A-eDP-1 [235.088428] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.326s) [235.108602] Starting dynamic subtest: pipe-B-eDP-1 [238.063499] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s) [238.081382] Starting dynamic subtest: pipe-C-eDP-1 [241.378813] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.312s) [241.380119] Subtest hang-read-crc: SUCCESS (8.619s) [242.303620] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [242.469577] Starting subtest: nonblocking-crc [242.470713] Starting dynamic subtest: pipe-A-eDP-1 [243.329490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s) [243.349649] Starting dynamic subtest: pipe-B-eDP-1 [244.908686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.576s) [244.928957] Starting dynamic subtest: pipe-C-eDP-1 [246.647188] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.734s) [246.648402] Subtest nonblocking-crc: SUCCESS (4.179s) [247.616910] [122/171] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [247.786530] Starting subtest: nonblocking-crc-frame-sequence [247.790190] Starting dynamic subtest: pipe-A-eDP-1 [248.639667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [248.659628] Starting dynamic subtest: pipe-B-eDP-1 [250.193428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [250.213229] Starting dynamic subtest: pipe-C-eDP-1 [251.913904] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.717s) [251.915169] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.129s) [252.863634] [123/171] (785s left) kms_pipe_crc_basic (read-crc) [253.031561] Starting subtest: read-crc [253.033138] Starting dynamic subtest: pipe-A-eDP-1 [253.821706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s) [253.840960] Starting dynamic subtest: pipe-B-eDP-1 [255.321330] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [255.340046] Starting dynamic subtest: pipe-C-eDP-1 [256.962168] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.649s) [256.963449] Subtest read-crc: SUCCESS (3.932s) [257.919911] [124/171] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [258.086932] Starting subtest: read-crc-frame-sequence [258.090522] Starting dynamic subtest: pipe-A-eDP-1 [258.876480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [258.899398] Starting dynamic subtest: pipe-B-eDP-1 [260.364558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [260.384445] Starting dynamic subtest: pipe-C-eDP-1 [262.014622] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.645s) [262.015826] Subtest read-crc-frame-sequence: SUCCESS (3.927s) [262.976103] [125/171] (775s left) kms_psr (primary_page_flip) [263.150578] Starting subtest: primary_page_flip [267.337508] Subtest primary_page_flip: SUCCESS (4.188s) [268.287843] [126/171] (770s left) kms_psr (cursor_plane_move) [268.457862] Starting subtest: cursor_plane_move [272.613058] Subtest cursor_plane_move: SUCCESS (4.154s) [273.536060] [127/171] (765s left) kms_psr (sprite_plane_onoff) [273.706018] Starting subtest: sprite_plane_onoff [277.968435] Subtest sprite_plane_onoff: SUCCESS (4.255s) [278.912761] [128/171] (759s left) kms_psr (primary_mmap_gtt) [279.083998] Starting subtest: primary_mmap_gtt [283.271707] Subtest primary_mmap_gtt: SUCCESS (4.187s) [284.222655] [129/171] (754s left) kms_setmode (basic-clone-single-crtc) [284.364997] Starting subtest: basic-clone-single-crtc [284.368810] Subtest basic-clone-single-crtc: SKIP (0.000s) [284.456111] [130/171] (754s left) i915_pm_backlight (basic-brightness) [284.623510] Starting subtest: basic-brightness [284.722301] Starting dynamic subtest: eDP-1 [285.298513] Dynamic subtest eDP-1: SUCCESS (0.578s) [285.299776] Subtest basic-brightness: SUCCESS (0.676s) [286.211139] [131/171] (752s left) i915_pm_rpm (basic-pci-d3-state) [288.098290] Starting subtest: basic-pci-d3-state [292.510554] Subtest basic-pci-d3-state: SUCCESS (4.410s) [292.709873] [132/171] (746s left) i915_pm_rpm (basic-rte) [292.842076] Starting subtest: basic-rte [298.979796] Subtest basic-rte: SUCCESS (6.126s) [304.284592] [133/171] (734s left) i915_pm_rps (basic-api) [304.432801] Starting subtest: basic-api [304.437083] Subtest basic-api: SUCCESS (0.004s) [304.516644] [134/171] (734s left) prime_self_import (basic-llseek-bad) [304.652649] Starting subtest: basic-llseek-bad [304.655250] Subtest basic-llseek-bad: SUCCESS (0.003s) [304.766557] [135/171] (734s left) prime_self_import (basic-llseek-size) [304.902107] Starting subtest: basic-llseek-size [304.906886] Subtest basic-llseek-size: SUCCESS (0.005s) [305.000211] [136/171] (734s left) prime_self_import (basic-with_fd_dup) [305.135847] Starting subtest: basic-with_fd_dup [305.140628] Subtest basic-with_fd_dup: SUCCESS (0.005s) [305.256117] [137/171] (733s left) prime_self_import (basic-with_one_bo) [305.393162] Starting subtest: basic-with_one_bo [305.398433] Subtest basic-with_one_bo: SUCCESS (0.005s) [305.481460] [138/171] (733s left) prime_self_import (basic-with_one_bo_two_files) [305.616765] Starting subtest: basic-with_one_bo_two_files [305.621452] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [305.720565] [139/171] (733s left) prime_self_import (basic-with_two_bos) [305.855568] Starting subtest: basic-with_two_bos [305.860432] Subtest basic-with_two_bos: SUCCESS (0.005s) [305.968207] [140/171] (733s left) prime_vgem (basic-fence-flip) [306.119532] Starting subtest: basic-fence-flip [306.645409] Subtest basic-fence-flip: SUCCESS (0.524s) [306.768079] [141/171] (732s left) prime_vgem (basic-fence-mmap) [306.919519] Starting subtest: basic-fence-mmap [306.968099] Subtest basic-fence-mmap: SUCCESS (0.048s) [307.070852] [142/171] (732s left) prime_vgem (basic-fence-read) [307.220530] Starting subtest: basic-fence-read [307.294361] Subtest basic-fence-read: SUCCESS (0.074s) [307.389329] [143/171] (731s left) prime_vgem (basic-gtt) [307.536111] Starting subtest: basic-gtt [307.559693] Subtest basic-gtt: SUCCESS (0.023s) [307.671249] [144/171] (731s left) prime_vgem (basic-read) [307.842613] Starting subtest: basic-read [307.878275] Subtest basic-read: SUCCESS (0.035s) [307.988819] [145/171] (731s left) prime_vgem (basic-write) [308.136142] Starting subtest: basic-write [308.178022] Subtest basic-write: SUCCESS (0.042s) [308.270173] [146/171] (731s left) vgem_basic (setversion) [308.411779] Starting subtest: setversion [308.414402] Subtest setversion: SUCCESS (0.000s) [308.485314] [147/171] (730s left) vgem_basic (create) [308.628637] Starting subtest: create [308.629973] Subtest create: SUCCESS (0.000s) [308.704160] [148/171] (730s left) vgem_basic (debugfs) [308.845201] Starting subtest: debugfs [308.846489] Subtest debugfs: SUCCESS (0.001s) [308.920092] [149/171] (730s left) vgem_basic (dmabuf-export) [309.062300] Starting subtest: dmabuf-export [309.064934] Subtest dmabuf-export: SUCCESS (0.003s) [309.170569] [150/171] (730s left) vgem_basic (dmabuf-fence) [309.311605] Starting subtest: dmabuf-fence [309.312832] Subtest dmabuf-fence: SUCCESS (0.001s) [309.384366] [151/171] (730s left) vgem_basic (dmabuf-fence-before) [309.531155] Starting subtest: dmabuf-fence-before [309.532452] Subtest dmabuf-fence-before: SUCCESS (0.000s) [309.600184] [152/171] (729s left) vgem_basic (dmabuf-mmap) [309.747640] Starting subtest: dmabuf-mmap [309.772181] Subtest dmabuf-mmap: SUCCESS (0.026s) [309.850904] [153/171] (729s left) vgem_basic (mmap) [309.997749] Starting subtest: mmap [310.012660] Subtest mmap: SUCCESS (0.017s) [310.085240] [154/171] (729s left) vgem_basic (second-client) [310.231522] Starting subtest: second-client [310.264672] Subtest second-client: SUCCESS (0.033s) [310.334496] [155/171] (729s left) vgem_basic (sysfs) [310.481882] Starting subtest: sysfs [310.483221] Subtest sysfs: SUCCESS (0.001s) [310.551175] [156/171] (729s left) core_hotunplug (unbind-rebind) [310.730178] Starting subtest: unbind-rebind [313.163385] Subtest unbind-rebind: SUCCESS (2.434s) [313.203667] [157/171] (726s left) vgem_basic (unload) [313.346108] Starting subtest: unload [342.395169] Subtest unload: SUCCESS (29.014s) [342.488030] [158/171] (697s left) i915_module_load (reload) [342.631948] Starting subtest: reload [346.169306] Subtest reload: SUCCESS (3.539s) [346.204194] [159/171] (693s left) gem_lmem_swapping (basic) [346.364609] Subtest basic: SKIP (0.000s) [346.421487] [160/171] (693s left) gem_lmem_swapping (parallel-random-engines) [346.566596] Subtest parallel-random-engines: SKIP (0.000s) [346.629976] [161/171] (693s left) gem_lmem_swapping (random-engines) [346.767278] Subtest random-engines: SKIP (0.000s) [346.820844] [162/171] (693s left) gem_lmem_swapping (verify-random) [346.964369] Subtest verify-random: SKIP (0.000s) [347.022647] [163/171] (692s left) i915_pm_rpm (module-reload) [359.529729] Starting subtest: module-reload [394.418584] Subtest module-reload: SUCCESS (34.880s) [394.443647] [164/171] (645s left) i915_selftest (live) [394.587045] Starting subtest: live [394.588562] Starting dynamic subtest: sanitycheck [396.455772] Dynamic subtest sanitycheck: SUCCESS (1.859s) [396.471028] Starting dynamic subtest: uncore [398.312587] Dynamic subtest uncore: SUCCESS (1.853s) [398.327986] Starting dynamic subtest: workarounds [400.382584] Dynamic subtest workarounds: SUCCESS (2.067s) [400.398170] Starting dynamic subtest: gt_engines [402.671579] Dynamic subtest gt_engines: SUCCESS (2.285s) [402.686777] Starting dynamic subtest: gt_timelines [415.371597] Dynamic subtest gt_timelines: SUCCESS (12.696s) [415.386621] Starting dynamic subtest: gt_contexts [417.335330] Dynamic subtest gt_contexts: SUCCESS (1.969s) [417.353376] Starting dynamic subtest: gt_lrc [421.746427] Dynamic subtest gt_lrc: SUCCESS (4.400s) [421.761881] Starting dynamic subtest: gt_mocs [423.711490] Dynamic subtest gt_mocs: SUCCESS (1.962s) [423.726576] Starting dynamic subtest: gt_pm [428.807630] Dynamic subtest gt_pm: SUCCESS (5.093s) [428.823308] Starting dynamic subtest: gt_heartbeat [430.757456] Dynamic subtest gt_heartbeat: SUCCESS (1.955s) [430.775040] Starting dynamic subtest: gt_tlb [433.911456] Dynamic subtest gt_tlb: SUCCESS (3.143s) [433.926596] Starting dynamic subtest: requests [441.515869] Dynamic subtest requests: SUCCESS (7.601s) [441.531199] Starting dynamic subtest: migrate [446.124530] Dynamic subtest migrate: SUCCESS (4.605s) [446.139481] Starting dynamic subtest: active [448.000612] Dynamic subtest active: SUCCESS (1.872s) [448.015872] Starting dynamic subtest: objects [451.358261] Dynamic subtest objects: SUCCESS (3.355s) [451.373903] Starting dynamic subtest: mman [458.328523] Dynamic subtest mman: SUCCESS (6.968s) [458.344191] Starting dynamic subtest: dmabuf [460.220620] Dynamic subtest dmabuf: SUCCESS (1.888s) [460.236038] Starting dynamic subtest: vma [462.061170] Dynamic subtest vma: SUCCESS (1.837s) [462.076609] Starting dynamic subtest: coherency [466.614820] Dynamic subtest coherency: SUCCESS (4.551s) [466.630645] Starting dynamic subtest: gtt [476.028495] Dynamic subtest gtt: SUCCESS (9.410s) [476.043762] Starting dynamic subtest: gem [478.027566] Dynamic subtest gem: SUCCESS (1.996s) [478.043205] Starting dynamic subtest: evict [481.906444] Dynamic subtest evict: SUCCESS (3.883s) [481.926224] Starting dynamic subtest: hugepages [489.688698] Dynamic subtest hugepages: SUCCESS (7.770s) [489.704234] Starting dynamic subtest: gem_contexts [504.842605] Dynamic subtest gem_contexts: SUCCESS (15.150s) [504.858472] Starting dynamic subtest: client [506.736608] Dynamic subtest client: SUCCESS (1.891s) [506.753055] Starting dynamic subtest: gem_migrate [508.592064] Dynamic subtest gem_migrate: SUCCESS (1.852s) [508.607842] Starting dynamic subtest: reset [514.038487] Dynamic subtest reset: SUCCESS (5.443s) [514.054492] Starting dynamic subtest: memory_region [515.881680] Dynamic subtest memory_region: SUCCESS (1.840s) [515.897435] Starting dynamic subtest: hangcheck [540.339703] Dynamic subtest hangcheck: SUCCESS (24.455s) [540.356470] Starting dynamic subtest: execlists [550.467753] Dynamic subtest execlists: SUCCESS (10.125s) [550.483624] Starting dynamic subtest: ring_submission [552.291483] Dynamic subtest ring_submission: SUCCESS (1.821s) [552.307236] Starting dynamic subtest: perf [554.207482] Dynamic subtest perf: SUCCESS (1.913s) [554.223332] Starting dynamic subtest: slpc [556.082557] Dynamic subtest slpc: SUCCESS (1.872s) [556.098403] Starting dynamic subtest: guc [557.923555] Dynamic subtest guc: SUCCESS (1.838s) [557.939369] Starting dynamic subtest: guc_multi_lrc [559.793358] Dynamic subtest guc_multi_lrc: SUCCESS (1.867s) [559.809241] Starting dynamic subtest: guc_hang [561.641072] Dynamic subtest guc_hang: SUCCESS (1.845s) [561.656971] Starting dynamic subtest: late_gt_pm [563.568655] Dynamic subtest late_gt_pm: SUCCESS (1.924s) [563.570095] Subtest live: SUCCESS (168.975s) [563.772323] [165/171] (476s left) dmabuf (all-tests) [563.912651] Starting subtest: all-tests [563.914035] Starting dynamic subtest: sanitycheck [563.973723] Dynamic subtest sanitycheck: SUCCESS (0.059s) [563.991784] Starting dynamic subtest: dma_fence [564.157208] Dynamic subtest dma_fence: SUCCESS (0.179s) [564.176973] Starting dynamic subtest: dma_fence_chain [581.831371] Dynamic subtest dma_fence_chain: SUCCESS (17.662s) [581.844274] Starting dynamic subtest: dma_fence_unwrap [581.897923] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s) [581.917158] Starting dynamic subtest: dma_resv [581.961925] Dynamic subtest dma_resv: SUCCESS (0.060s) [581.964334] Subtest all-tests: SUCCESS (18.050s) [581.993533] [166/171] (457s left) i915_suspend (basic-s2idle-without-i915) [582.130045] Starting subtest: basic-s2idle-without-i915 [605.911638] Subtest basic-s2idle-without-i915: SUCCESS (8.473s) [606.218960] [167/171] (449s left) i915_suspend (basic-s3-without-i915) [606.357223] Starting subtest: basic-s3-without-i915 [629.982123] Subtest basic-s3-without-i915: SUCCESS (7.139s) [630.340483] [168/171] (441s left) gem_exec_suspend (basic-s0) [630.497002] Starting subtest: basic-S0 [630.498217] Starting dynamic subtest: smem [650.187508] Dynamic subtest smem: SUCCESS (3.846s) [650.188717] Subtest basic-S0: SUCCESS (3.848s) [650.347350] [169/171] (437s left) gem_exec_suspend (basic-s3) [650.495235] Starting subtest: basic-S3 [650.496419] Starting dynamic subtest: smem [669.089115] Dynamic subtest smem: SUCCESS (3.798s) [669.090298] Subtest basic-S3: SUCCESS (3.800s) [669.253083] [170/171] (433s left) kms_chamelium_hpd (common-hpd-after-suspend) [669.746395] Subtest common-hpd-after-suspend: SKIP (0.000s) [670.646315] [171/171] (431s left) kms_pipe_crc_basic (suspend-read-crc) [670.808993] Starting subtest: suspend-read-crc [670.812577] Starting dynamic subtest: pipe-A-eDP-1 [689.028688] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.430s) [689.052868] Starting dynamic subtest: pipe-B-eDP-1 [707.001094] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.084s) [707.024105] Starting dynamic subtest: pipe-C-eDP-1 [725.994827] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.245s) [725.996035] Subtest suspend-read-crc: SUCCESS (8.771s) [726.916904] Closing watchdogs Done.