[37.940910] Initializing watchdogs [37.941124] /dev/watchdog0 [37.951575] [001/171] (960s left) i915_module_load (load) [38.091303] Starting subtest: load [40.486354] Subtest load: SUCCESS (2.395s) [40.514342] [002/171] (957s left) core_auth (basic-auth) [40.645180] Starting subtest: basic-auth [40.647594] Subtest basic-auth: SUCCESS (0.002s) [40.715693] [003/171] (957s left) debugfs_test (read_all_entries) [40.867226] Starting subtest: read_all_entries [40.954618] Subtest read_all_entries: SUCCESS (0.087s) [41.065478] [004/171] (957s left) debugfs_test (basic-hwmon) [41.199068] Starting subtest: basic-hwmon [41.201214] Subtest basic-hwmon: SKIP (0.000s) [41.303182] [005/171] (957s left) fbdev (eof) [41.454895] Starting subtest: eof [41.456111] Subtest eof: SUCCESS (0.000s) [41.518469] [006/171] (957s left) fbdev (info) [41.636998] Starting subtest: info [41.638342] Subtest info: SUCCESS (0.000s) [41.715715] [007/171] (956s left) fbdev (nullptr) [41.836856] Starting subtest: nullptr [41.838077] Subtest nullptr: SUCCESS (0.000s) [41.902486] [008/171] (956s left) fbdev (read) [42.037523] Starting subtest: read [49.145815] Subtest read: SUCCESS (7.075s) [49.184599] [009/171] (949s left) fbdev (write) [49.321875] Starting subtest: write [53.093517] Subtest write: SUCCESS (3.738s) [53.134373] [010/171] (945s left) gem_basic (bad-close) [53.267196] Starting subtest: bad-close [53.269610] Subtest bad-close: SUCCESS (0.000s) [53.352494] [011/171] (945s left) gem_basic (create-close) [53.489337] Starting subtest: create-close [53.491407] Subtest create-close: SUCCESS (0.000s) [53.585197] [012/171] (945s left) gem_basic (create-fd-close) [53.722930] Starting subtest: create-fd-close [53.725286] Subtest create-fd-close: SUCCESS (0.000s) [53.818440] [013/171] (944s left) gem_busy (busy@all-engines) [53.970202] Starting subtest: busy [53.971405] Starting dynamic subtest: all-engines [54.017318] Dynamic subtest all-engines: SUCCESS (0.047s) [54.018731] Subtest busy: SUCCESS (0.047s) [54.420611] [014/171] (944s left) gem_close_race (basic-process) [54.560195] Starting subtest: basic-process [54.634607] Subtest basic-process: SUCCESS (0.074s) [54.834470] [015/171] (943s left) gem_close_race (basic-threads) [54.971400] Starting subtest: basic-threads [56.139204] Subtest basic-threads: SUCCESS (1.167s) [56.353862] [016/171] (942s left) gem_ctx_create (basic) [56.488618] Starting subtest: basic [56.489811] Subtest basic: SUCCESS (0.000s) [56.685096] [017/171] (942s left) gem_ctx_create (basic-files) [56.814884] Starting subtest: basic-files [58.835583] Subtest basic-files: SUCCESS (2.021s) [59.052340] [018/171] (939s left) gem_ctx_exec (basic) [59.189784] Starting subtest: basic [59.194860] Subtest basic: SUCCESS (0.005s) [59.301276] [019/171] (939s left) gem_exec_basic (basic) [59.430528] Starting subtest: basic [59.431643] Starting dynamic subtest: rcs0-smem [59.432651] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [59.443465] Starting dynamic subtest: bcs0-smem [59.444682] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [59.454540] Starting dynamic subtest: vcs0-smem [59.455856] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.465639] Starting dynamic subtest: vecs0-smem [59.466818] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [59.467993] Subtest basic: SUCCESS (0.005s) [59.633999] [020/171] (939s left) gem_exec_create (basic) [59.765369] Starting subtest: basic [59.766483] Starting dynamic subtest: smem [61.806515] Dynamic subtest smem: SUCCESS (2.040s) [61.807566] Subtest basic: SUCCESS (2.041s) [62.019545] [021/171] (936s left) gem_exec_fence (basic-busy) [62.299605] Starting subtest: basic-busy [62.300954] Starting dynamic subtest: rcs0 [62.320196] Dynamic subtest rcs0: SUCCESS (0.029s) [62.332936] Starting dynamic subtest: bcs0 [62.344339] Dynamic subtest bcs0: SUCCESS (0.024s) [62.355162] Starting dynamic subtest: vcs0 [62.369952] Dynamic subtest vcs0: SUCCESS (0.025s) [62.382767] Starting dynamic subtest: vecs0 [62.393398] Dynamic subtest vecs0: SUCCESS (0.023s) [62.394779] Subtest basic-busy: SUCCESS (0.103s) [62.973768] [022/171] (935s left) gem_exec_fence (basic-wait) [63.258634] Starting subtest: basic-wait [63.260041] Starting dynamic subtest: rcs0 [63.274534] Dynamic subtest rcs0: SUCCESS (0.024s) [63.287897] Starting dynamic subtest: bcs0 [63.297354] Dynamic subtest bcs0: SUCCESS (0.023s) [63.308209] Starting dynamic subtest: vcs0 [63.324521] Dynamic subtest vcs0: SUCCESS (0.027s) [63.335370] Starting dynamic subtest: vecs0 [63.354593] Dynamic subtest vecs0: SUCCESS (0.030s) [63.356293] Subtest basic-wait: SUCCESS (0.105s) [63.885289] [023/171] (935s left) gem_exec_fence (basic-await) [64.159607] Starting subtest: basic-await [64.160830] Starting dynamic subtest: rcs0 [64.241394] Dynamic subtest rcs0: SUCCESS (0.089s) [64.266995] Starting dynamic subtest: bcs0 [64.357219] Dynamic subtest bcs0: SUCCESS (0.115s) [64.383822] Starting dynamic subtest: vcs0 [64.479060] Dynamic subtest vcs0: SUCCESS (0.122s) [64.504323] Starting dynamic subtest: vecs0 [64.600314] Dynamic subtest vecs0: SUCCESS (0.121s) [64.602297] Subtest basic-await: SUCCESS (0.449s) [65.185252] [024/171] (933s left) gem_exec_fence (nb-await) [65.458864] Starting subtest: nb-await [65.460208] Starting dynamic subtest: rcs0 [65.516734] Dynamic subtest rcs0: SUCCESS (0.065s) [65.533542] Starting dynamic subtest: bcs0 [65.583852] Dynamic subtest bcs0: SUCCESS (0.068s) [65.609716] Starting dynamic subtest: vcs0 [65.656258] Dynamic subtest vcs0: SUCCESS (0.072s) [65.682932] Starting dynamic subtest: vecs0 [65.729349] Dynamic subtest vecs0: SUCCESS (0.073s) [65.731189] Subtest nb-await: SUCCESS (0.279s) [66.268593] [025/171] (932s left) gem_exec_gttfill (basic) [66.404140] Starting subtest: basic [73.592229] Subtest basic: SUCCESS (7.180s) [73.771509] [026/171] (925s left) gem_exec_parallel (engines) [73.980452] Starting subtest: engines [73.981665] Starting dynamic subtest: basic [76.472633] Dynamic subtest basic: SUCCESS (2.466s) [76.487222] Starting dynamic subtest: contexts [79.782255] Dynamic subtest contexts: SUCCESS (3.326s) [79.794847] Starting dynamic subtest: fds [83.808134] Dynamic subtest fds: SUCCESS (4.034s) [83.828233] Starting dynamic subtest: userptr [86.305881] Dynamic subtest userptr: SUCCESS (2.468s) [86.307845] Subtest engines: SUCCESS (12.295s) [86.489050] [027/171] (912s left) gem_exec_store (basic) [86.627454] Starting subtest: basic [86.690843] Subtest basic: SUCCESS (0.063s) [86.887113] [028/171] (912s left) gem_flink_basic (bad-flink) [87.007934] Starting subtest: bad-flink [87.009237] Subtest bad-flink: SUCCESS (0.000s) [87.086110] [029/171] (911s left) gem_flink_basic (bad-open) [87.203791] Starting subtest: bad-open [87.204974] Subtest bad-open: SUCCESS (0.000s) [87.286312] [030/171] (911s left) gem_flink_basic (basic) [87.405211] Starting subtest: basic [87.406333] Subtest basic: SUCCESS (0.000s) [87.502809] [031/171] (911s left) gem_flink_basic (double-flink) [87.621023] Starting subtest: double-flink [87.622133] Subtest double-flink: SUCCESS (0.000s) [87.719519] [032/171] (911s left) gem_flink_basic (flink-lifetime) [87.837752] Starting subtest: flink-lifetime [87.838928] Subtest flink-lifetime: SUCCESS (0.002s) [87.936329] [033/171] (911s left) gem_huc_copy (huc-copy) [88.061449] Starting subtest: huc-copy [88.063680] Subtest huc-copy: SKIP (0.000s) [88.186315] [034/171] (911s left) gem_linear_blits (basic) [88.463316] Starting subtest: basic [88.475213] Subtest basic: SUCCESS (0.012s) [88.603489] [035/171] (910s left) gem_mmap (basic) [88.791724] Starting subtest: basic [88.796964] Subtest basic: SUCCESS (0.001s) [88.886449] [036/171] (910s left) gem_mmap_gtt (basic) [89.007409] Starting subtest: basic [89.008614] Subtest basic: SUCCESS (0.001s) [89.087274] [037/171] (910s left) gem_render_linear_blits (basic) [89.209890] Starting subtest: basic [89.259856] Subtest basic: SUCCESS (0.049s) [89.321365] [038/171] (909s left) gem_render_tiled_blits (basic) [89.448602] Starting subtest: basic [89.509187] Subtest basic: SUCCESS (0.060s) [89.581434] [039/171] (909s left) gem_ringfill (basic-all) [89.841124] Starting subtest: basic-all [91.082430] Subtest basic-all: SUCCESS (1.242s) [91.171991] [040/171] (908s left) gem_softpin (allocator-basic) [91.298941] Starting subtest: allocator-basic [91.461972] Subtest allocator-basic: SUCCESS (0.154s) [91.570416] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [91.716031] Starting subtest: allocator-basic-reserve [91.870268] Subtest allocator-basic-reserve: SUCCESS (0.154s) [91.986903] [042/171] (907s left) gem_softpin (safe-alignment) [92.125726] Starting subtest: safe-alignment [92.143075] Subtest safe-alignment: SUCCESS (0.017s) [92.252747] [043/171] (907s left) gem_sync (basic-all) [92.385647] Starting subtest: basic-all [94.874904] Subtest basic-all: SUCCESS (2.489s) [95.087754] [044/171] (904s left) gem_sync (basic-each) [95.232349] Starting subtest: basic-each [97.389811] Subtest basic-each: SUCCESS (2.157s) [97.606301] [045/171] (901s left) gem_tiled_blits (basic) [97.874418] Starting subtest: basic [97.904363] Subtest basic: SUCCESS (0.030s) [98.037713] [046/171] (901s left) gem_tiled_fence_blits (basic) [98.384950] Starting subtest: basic [98.411272] Subtest basic: SUCCESS (0.027s) [98.535339] [047/171] (900s left) gem_tiled_pread_basic [99.070312] [048/171] (900s left) gem_wait (busy@all-engines) [99.209950] Starting subtest: busy [99.211162] Starting dynamic subtest: all-engines [99.754096] Dynamic subtest all-engines: SUCCESS (0.544s) [99.755393] Subtest busy: SUCCESS (0.544s) [99.987380] [049/171] (899s left) gem_wait (wait@all-engines) [100.131547] Starting subtest: wait [100.132737] Starting dynamic subtest: all-engines [101.180520] Dynamic subtest all-engines: SUCCESS (1.047s) [101.182440] Subtest wait: SUCCESS (1.047s) [101.420299] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [101.538599] Starting subtest: basic-eu-total [101.540881] Subtest basic-eu-total: SUCCESS (0.000s) [101.620014] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [101.739153] Starting subtest: basic-subslice-total [101.741490] Subtest basic-subslice-total: SUCCESS (0.000s) [101.819717] [052/171] (897s left) i915_hangman (error-state-basic) [101.952620] Starting subtest: error-state-basic [101.962132] Subtest error-state-basic: SUCCESS (0.010s) [102.070397] [053/171] (897s left) i915_pciid [102.270462] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [102.390404] Starting subtest: addfb25-bad-modifier [102.391455] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [102.519300] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [102.639640] Starting subtest: addfb25-framebuffer-vs-set-tiling [102.640908] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.753197] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [102.872209] Starting subtest: addfb25-modifier-no-flag [102.873260] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [102.986640] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [103.106343] Starting subtest: addfb25-x-tiled-legacy [103.107490] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [103.219201] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [103.337912] Starting subtest: addfb25-x-tiled-mismatch-legacy [103.339369] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [103.453081] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [103.600156] Starting subtest: addfb25-yf-tiled-legacy [103.601201] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [103.686298] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [103.831836] Starting subtest: addfb25-y-tiled-legacy [103.833086] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [103.937777] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [104.083709] Starting subtest: addfb25-y-tiled-small-legacy [104.084877] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [104.169559] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [104.286218] Starting subtest: bad-pitch-0 [104.287300] Subtest bad-pitch-0: SUCCESS (0.000s) [104.402549] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [104.535297] Starting subtest: bad-pitch-1024 [104.536623] Subtest bad-pitch-1024: SUCCESS (0.000s) [104.654500] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [104.791425] Starting subtest: bad-pitch-128 [104.792660] Subtest bad-pitch-128: SUCCESS (0.000s) [104.921037] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [105.042891] Starting subtest: bad-pitch-256 [105.044385] Subtest bad-pitch-256: SUCCESS (0.000s) [105.169712] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [105.288367] Starting subtest: bad-pitch-32 [105.289417] Subtest bad-pitch-32: SUCCESS (0.000s) [105.403235] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [105.521772] Starting subtest: bad-pitch-63 [105.523034] Subtest bad-pitch-63: SUCCESS (0.000s) [105.654533] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [105.774337] Starting subtest: bad-pitch-65536 [105.775395] Subtest bad-pitch-65536: SUCCESS (0.000s) [105.903427] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [106.021680] Starting subtest: bad-pitch-999 [106.022840] Subtest bad-pitch-999: SUCCESS (0.000s) [106.154015] [070/171] (893s left) kms_addfb_basic (basic) [106.273395] Starting subtest: basic [106.274484] Subtest basic: SUCCESS (0.000s) [106.386234] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [106.505255] Starting subtest: basic-x-tiled-legacy [106.506375] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [106.638219] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [106.757246] Starting subtest: basic-y-tiled-legacy [106.758319] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [106.887360] [073/171] (893s left) kms_addfb_basic (bo-too-small) [107.033676] Starting subtest: bo-too-small [107.034830] Subtest bo-too-small: SUCCESS (0.000s) [107.136526] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [107.283516] Starting subtest: bo-too-small-due-to-tiling [107.284675] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [107.386402] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [107.504944] Starting subtest: clobberred-modifier [107.506117] Subtest clobberred-modifier: SUCCESS (0.000s) [107.619796] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [107.749210] Starting subtest: framebuffer-vs-set-tiling [107.750303] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.869487] [077/171] (892s left) kms_addfb_basic (invalid-get-prop) [107.988344] Starting subtest: invalid-get-prop [107.989456] Subtest invalid-get-prop: SUCCESS (0.000s) [108.103403] [078/171] (892s left) kms_addfb_basic (invalid-get-prop-any) [108.223224] Starting subtest: invalid-get-prop-any [108.224320] Subtest invalid-get-prop-any: SUCCESS (0.000s) [108.353314] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [108.472361] Starting subtest: invalid-set-prop [108.473588] Subtest invalid-set-prop: SUCCESS (0.000s) [108.586128] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [108.704503] Starting subtest: invalid-set-prop-any [108.705563] Subtest invalid-set-prop-any: SUCCESS (0.000s) [108.839542] [081/171] (891s left) kms_addfb_basic (no-handle) [108.958774] Starting subtest: no-handle [108.959932] Subtest no-handle: SUCCESS (0.000s) [109.086884] [082/171] (891s left) kms_addfb_basic (size-max) [109.232459] Starting subtest: size-max [109.233834] Subtest size-max: SUCCESS (0.000s) [109.319332] [083/171] (891s left) kms_addfb_basic (small-bo) [109.465341] Starting subtest: small-bo [109.466473] Subtest small-bo: SUCCESS (0.000s) [109.552607] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [109.669852] Starting subtest: tile-pitch-mismatch [109.671058] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [109.786286] [085/171] (890s left) kms_addfb_basic (too-high) [109.931927] Starting subtest: too-high [109.933240] Subtest too-high: SUCCESS (0.001s) [110.036343] [086/171] (890s left) kms_addfb_basic (too-wide) [110.183364] Starting subtest: too-wide [110.184476] Subtest too-wide: SUCCESS (0.000s) [110.269649] [087/171] (890s left) kms_addfb_basic (unused-handle) [110.396433] Starting subtest: unused-handle [110.397619] Subtest unused-handle: SUCCESS (0.000s) [110.503305] [088/171] (890s left) kms_addfb_basic (unused-modifier) [110.621554] Starting subtest: unused-modifier [110.622739] Subtest unused-modifier: SUCCESS (0.000s) [110.736464] [089/171] (889s left) kms_addfb_basic (unused-offsets) [110.854224] Starting subtest: unused-offsets [110.855310] Subtest unused-offsets: SUCCESS (0.000s) [110.986907] [090/171] (889s left) kms_addfb_basic (unused-pitches) [111.116393] Starting subtest: unused-pitches [111.117573] Subtest unused-pitches: SUCCESS (0.000s) [111.256566] [091/171] (889s left) kms_busy (basic) [111.414549] Starting subtest: basic [111.416969] Starting dynamic subtest: flip [112.421193] Dynamic subtest flip: SUCCESS (0.994s) [112.434938] Starting dynamic subtest: modeset [116.245446] Dynamic subtest modeset: SUCCESS (3.834s) [116.246607] Subtest basic: SUCCESS (4.830s) [117.217692] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast) [117.685759] Subtest dp-hpd-fast: SKIP (0.000s) [118.578406] [093/171] (882s left) kms_chamelium_edid (dp-edid-read) [119.044692] Subtest dp-edid-read: SKIP (0.000s) [119.918639] [094/171] (880s left) kms_chamelium_frames (dp-crc-fast) [120.387207] Subtest dp-crc-fast: SKIP (0.000s) [121.263862] [095/171] (879s left) kms_chamelium_hpd (hdmi-hpd-fast) [121.730144] Subtest hdmi-hpd-fast: SKIP (0.000s) [122.607679] [096/171] (878s left) kms_chamelium_edid (hdmi-edid-read) [123.074107] Subtest hdmi-edid-read: SKIP (0.000s) [123.950156] [097/171] (876s left) kms_chamelium_frames (hdmi-crc-fast) [124.416018] Subtest hdmi-crc-fast: SKIP (0.000s) [125.293626] [098/171] (875s left) kms_chamelium_hpd (vga-hpd-fast) [125.759725] Subtest vga-hpd-fast: SKIP (0.000s) [126.638405] [099/171] (874s left) kms_chamelium_edid (vga-edid-read) [127.105174] Subtest vga-edid-read: SKIP (0.000s) [127.983821] [100/171] (872s left) kms_prop_blob (basic) [128.103837] Starting subtest: basic [128.105064] Subtest basic: SUCCESS (0.000s) [128.186237] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [128.330473] Starting subtest: basic-busy-flip-before-cursor-atomic [128.332718] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [128.413587] [102/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [128.558210] Starting subtest: basic-busy-flip-before-cursor-legacy [128.560385] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [128.630047] [103/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [128.775360] Starting subtest: basic-flip-after-cursor-atomic [130.046646] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.272s) [130.976135] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [131.121434] Starting subtest: basic-flip-after-cursor-legacy [132.404204] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.283s) [133.343352] [105/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [133.487651] Starting subtest: basic-flip-after-cursor-varying-size [134.771188] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.284s) [135.710989] [106/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [135.861838] Starting subtest: basic-flip-before-cursor-atomic [137.155471] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.294s) [138.078689] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [138.224471] Starting subtest: basic-flip-before-cursor-legacy [139.507966] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.284s) [140.446435] [108/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [140.592988] Starting subtest: basic-flip-before-cursor-varying-size [141.866393] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.272s) [142.815610] [109/171] (858s left) kms_flip (basic-flip-vs-dpms) [142.943300] Starting subtest: basic-flip-vs-dpms [142.946278] Starting dynamic subtest: A-eDP1 [145.822246] Dynamic subtest A-eDP1: SUCCESS (2.876s) [145.837969] Starting dynamic subtest: B-eDP1 [148.190463] Dynamic subtest B-eDP1: SUCCESS (2.366s) [148.205988] Starting dynamic subtest: C-eDP1 [150.546070] Dynamic subtest C-eDP1: SUCCESS (2.355s) [150.547423] Subtest basic-flip-vs-dpms: SUCCESS (7.606s) [151.455325] [110/171] (849s left) kms_flip (basic-flip-vs-modeset) [151.584045] Starting subtest: basic-flip-vs-modeset [151.587094] Starting dynamic subtest: A-eDP1 [154.454477] Dynamic subtest A-eDP1: SUCCESS (2.867s) [154.472013] Starting dynamic subtest: B-eDP1 [156.826148] Dynamic subtest B-eDP1: SUCCESS (2.368s) [156.841135] Starting dynamic subtest: C-eDP1 [159.193731] Dynamic subtest C-eDP1: SUCCESS (2.367s) [159.194806] Subtest basic-flip-vs-modeset: SUCCESS (7.610s) [160.160503] [111/171] (840s left) kms_flip (basic-flip-vs-wf_vblank) [160.297834] Starting subtest: basic-flip-vs-wf_vblank [160.301161] Starting dynamic subtest: A-eDP1 [162.624062] Dynamic subtest A-eDP1: SUCCESS (2.323s) [162.639742] Starting dynamic subtest: B-eDP1 [164.847241] Dynamic subtest B-eDP1: SUCCESS (2.222s) [164.863470] Starting dynamic subtest: C-eDP1 [167.090500] Dynamic subtest C-eDP1: SUCCESS (2.243s) [167.092936] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.796s) [168.361550] [112/171] (832s left) kms_flip (basic-plain-flip) [168.488340] Starting subtest: basic-plain-flip [168.491448] Starting dynamic subtest: A-eDP1 [170.535484] Dynamic subtest A-eDP1: SUCCESS (2.044s) [170.551332] Starting dynamic subtest: B-eDP1 [172.503596] Dynamic subtest B-eDP1: SUCCESS (1.967s) [172.519922] Starting dynamic subtest: C-eDP1 [174.486296] Dynamic subtest C-eDP1: SUCCESS (1.981s) [174.488961] Subtest basic-plain-flip: SUCCESS (6.002s) [175.773636] [113/171] (825s left) kms_force_connector_basic (force-connector-state) [175.900231] Starting subtest: force-connector-state [177.617581] Subtest force-connector-state: SUCCESS (1.719s) [178.225528] [114/171] (822s left) kms_force_connector_basic (force-edid) [178.347918] Starting subtest: force-edid [178.598418] Subtest force-edid: SUCCESS (0.251s) [178.708496] [115/171] (822s left) kms_force_connector_basic (force-load-detect) [178.831588] Starting subtest: force-load-detect [178.833976] Subtest force-load-detect: SKIP (0.000s) [178.941856] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [179.073863] Starting subtest: prune-stale-modes [179.378431] Subtest prune-stale-modes: SUCCESS (0.304s) [179.491741] [117/171] (821s left) kms_frontbuffer_tracking (basic) [179.646331] Starting subtest: basic [182.959245] Subtest basic: SUCCESS (3.314s) [183.076706] [118/171] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [183.229192] Starting subtest: compare-crc-sanitycheck [183.230304] Starting dynamic subtest: pipe-A-eDP-1 [183.907791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s) [183.923907] Starting dynamic subtest: pipe-B-eDP-1 [185.298115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [185.316274] Starting dynamic subtest: pipe-C-eDP-1 [186.835548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.534s) [186.846729] Subtest compare-crc-sanitycheck: SUCCESS (3.607s) [187.801557] [119/171] (813s left) kms_pipe_crc_basic (hang-read-crc) [187.952713] Starting subtest: hang-read-crc [187.954022] Starting dynamic subtest: pipe-A-eDP-1 [190.284828] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.330s) [190.301183] Starting dynamic subtest: pipe-B-eDP-1 [193.259217] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.972s) [193.276932] Starting dynamic subtest: pipe-C-eDP-1 [196.543087] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.281s) [196.544363] Subtest hang-read-crc: SUCCESS (8.591s) [197.466168] [120/171] (803s left) kms_pipe_crc_basic (nonblocking-crc) [197.625891] Starting subtest: nonblocking-crc [197.630456] Starting dynamic subtest: pipe-A-eDP-1 [198.495539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s) [198.511398] Starting dynamic subtest: pipe-B-eDP-1 [200.046663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [200.064739] Starting dynamic subtest: pipe-C-eDP-1 [201.752643] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.702s) [201.753836] Subtest nonblocking-crc: SUCCESS (4.127s) [202.714478] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [202.863665] Starting subtest: nonblocking-crc-frame-sequence [202.866608] Starting dynamic subtest: pipe-A-eDP-1 [203.726751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s) [203.745624] Starting dynamic subtest: pipe-B-eDP-1 [205.279127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [205.296754] Starting dynamic subtest: pipe-C-eDP-1 [206.985141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.703s) [206.986381] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.122s) [207.897937] [122/171] (793s left) kms_pipe_crc_basic (read-crc) [208.048659] Starting subtest: read-crc [208.049977] Starting dynamic subtest: pipe-A-eDP-1 [208.842202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [208.860036] Starting dynamic subtest: pipe-B-eDP-1 [210.346648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s) [210.363072] Starting dynamic subtest: pipe-C-eDP-1 [212.026719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.677s) [212.027864] Subtest read-crc: SUCCESS (3.979s) [212.954212] [123/171] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence) [213.104048] Starting subtest: read-crc-frame-sequence [213.107347] Starting dynamic subtest: pipe-A-eDP-1 [213.898757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [213.914711] Starting dynamic subtest: pipe-B-eDP-1 [215.401801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s) [215.416821] Starting dynamic subtest: pipe-C-eDP-1 [217.034812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.636s) [217.035999] Subtest read-crc-frame-sequence: SUCCESS (3.931s) [217.945169] [124/171] (783s left) kms_psr (primary_page_flip) [218.097980] Starting subtest: primary_page_flip [222.371410] Subtest primary_page_flip: SUCCESS (4.274s) [223.321930] [125/171] (778s left) kms_psr (cursor_plane_move) [223.472854] Starting subtest: cursor_plane_move [227.623969] Subtest cursor_plane_move: SUCCESS (4.151s) [228.570404] [126/171] (772s left) kms_psr (sprite_plane_onoff) [228.721657] Starting subtest: sprite_plane_onoff [232.960172] Subtest sprite_plane_onoff: SUCCESS (4.239s) [233.882645] [127/171] (767s left) kms_psr (primary_mmap_gtt) [234.032263] Starting subtest: primary_mmap_gtt [238.297310] Subtest primary_mmap_gtt: SUCCESS (4.254s) [239.194432] [128/171] (762s left) kms_setmode (basic-clone-single-crtc) [239.316393] Starting subtest: basic-clone-single-crtc [239.319445] Subtest basic-clone-single-crtc: SKIP (0.000s) [239.394608] [129/171] (762s left) i915_pm_backlight (basic-brightness) [239.543969] Starting subtest: basic-brightness [239.645960] Starting dynamic subtest: eDP-1 [240.205573] Dynamic subtest eDP-1: SUCCESS (0.559s) [240.206811] Subtest basic-brightness: SUCCESS (0.663s) [241.121967] [130/171] (760s left) i915_pm_rpm (basic-pci-d3-state) [242.996019] Starting subtest: basic-pci-d3-state [247.419447] Subtest basic-pci-d3-state: SUCCESS (4.418s) [247.614915] [131/171] (754s left) i915_pm_rpm (basic-rte) [247.731818] Starting subtest: basic-rte [253.878509] Subtest basic-rte: SUCCESS (6.146s) [255.361723] [132/171] (746s left) i915_pm_rps (basic-api) [255.489913] Starting subtest: basic-api [255.494481] Subtest basic-api: SUCCESS (0.005s) [255.593819] [133/171] (746s left) prime_self_import (basic-llseek-bad) [255.710282] Starting subtest: basic-llseek-bad [255.713882] Subtest basic-llseek-bad: SUCCESS (0.002s) [255.810187] [134/171] (745s left) prime_self_import (basic-llseek-size) [255.935700] Starting subtest: basic-llseek-size [255.939618] Subtest basic-llseek-size: SUCCESS (0.004s) [256.043617] [135/171] (745s left) prime_self_import (basic-with_fd_dup) [256.160623] Starting subtest: basic-with_fd_dup [256.166480] Subtest basic-with_fd_dup: SUCCESS (0.004s) [256.260436] [136/171] (745s left) prime_self_import (basic-with_one_bo) [256.376268] Starting subtest: basic-with_one_bo [256.383621] Subtest basic-with_one_bo: SUCCESS (0.005s) [256.460958] [137/171] (745s left) prime_self_import (basic-with_one_bo_two_files) [256.577489] Starting subtest: basic-with_one_bo_two_files [256.581141] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [256.676880] [138/171] (745s left) prime_self_import (basic-with_two_bos) [256.803067] Starting subtest: basic-with_two_bos [256.808798] Subtest basic-with_two_bos: SUCCESS (0.004s) [256.894043] [139/171] (744s left) prime_vgem (basic-fence-flip) [257.043630] Starting subtest: basic-fence-flip [257.508044] Subtest basic-fence-flip: SUCCESS (0.464s) [257.644653] [140/171] (744s left) prime_vgem (basic-fence-mmap) [257.783488] Starting subtest: basic-fence-mmap [257.825085] Subtest basic-fence-mmap: SUCCESS (0.041s) [257.935224] [141/171] (743s left) prime_vgem (basic-fence-read) [258.066868] Starting subtest: basic-fence-read [258.133992] Subtest basic-fence-read: SUCCESS (0.067s) [258.215969] [142/171] (743s left) prime_vgem (basic-gtt) [258.350152] Starting subtest: basic-gtt [258.372166] Subtest basic-gtt: SUCCESS (0.022s) [258.482160] [143/171] (743s left) prime_vgem (basic-read) [258.640489] Starting subtest: basic-read [258.674392] Subtest basic-read: SUCCESS (0.034s) [258.781850] [144/171] (743s left) prime_vgem (basic-write) [258.951227] Starting subtest: basic-write [258.989819] Subtest basic-write: SUCCESS (0.040s) [259.081960] [145/171] (742s left) prime_vgem (basic-userptr) [259.222470] Starting subtest: basic-userptr [259.237190] Subtest basic-userptr: SKIP (0.013s) [259.353428] [146/171] (742s left) vgem_basic (setversion) [259.475705] Starting subtest: setversion [259.478254] Subtest setversion: SUCCESS (0.000s) [259.548700] [147/171] (742s left) vgem_basic (create) [259.675916] Starting subtest: create [259.677229] Subtest create: SUCCESS (0.000s) [259.749057] [148/171] (742s left) vgem_basic (debugfs) [259.876121] Starting subtest: debugfs [259.877395] Subtest debugfs: SUCCESS (0.001s) [259.949028] [149/171] (742s left) vgem_basic (dmabuf-export) [260.076097] Starting subtest: dmabuf-export [260.093463] Subtest dmabuf-export: SUCCESS (0.016s) [260.196364] [150/171] (741s left) vgem_basic (dmabuf-fence) [260.327570] Starting subtest: dmabuf-fence [260.328776] Subtest dmabuf-fence: SUCCESS (0.001s) [260.394504] [151/171] (741s left) vgem_basic (dmabuf-fence-before) [260.527684] Starting subtest: dmabuf-fence-before [260.528802] Subtest dmabuf-fence-before: SUCCESS (0.000s) [260.594435] [152/171] (741s left) vgem_basic (dmabuf-mmap) [260.727562] Starting subtest: dmabuf-mmap [260.752485] Subtest dmabuf-mmap: SUCCESS (0.026s) [260.828041] [153/171] (741s left) vgem_basic (mmap) [260.960736] Starting subtest: mmap [260.976329] Subtest mmap: SUCCESS (0.016s) [261.044424] [154/171] (741s left) vgem_basic (second-client) [261.195108] Starting subtest: second-client [261.249617] Subtest second-client: SUCCESS (0.049s) [261.311861] [155/171] (740s left) vgem_basic (sysfs) [261.444530] Starting subtest: sysfs [261.445634] Subtest sysfs: SUCCESS (0.001s) [261.511344] [156/171] (740s left) core_hotunplug (unbind-rebind) [261.677735] Starting subtest: unbind-rebind [264.041520] Subtest unbind-rebind: SUCCESS (2.365s) [264.075376] [157/171] (738s left) vgem_basic (unload) [264.200584] Starting subtest: unload [293.050375] Subtest unload: SUCCESS (28.816s) [293.162748] [158/171] (709s left) i915_module_load (reload) [293.280935] Starting subtest: reload [296.486962] Subtest reload: SUCCESS (3.204s) [296.512694] [159/171] (705s left) gem_lmem_swapping (basic) [296.652558] Subtest basic: SKIP (0.000s) [296.701180] [160/171] (705s left) gem_lmem_swapping (parallel-random-engines) [296.835560] Subtest parallel-random-engines: SKIP (0.000s) [296.884594] [161/171] (705s left) gem_lmem_swapping (random-engines) [297.008907] Subtest random-engines: SKIP (0.000s) [297.051489] [162/171] (705s left) gem_lmem_swapping (verify-random) [297.185755] Subtest verify-random: SKIP (0.000s) [297.235326] [163/171] (705s left) i915_pm_rpm (module-reload) [309.737206] Starting subtest: module-reload [344.017663] Subtest module-reload: SUCCESS (34.274s) [344.037553] [164/171] (658s left) i915_selftest (live) [344.167565] Starting subtest: live [344.168853] Starting dynamic subtest: sanitycheck [345.999721] Dynamic subtest sanitycheck: SUCCESS (1.823s) [346.013797] Starting dynamic subtest: uncore [347.795406] Dynamic subtest uncore: SUCCESS (1.795s) [347.809400] Starting dynamic subtest: workarounds [349.803520] Dynamic subtest workarounds: SUCCESS (2.007s) [349.817537] Starting dynamic subtest: gt_engines [352.032575] Dynamic subtest gt_engines: SUCCESS (2.228s) [352.046575] Starting dynamic subtest: gt_timelines [364.139390] Dynamic subtest gt_timelines: SUCCESS (12.106s) [364.153497] Starting dynamic subtest: gt_contexts [366.043554] Dynamic subtest gt_contexts: SUCCESS (1.903s) [366.057675] Starting dynamic subtest: gt_lrc [370.346319] Dynamic subtest gt_lrc: SUCCESS (4.302s) [370.360537] Starting dynamic subtest: gt_mocs [372.181640] Dynamic subtest gt_mocs: SUCCESS (1.834s) [372.195764] Starting dynamic subtest: gt_pm [377.223609] Dynamic subtest gt_pm: SUCCESS (5.041s) [377.237811] Starting dynamic subtest: gt_heartbeat [379.110511] Dynamic subtest gt_heartbeat: SUCCESS (1.886s) [379.124777] Starting dynamic subtest: requests [386.642685] Dynamic subtest requests: SUCCESS (7.531s) [386.656993] Starting dynamic subtest: migrate [391.179489] Dynamic subtest migrate: SUCCESS (4.536s) [391.193690] Starting dynamic subtest: active [392.995546] Dynamic subtest active: SUCCESS (1.815s) [393.009771] Starting dynamic subtest: objects [396.371559] Dynamic subtest objects: SUCCESS (3.375s) [396.385811] Starting dynamic subtest: mman [403.216635] Dynamic subtest mman: SUCCESS (6.844s) [403.231050] Starting dynamic subtest: dmabuf [405.036400] Dynamic subtest dmabuf: SUCCESS (1.819s) [405.050631] Starting dynamic subtest: vma [406.803485] Dynamic subtest vma: SUCCESS (1.766s) [406.817923] Starting dynamic subtest: coherency [411.231402] Dynamic subtest coherency: SUCCESS (4.431s) [411.245509] Starting dynamic subtest: gtt [422.441539] Dynamic subtest gtt: SUCCESS (11.205s) [422.455926] Starting dynamic subtest: gem [424.356502] Dynamic subtest gem: SUCCESS (1.914s) [424.371034] Starting dynamic subtest: evict [428.000515] Dynamic subtest evict: SUCCESS (3.643s) [428.015070] Starting dynamic subtest: hugepages [434.842344] Dynamic subtest hugepages: SUCCESS (6.841s) [434.857055] Starting dynamic subtest: gem_contexts [449.803574] Dynamic subtest gem_contexts: SUCCESS (14.960s) [449.818319] Starting dynamic subtest: client [451.614470] Dynamic subtest client: SUCCESS (1.810s) [451.629278] Starting dynamic subtest: gem_migrate [453.347539] Dynamic subtest gem_migrate: SUCCESS (1.732s) [453.362416] Starting dynamic subtest: reset [458.702475] Dynamic subtest reset: SUCCESS (5.354s) [458.717468] Starting dynamic subtest: memory_region [460.442434] Dynamic subtest memory_region: SUCCESS (1.739s) [460.457348] Starting dynamic subtest: hangcheck [484.805240] Dynamic subtest hangcheck: SUCCESS (24.362s) [484.819994] Starting dynamic subtest: execlists [494.807666] Dynamic subtest execlists: SUCCESS (10.001s) [494.822493] Starting dynamic subtest: ring_submission [496.592624] Dynamic subtest ring_submission: SUCCESS (1.784s) [496.607437] Starting dynamic subtest: perf [498.465622] Dynamic subtest perf: SUCCESS (1.872s) [498.480508] Starting dynamic subtest: slpc [500.254520] Dynamic subtest slpc: SUCCESS (1.788s) [500.269401] Starting dynamic subtest: guc [502.037466] Dynamic subtest guc: SUCCESS (1.782s) [502.052385] Starting dynamic subtest: guc_multi_lrc [503.772472] Dynamic subtest guc_multi_lrc: SUCCESS (1.734s) [503.787398] Starting dynamic subtest: guc_hang [505.555534] Dynamic subtest guc_hang: SUCCESS (1.782s) [505.570448] Starting dynamic subtest: late_gt_pm [507.343499] Dynamic subtest late_gt_pm: SUCCESS (1.787s) [507.344865] Subtest live: SUCCESS (163.167s) [507.428774] [165/171] (495s left) dmabuf (all-tests) [507.555992] Starting subtest: all-tests [507.558021] Starting dynamic subtest: sanitycheck [507.586856] Dynamic subtest sanitycheck: SUCCESS (0.030s) [507.598910] Starting dynamic subtest: dma_fence [507.725862] Dynamic subtest dma_fence: SUCCESS (0.138s) [507.737410] Starting dynamic subtest: dma_fence_chain [525.352219] Dynamic subtest dma_fence_chain: SUCCESS (17.617s) [525.365193] Starting dynamic subtest: dma_fence_unwrap [525.368483] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [525.380869] Starting dynamic subtest: dma_resv [525.392655] Dynamic subtest dma_resv: SUCCESS (0.023s) [525.394073] Subtest all-tests: SUCCESS (17.837s) [525.417072] [166/171] (477s left) i915_suspend (basic-s2idle-without-i915) [525.533502] Starting subtest: basic-s2idle-without-i915 [548.426264] Subtest basic-s2idle-without-i915: SUCCESS (7.973s) [548.722674] [167/171] (468s left) i915_suspend (basic-s3-without-i915) [548.852662] Starting subtest: basic-s3-without-i915 [571.630098] Subtest basic-s3-without-i915: SUCCESS (7.017s) [571.941674] [168/171] (461s left) gem_exec_suspend (basic-s0) [572.087381] Starting subtest: basic-S0 [572.088595] Starting dynamic subtest: smem [591.465015] Dynamic subtest smem: SUCCESS (3.586s) [591.466021] Subtest basic-S0: SUCCESS (3.587s) [591.618227] [169/171] (457s left) gem_exec_suspend (basic-s3) [591.751314] Starting subtest: basic-S3 [591.752483] Starting dynamic subtest: smem [610.487173] Dynamic subtest smem: SUCCESS (3.510s) [610.488228] Subtest basic-S3: SUCCESS (3.511s) [610.628521] [170/171] (453s left) kms_chamelium_hpd (common-hpd-after-suspend) [611.108847] Subtest common-hpd-after-suspend: SKIP (0.000s) [612.016323] [171/171] (452s left) kms_pipe_crc_basic (suspend-read-crc) [612.166615] Starting subtest: suspend-read-crc [612.170130] Starting dynamic subtest: pipe-A-eDP-1 [629.510540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.450s) [629.530082] Starting dynamic subtest: pipe-B-eDP-1 [647.449071] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.066s) [647.468220] Starting dynamic subtest: pipe-C-eDP-1 [666.451730] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.215s) [666.453154] Subtest suspend-read-crc: SUCCESS (8.740s) [667.347977] Closing watchdogs Done.