[37.036945] Initializing watchdogs [37.037155] /dev/watchdog0 [37.047716] [001/171] (960s left) i915_module_load (load) [37.194945] Starting subtest: load [39.875212] Subtest load: SUCCESS (2.680s) [39.904452] [002/171] (957s left) core_auth (basic-auth) [40.043541] Starting subtest: basic-auth [40.044683] Subtest basic-auth: SUCCESS (0.001s) [40.127156] [003/171] (957s left) debugfs_test (read_all_entries) [40.269787] Starting subtest: read_all_entries [40.343756] Subtest read_all_entries: SUCCESS (0.073s) [40.457677] [004/171] (957s left) debugfs_test (basic-hwmon) [40.598702] Starting subtest: basic-hwmon [40.600712] Subtest basic-hwmon: SKIP (0.000s) [40.729244] [005/171] (956s left) fbdev (eof) [40.909530] Starting subtest: eof [40.912046] Subtest eof: SUCCESS (0.000s) [40.974632] [006/171] (956s left) fbdev (info) [41.108676] Starting subtest: info [41.109875] Subtest info: SUCCESS (0.000s) [41.193342] [007/171] (956s left) fbdev (nullptr) [41.342780] Starting subtest: nullptr [41.344106] Subtest nullptr: SUCCESS (0.000s) [41.408963] [008/171] (956s left) fbdev (read) [41.559585] Starting subtest: read [48.669971] Subtest read: SUCCESS (7.076s) [48.707843] [009/171] (949s left) fbdev (write) [48.860628] Starting subtest: write [52.643365] Subtest write: SUCCESS (3.748s) [52.691876] [010/171] (945s left) gem_basic (bad-close) [52.820753] Starting subtest: bad-close [52.823169] Subtest bad-close: SUCCESS (0.000s) [52.908013] [011/171] (944s left) gem_basic (create-close) [53.044564] Starting subtest: create-close [53.046772] Subtest create-close: SUCCESS (0.000s) [53.140641] [012/171] (944s left) gem_basic (create-fd-close) [53.276521] Starting subtest: create-fd-close [53.278513] Subtest create-fd-close: SUCCESS (0.000s) [53.375962] [013/171] (944s left) gem_busy (busy@all-engines) [53.531798] Starting subtest: busy [53.532877] Starting dynamic subtest: all-engines [53.601794] Dynamic subtest all-engines: SUCCESS (0.071s) [53.602927] Subtest busy: SUCCESS (0.071s) [53.992560] [014/171] (943s left) gem_close_race (basic-process) [54.149275] Starting subtest: basic-process [54.218117] Subtest basic-process: SUCCESS (0.068s) [54.426096] [015/171] (943s left) gem_close_race (basic-threads) [54.582817] Starting subtest: basic-threads [55.765041] Subtest basic-threads: SUCCESS (1.181s) [55.979148] [016/171] (941s left) gem_ctx_create (basic) [56.135382] Starting subtest: basic [56.136585] Subtest basic: SUCCESS (0.000s) [56.343487] [017/171] (941s left) gem_ctx_create (basic-files) [56.494568] Starting subtest: basic-files [58.520280] Subtest basic-files: SUCCESS (2.026s) [58.775997] [018/171] (939s left) gem_ctx_exec (basic) [58.923604] Starting subtest: basic [58.928548] Subtest basic: SUCCESS (0.005s) [59.042028] [019/171] (938s left) gem_exec_basic (basic) [59.188633] Starting subtest: basic [59.189790] Starting dynamic subtest: rcs0-smem [59.190948] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [59.202446] Starting dynamic subtest: bcs0-smem [59.203623] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [59.214309] Starting dynamic subtest: vcs0-smem [59.215460] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.225945] Starting dynamic subtest: vecs0-smem [59.227331] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [59.228647] Subtest basic: SUCCESS (0.006s) [59.392589] [020/171] (938s left) gem_exec_create (basic) [59.537275] Starting subtest: basic [59.538615] Starting dynamic subtest: smem [61.598423] Dynamic subtest smem: SUCCESS (2.038s) [61.599869] Subtest basic: SUCCESS (2.038s) [61.794624] [021/171] (936s left) gem_exec_fence (basic-busy) [62.106423] Starting subtest: basic-busy [62.107939] Starting dynamic subtest: rcs0 [62.128913] Dynamic subtest rcs0: SUCCESS (0.029s) [62.141165] Starting dynamic subtest: bcs0 [62.143402] Dynamic subtest bcs0: SUCCESS (0.015s) [62.155082] Starting dynamic subtest: vcs0 [62.170146] Dynamic subtest vcs0: SUCCESS (0.026s) [62.181428] Starting dynamic subtest: vecs0 [62.191384] Dynamic subtest vecs0: SUCCESS (0.021s) [62.192490] Subtest basic-busy: SUCCESS (0.092s) [62.795703] [022/171] (935s left) gem_exec_fence (basic-wait) [63.094619] Starting subtest: basic-wait [63.095930] Starting dynamic subtest: rcs0 [63.128733] Dynamic subtest rcs0: SUCCESS (0.042s) [63.145557] Starting dynamic subtest: bcs0 [63.160571] Dynamic subtest bcs0: SUCCESS (0.032s) [63.173558] Starting dynamic subtest: vcs0 [63.191125] Dynamic subtest vcs0: SUCCESS (0.030s) [63.203155] Starting dynamic subtest: vecs0 [63.223334] Dynamic subtest vecs0: SUCCESS (0.032s) [63.225763] Subtest basic-wait: SUCCESS (0.137s) [63.761581] [023/171] (934s left) gem_exec_fence (basic-await) [64.052489] Starting subtest: basic-await [64.053640] Starting dynamic subtest: rcs0 [64.143517] Dynamic subtest rcs0: SUCCESS (0.098s) [64.174075] Starting dynamic subtest: bcs0 [64.285514] Dynamic subtest bcs0: SUCCESS (0.133s) [64.312602] Starting dynamic subtest: vcs0 [64.404953] Dynamic subtest vcs0: SUCCESS (0.127s) [64.433502] Starting dynamic subtest: vecs0 [64.525209] Dynamic subtest vecs0: SUCCESS (0.119s) [64.527169] Subtest basic-await: SUCCESS (0.481s) [65.110954] [024/171] (933s left) gem_exec_fence (nb-await) [65.401427] Starting subtest: nb-await [65.402526] Starting dynamic subtest: rcs0 [65.460382] Dynamic subtest rcs0: SUCCESS (0.066s) [65.476939] Starting dynamic subtest: bcs0 [65.528493] Dynamic subtest bcs0: SUCCESS (0.068s) [65.557509] Starting dynamic subtest: vcs0 [65.607291] Dynamic subtest vcs0: SUCCESS (0.077s) [65.635925] Starting dynamic subtest: vecs0 [65.682543] Dynamic subtest vecs0: SUCCESS (0.076s) [65.684620] Subtest nb-await: SUCCESS (0.289s) [66.228137] [025/171] (931s left) gem_exec_gttfill (basic) [66.382578] Starting subtest: basic [73.782411] Subtest basic: SUCCESS (7.391s) [73.965041] [026/171] (924s left) gem_exec_parallel (engines) [74.180469] Starting subtest: engines [74.181567] Starting dynamic subtest: basic [76.682627] Dynamic subtest basic: SUCCESS (2.484s) [76.708052] Starting dynamic subtest: contexts [80.076932] Dynamic subtest contexts: SUCCESS (3.403s) [80.090835] Starting dynamic subtest: fds [84.236305] Dynamic subtest fds: SUCCESS (4.168s) [84.261646] Starting dynamic subtest: userptr [86.776789] Dynamic subtest userptr: SUCCESS (2.515s) [86.778685] Subtest engines: SUCCESS (12.571s) [86.977118] [027/171] (911s left) gem_exec_store (basic) [87.140119] Starting subtest: basic [87.197797] Subtest basic: SUCCESS (0.059s) [87.397753] [028/171] (910s left) gem_flink_basic (bad-flink) [87.532671] Starting subtest: bad-flink [87.533786] Subtest bad-flink: SUCCESS (0.000s) [87.611598] [029/171] (910s left) gem_flink_basic (bad-open) [87.750531] Starting subtest: bad-open [87.751722] Subtest bad-open: SUCCESS (0.000s) [87.828088] [030/171] (910s left) gem_flink_basic (basic) [87.957567] Starting subtest: basic [87.958725] Subtest basic: SUCCESS (0.000s) [88.061764] [031/171] (910s left) gem_flink_basic (double-flink) [88.199671] Starting subtest: double-flink [88.200782] Subtest double-flink: SUCCESS (0.000s) [88.295609] [032/171] (910s left) gem_flink_basic (flink-lifetime) [88.423667] Starting subtest: flink-lifetime [88.426248] Subtest flink-lifetime: SUCCESS (0.002s) [88.544857] [033/171] (909s left) gem_huc_copy (huc-copy) [88.687839] Starting subtest: huc-copy [88.690179] Subtest huc-copy: SKIP (0.000s) [88.794634] [034/171] (909s left) gem_linear_blits (basic) [89.068375] Starting subtest: basic [89.082728] Subtest basic: SUCCESS (0.015s) [89.211471] [035/171] (909s left) gem_mmap (basic) [89.409348] Starting subtest: basic [89.414125] Subtest basic: SUCCESS (0.001s) [89.512044] [036/171] (908s left) gem_mmap_gtt (basic) [89.654364] Starting subtest: basic [89.655477] Subtest basic: SUCCESS (0.001s) [89.744294] [037/171] (908s left) gem_render_linear_blits (basic) [89.886843] Starting subtest: basic [89.936513] Subtest basic: SUCCESS (0.049s) [90.017499] [038/171] (908s left) gem_render_tiled_blits (basic) [90.160807] Starting subtest: basic [90.222547] Subtest basic: SUCCESS (0.061s) [90.297660] [039/171] (908s left) gem_ringfill (basic-all) [90.581489] Starting subtest: basic-all [91.805495] Subtest basic-all: SUCCESS (1.216s) [91.881512] [040/171] (906s left) gem_softpin (allocator-basic) [92.026498] Starting subtest: allocator-basic [92.193822] Subtest allocator-basic: SUCCESS (0.159s) [92.297302] [041/171] (906s left) gem_softpin (allocator-basic-reserve) [92.450934] Starting subtest: allocator-basic-reserve [92.621837] Subtest allocator-basic-reserve: SUCCESS (0.162s) [92.731198] [042/171] (905s left) gem_softpin (safe-alignment) [92.882443] Starting subtest: safe-alignment [92.898537] Subtest safe-alignment: SUCCESS (0.017s) [93.029119] [043/171] (905s left) gem_sync (basic-all) [93.176648] Starting subtest: basic-all [95.371773] Subtest basic-all: SUCCESS (2.172s) [95.562311] [044/171] (903s left) gem_sync (basic-each) [95.715477] Starting subtest: basic-each [97.971374] Subtest basic-each: SUCCESS (2.255s) [98.187567] [045/171] (900s left) gem_tiled_blits (basic) [98.463604] Starting subtest: basic [98.491747] Subtest basic: SUCCESS (0.028s) [98.628195] [046/171] (900s left) gem_tiled_fence_blits (basic) [98.974162] Starting subtest: basic [99.001215] Subtest basic: SUCCESS (0.027s) [99.124630] [047/171] (899s left) gem_tiled_pread_basic [99.664637] [048/171] (899s left) gem_wait (busy@all-engines) [99.829528] Starting subtest: busy [99.830737] Starting dynamic subtest: all-engines [100.373882] Dynamic subtest all-engines: SUCCESS (0.544s) [100.375097] Subtest busy: SUCCESS (0.544s) [100.615361] [049/171] (898s left) gem_wait (wait@all-engines) [100.778279] Starting subtest: wait [100.779418] Starting dynamic subtest: all-engines [101.818463] Dynamic subtest all-engines: SUCCESS (1.039s) [101.820260] Subtest wait: SUCCESS (1.039s) [102.065308] [050/171] (896s left) i915_getparams_basic (basic-eu-total) [102.201439] Starting subtest: basic-eu-total [102.203599] Subtest basic-eu-total: SUCCESS (0.000s) [102.278865] [051/171] (896s left) i915_getparams_basic (basic-subslice-total) [102.415442] Starting subtest: basic-subslice-total [102.417879] Subtest basic-subslice-total: SUCCESS (0.000s) [102.495049] [052/171] (896s left) i915_hangman (error-state-basic) [102.647346] Starting subtest: error-state-basic [102.661353] Subtest error-state-basic: SUCCESS (0.013s) [102.746037] [053/171] (896s left) i915_pciid [102.978778] [054/171] (895s left) kms_addfb_basic (addfb25-bad-modifier) [103.133857] Starting subtest: addfb25-bad-modifier [103.135112] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [103.261506] [055/171] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [103.399194] Starting subtest: addfb25-framebuffer-vs-set-tiling [103.400237] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [103.528511] [056/171] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [103.657647] Starting subtest: addfb25-modifier-no-flag [103.658773] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [103.778323] [057/171] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [103.915955] Starting subtest: addfb25-x-tiled-legacy [103.917072] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [104.045306] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [104.183487] Starting subtest: addfb25-x-tiled-mismatch-legacy [104.184662] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [104.313330] [059/171] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [104.483068] Starting subtest: addfb25-yf-tiled-legacy [104.484154] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [104.577844] [060/171] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [104.744409] Starting subtest: addfb25-y-tiled-legacy [104.745537] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [104.845077] [061/171] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.012664] Starting subtest: addfb25-y-tiled-small-legacy [105.013790] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [105.111367] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [105.248808] Starting subtest: bad-pitch-0 [105.250045] Subtest bad-pitch-0: SUCCESS (0.000s) [105.377965] [063/171] (893s left) kms_addfb_basic (bad-pitch-1024) [105.514627] Starting subtest: bad-pitch-1024 [105.515823] Subtest bad-pitch-1024: SUCCESS (0.000s) [105.645336] [064/171] (893s left) kms_addfb_basic (bad-pitch-128) [105.783380] Starting subtest: bad-pitch-128 [105.784455] Subtest bad-pitch-128: SUCCESS (0.000s) [105.912197] [065/171] (893s left) kms_addfb_basic (bad-pitch-256) [106.049773] Starting subtest: bad-pitch-256 [106.050961] Subtest bad-pitch-256: SUCCESS (0.000s) [106.178501] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [106.316788] Starting subtest: bad-pitch-32 [106.317822] Subtest bad-pitch-32: SUCCESS (0.000s) [106.445077] [067/171] (892s left) kms_addfb_basic (bad-pitch-63) [106.583566] Starting subtest: bad-pitch-63 [106.584620] Subtest bad-pitch-63: SUCCESS (0.000s) [106.711135] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536) [106.847793] Starting subtest: bad-pitch-65536 [106.849093] Subtest bad-pitch-65536: SUCCESS (0.000s) [106.978484] [069/171] (892s left) kms_addfb_basic (bad-pitch-999) [107.108929] Starting subtest: bad-pitch-999 [107.110499] Subtest bad-pitch-999: SUCCESS (0.000s) [107.228372] [070/171] (892s left) kms_addfb_basic (basic) [107.385785] Starting subtest: basic [107.386875] Subtest basic: SUCCESS (0.000s) [107.511994] [071/171] (891s left) kms_addfb_basic (basic-x-tiled-legacy) [107.662975] Starting subtest: basic-x-tiled-legacy [107.664060] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [107.778194] [072/171] (891s left) kms_addfb_basic (basic-y-tiled-legacy) [107.929229] Starting subtest: basic-y-tiled-legacy [107.930329] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.061644] [073/171] (891s left) kms_addfb_basic (bo-too-small) [108.241849] Starting subtest: bo-too-small [108.243103] Subtest bo-too-small: SUCCESS (0.000s) [108.345158] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [108.501951] Starting subtest: bo-too-small-due-to-tiling [108.503306] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [108.594482] [075/171] (890s left) kms_addfb_basic (clobberred-modifier) [108.743614] Starting subtest: clobberred-modifier [108.744678] Subtest clobberred-modifier: SUCCESS (0.000s) [108.877929] [076/171] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.033481] Starting subtest: framebuffer-vs-set-tiling [109.034605] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.161522] [077/171] (890s left) kms_addfb_basic (invalid-get-prop) [109.312898] Starting subtest: invalid-get-prop [109.314032] Subtest invalid-get-prop: SUCCESS (0.000s) [109.444797] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [109.601131] Starting subtest: invalid-get-prop-any [109.602473] Subtest invalid-get-prop-any: SUCCESS (0.000s) [109.727871] [079/171] (889s left) kms_addfb_basic (invalid-set-prop) [109.882870] Starting subtest: invalid-set-prop [109.884430] Subtest invalid-set-prop: SUCCESS (0.000s) [110.012655] [080/171] (889s left) kms_addfb_basic (invalid-set-prop-any) [110.164956] Starting subtest: invalid-set-prop-any [110.166150] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.295681] [081/171] (889s left) kms_addfb_basic (no-handle) [110.447330] Starting subtest: no-handle [110.448443] Subtest no-handle: SUCCESS (0.000s) [110.578107] [082/171] (889s left) kms_addfb_basic (size-max) [110.760298] Starting subtest: size-max [110.761381] Subtest size-max: SUCCESS (0.000s) [110.845249] [083/171] (888s left) kms_addfb_basic (small-bo) [111.030678] Starting subtest: small-bo [111.031794] Subtest small-bo: SUCCESS (0.000s) [111.127884] [084/171] (888s left) kms_addfb_basic (tile-pitch-mismatch) [111.291270] Starting subtest: tile-pitch-mismatch [111.292630] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [111.411940] [085/171] (888s left) kms_addfb_basic (too-high) [111.593561] Starting subtest: too-high [111.594648] Subtest too-high: SUCCESS (0.001s) [111.694781] [086/171] (888s left) kms_addfb_basic (too-wide) [111.853637] Starting subtest: too-wide [111.854756] Subtest too-wide: SUCCESS (0.000s) [111.961814] [087/171] (887s left) kms_addfb_basic (unused-handle) [112.115816] Starting subtest: unused-handle [112.117213] Subtest unused-handle: SUCCESS (0.000s) [112.245257] [088/171] (887s left) kms_addfb_basic (unused-modifier) [112.397881] Starting subtest: unused-modifier [112.399019] Subtest unused-modifier: SUCCESS (0.000s) [112.528012] [089/171] (887s left) kms_addfb_basic (unused-offsets) [112.675855] Starting subtest: unused-offsets [112.677311] Subtest unused-offsets: SUCCESS (0.000s) [112.813580] [090/171] (887s left) kms_addfb_basic (unused-pitches) [112.940551] Starting subtest: unused-pitches [112.941854] Subtest unused-pitches: SUCCESS (0.000s) [113.078997] [091/171] (886s left) kms_busy (basic) [113.242608] Starting subtest: basic [113.245192] Starting dynamic subtest: flip [114.228243] Dynamic subtest flip: SUCCESS (0.984s) [114.245941] Starting dynamic subtest: modeset [118.063465] Dynamic subtest modeset: SUCCESS (3.835s) [118.064776] Subtest basic: SUCCESS (4.822s) [119.037512] [092/171] (880s left) kms_chamelium_hpd (dp-hpd-fast) [119.524319] Subtest dp-hpd-fast: SKIP (0.000s) [120.392094] [093/171] (879s left) kms_chamelium_edid (dp-edid-read) [120.871108] Subtest dp-edid-read: SKIP (0.000s) [121.740571] [094/171] (878s left) kms_chamelium_frames (dp-crc-fast) [122.204280] Subtest dp-crc-fast: SKIP (0.000s) [123.085186] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [123.552136] Subtest hdmi-hpd-fast: SKIP (0.000s) [124.425218] [096/171] (875s left) kms_chamelium_edid (hdmi-edid-read) [124.907983] Subtest hdmi-edid-read: SKIP (0.000s) [125.770800] [097/171] (874s left) kms_chamelium_frames (hdmi-crc-fast) [126.248021] Subtest hdmi-crc-fast: SKIP (0.000s) [127.111957] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [127.579662] Subtest vga-hpd-fast: SKIP (0.000s) [128.455244] [099/171] (871s left) kms_chamelium_edid (vga-edid-read) [128.936742] Subtest vga-edid-read: SKIP (0.000s) [129.801799] [100/171] (870s left) kms_prop_blob (basic) [129.941781] Starting subtest: basic [129.943017] Subtest basic: SUCCESS (0.000s) [130.021152] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [130.188364] Starting subtest: basic-busy-flip-before-cursor-atomic [130.190387] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.265664] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [130.429451] Starting subtest: basic-busy-flip-before-cursor-legacy [130.431579] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [130.526736] [103/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [130.692131] Starting subtest: basic-flip-after-cursor-atomic [131.981498] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.284s) [132.923750] [104/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [133.087461] Starting subtest: basic-flip-after-cursor-legacy [134.366790] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.279s) [135.292417] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [135.456479] Starting subtest: basic-flip-after-cursor-varying-size [136.748179] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.292s) [137.722495] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.887903] Starting subtest: basic-flip-before-cursor-atomic [139.181954] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.294s) [140.155508] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [140.322129] Starting subtest: basic-flip-before-cursor-legacy [141.613528] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.292s) [142.590799] [108/171] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [142.756653] Starting subtest: basic-flip-before-cursor-varying-size [144.051174] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.293s) [145.018942] [109/171] (855s left) kms_flip (basic-flip-vs-dpms) [145.170295] Starting subtest: basic-flip-vs-dpms [145.173376] Starting dynamic subtest: A-eDP1 [148.023887] Dynamic subtest A-eDP1: SUCCESS (2.850s) [148.041345] Starting dynamic subtest: B-eDP1 [150.390030] Dynamic subtest B-eDP1: SUCCESS (2.364s) [150.416403] Starting dynamic subtest: C-eDP1 [152.760214] Dynamic subtest C-eDP1: SUCCESS (2.367s) [152.761326] Subtest basic-flip-vs-dpms: SUCCESS (7.592s) [153.723829] [110/171] (846s left) kms_flip (basic-flip-vs-modeset) [153.869903] Starting subtest: basic-flip-vs-modeset [153.873021] Starting dynamic subtest: A-eDP1 [156.718190] Dynamic subtest A-eDP1: SUCCESS (2.845s) [156.735467] Starting dynamic subtest: B-eDP1 [159.076375] Dynamic subtest B-eDP1: SUCCESS (2.353s) [159.092702] Starting dynamic subtest: C-eDP1 [161.459395] Dynamic subtest C-eDP1: SUCCESS (2.386s) [161.462227] Subtest basic-flip-vs-modeset: SUCCESS (7.593s) [162.429336] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [162.576242] Starting subtest: basic-flip-vs-wf_vblank [162.579287] Starting dynamic subtest: A-eDP1 [164.891252] Dynamic subtest A-eDP1: SUCCESS (2.312s) [164.908700] Starting dynamic subtest: B-eDP1 [167.178282] Dynamic subtest B-eDP1: SUCCESS (2.286s) [167.195599] Starting dynamic subtest: C-eDP1 [169.444356] Dynamic subtest C-eDP1: SUCCESS (2.265s) [169.447471] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.873s) [170.749401] [112/171] (829s left) kms_flip (basic-plain-flip) [170.895212] Starting subtest: basic-plain-flip [170.898567] Starting dynamic subtest: A-eDP1 [172.928917] Dynamic subtest A-eDP1: SUCCESS (2.030s) [172.946291] Starting dynamic subtest: B-eDP1 [174.893294] Dynamic subtest B-eDP1: SUCCESS (1.963s) [174.910820] Starting dynamic subtest: C-eDP1 [176.878259] Dynamic subtest C-eDP1: SUCCESS (1.984s) [176.882835] Subtest basic-plain-flip: SUCCESS (5.987s) [178.170910] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [178.314229] Starting subtest: force-connector-state [180.006760] Subtest force-connector-state: SUCCESS (1.692s) [180.648767] [114/171] (820s left) kms_force_connector_basic (force-edid) [180.797166] Starting subtest: force-edid [181.049633] Subtest force-edid: SUCCESS (0.254s) [181.179987] [115/171] (819s left) kms_force_connector_basic (force-load-detect) [181.321387] Starting subtest: force-load-detect [181.323658] Subtest force-load-detect: SKIP (0.000s) [181.429890] [116/171] (819s left) kms_force_connector_basic (prune-stale-modes) [181.570160] Starting subtest: prune-stale-modes [181.877317] Subtest prune-stale-modes: SUCCESS (0.306s) [181.996525] [117/171] (818s left) kms_frontbuffer_tracking (basic) [182.163198] Starting subtest: basic [185.461566] Subtest basic: SUCCESS (3.297s) [185.564632] [118/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [185.736078] Starting subtest: compare-crc-sanitycheck-xr24 [185.737318] Starting dynamic subtest: pipe-A-eDP-1 [186.424249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [186.445853] Starting dynamic subtest: pipe-B-eDP-1 [187.806144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s) [187.826375] Starting dynamic subtest: pipe-C-eDP-1 [189.352482] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [189.353769] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.608s) [190.261301] [119/171] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [190.421426] Starting subtest: compare-crc-sanitycheck-nv12 [190.424519] Starting dynamic subtest: pipe-A-eDP-1 [191.334047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.910s) [191.354984] Starting dynamic subtest: pipe-B-eDP-1 [192.799973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s) [192.824308] Starting dynamic subtest: pipe-C-eDP-1 [194.561214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.756s) [194.562353] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.141s) [195.512313] [120/171] (805s left) kms_pipe_crc_basic (hang-read-crc) [195.681718] Starting subtest: hang-read-crc [195.683695] Starting dynamic subtest: pipe-A-eDP-1 [198.004191] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.320s) [198.025359] Starting dynamic subtest: pipe-B-eDP-1 [200.980953] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s) [201.001220] Starting dynamic subtest: pipe-C-eDP-1 [204.288289] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.302s) [204.289439] Subtest hang-read-crc: SUCCESS (8.607s) [205.237636] [121/171] (795s left) kms_pipe_crc_basic (nonblocking-crc) [205.401165] Starting subtest: nonblocking-crc [205.402953] Starting dynamic subtest: pipe-A-eDP-1 [206.263399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s) [206.283531] Starting dynamic subtest: pipe-B-eDP-1 [207.815737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s) [207.835853] Starting dynamic subtest: pipe-C-eDP-1 [209.531332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.710s) [209.532456] Subtest nonblocking-crc: SUCCESS (4.131s) [210.485930] [122/171] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [210.653787] Starting subtest: nonblocking-crc-frame-sequence [210.659247] Starting dynamic subtest: pipe-A-eDP-1 [211.510760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [211.534174] Starting dynamic subtest: pipe-B-eDP-1 [213.062646] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [213.083160] Starting dynamic subtest: pipe-C-eDP-1 [214.799342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.730s) [214.800445] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.145s) [215.734969] [123/171] (785s left) kms_pipe_crc_basic (read-crc) [215.907435] Starting subtest: read-crc [215.909599] Starting dynamic subtest: pipe-A-eDP-1 [216.709148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s) [216.730292] Starting dynamic subtest: pipe-B-eDP-1 [218.220990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.506s) [218.241535] Starting dynamic subtest: pipe-C-eDP-1 [219.861771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.634s) [219.862925] Subtest read-crc: SUCCESS (3.954s) [220.789977] [124/171] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [220.949691] Starting subtest: read-crc-frame-sequence [220.952771] Starting dynamic subtest: pipe-A-eDP-1 [221.747515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [221.768381] Starting dynamic subtest: pipe-B-eDP-1 [223.235407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [223.256466] Starting dynamic subtest: pipe-C-eDP-1 [224.885522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.644s) [224.886640] Subtest read-crc-frame-sequence: SUCCESS (3.936s) [225.846841] [125/171] (775s left) kms_psr (primary_page_flip) [226.015763] Starting subtest: primary_page_flip [230.207409] Subtest primary_page_flip: SUCCESS (4.191s) [231.158636] [126/171] (769s left) kms_psr (cursor_plane_move) [231.327519] Starting subtest: cursor_plane_move [235.482271] Subtest cursor_plane_move: SUCCESS (4.155s) [236.405840] [127/171] (764s left) kms_psr (sprite_plane_onoff) [236.576287] Starting subtest: sprite_plane_onoff [240.853065] Subtest sprite_plane_onoff: SUCCESS (4.275s) [241.782585] [128/171] (759s left) kms_psr (primary_mmap_gtt) [241.952266] Starting subtest: primary_mmap_gtt [246.142161] Subtest primary_mmap_gtt: SUCCESS (4.171s) [247.094945] [129/171] (754s left) kms_setmode (basic-clone-single-crtc) [247.234193] Starting subtest: basic-clone-single-crtc [247.237291] Subtest basic-clone-single-crtc: SKIP (0.000s) [247.311412] [130/171] (753s left) i915_pm_backlight (basic-brightness) [247.471407] Starting subtest: basic-brightness [247.575603] Starting dynamic subtest: eDP-1 [248.118977] Dynamic subtest eDP-1: SUCCESS (0.543s) [248.120329] Subtest basic-brightness: SUCCESS (0.650s) [249.079769] [131/171] (752s left) i915_pm_rpm (basic-pci-d3-state) [250.968023] Starting subtest: basic-pci-d3-state [255.377082] Subtest basic-pci-d3-state: SUCCESS (4.408s) [255.580345] [132/171] (745s left) i915_pm_rpm (basic-rte) [255.714222] Starting subtest: basic-rte [261.840594] Subtest basic-rte: SUCCESS (6.126s) [263.310360] [133/171] (737s left) i915_pm_rps (basic-api) [263.455884] Starting subtest: basic-api [263.460208] Subtest basic-api: SUCCESS (0.004s) [263.542527] [134/171] (737s left) prime_self_import (basic-llseek-bad) [263.678382] Starting subtest: basic-llseek-bad [263.683252] Subtest basic-llseek-bad: SUCCESS (0.003s) [263.775830] [135/171] (737s left) prime_self_import (basic-llseek-size) [263.910274] Starting subtest: basic-llseek-size [263.915130] Subtest basic-llseek-size: SUCCESS (0.004s) [264.025681] [136/171] (737s left) prime_self_import (basic-with_fd_dup) [264.152563] Starting subtest: basic-with_fd_dup [264.157754] Subtest basic-with_fd_dup: SUCCESS (0.004s) [264.258815] [137/171] (737s left) prime_self_import (basic-with_one_bo) [264.394804] Starting subtest: basic-with_one_bo [264.400013] Subtest basic-with_one_bo: SUCCESS (0.005s) [264.490536] [138/171] (736s left) prime_self_import (basic-with_one_bo_two_files) [264.626542] Starting subtest: basic-with_one_bo_two_files [264.631324] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [264.725481] [139/171] (736s left) prime_self_import (basic-with_two_bos) [264.860392] Starting subtest: basic-with_two_bos [264.864927] Subtest basic-with_two_bos: SUCCESS (0.004s) [264.975300] [140/171] (736s left) prime_vgem (basic-fence-flip) [265.136645] Starting subtest: basic-fence-flip [265.603302] Subtest basic-fence-flip: SUCCESS (0.466s) [265.728060] [141/171] (735s left) prime_vgem (basic-fence-mmap) [265.889745] Starting subtest: basic-fence-mmap [265.937272] Subtest basic-fence-mmap: SUCCESS (0.047s) [266.026323] [142/171] (735s left) prime_vgem (basic-fence-read) [266.178866] Starting subtest: basic-fence-read [266.252046] Subtest basic-fence-read: SUCCESS (0.073s) [266.343129] [143/171] (735s left) prime_vgem (basic-gtt) [266.500384] Starting subtest: basic-gtt [266.523412] Subtest basic-gtt: SUCCESS (0.023s) [266.642733] [144/171] (734s left) prime_vgem (basic-read) [266.804367] Starting subtest: basic-read [266.840025] Subtest basic-read: SUCCESS (0.035s) [266.942227] [145/171] (734s left) prime_vgem (basic-write) [267.101486] Starting subtest: basic-write [267.142947] Subtest basic-write: SUCCESS (0.041s) [267.225730] [146/171] (734s left) vgem_basic (setversion) [267.370958] Starting subtest: setversion [267.373326] Subtest setversion: SUCCESS (0.000s) [267.442453] [147/171] (734s left) vgem_basic (create) [267.587678] Starting subtest: create [267.588900] Subtest create: SUCCESS (0.000s) [267.659030] [148/171] (734s left) vgem_basic (debugfs) [267.804640] Starting subtest: debugfs [267.805861] Subtest debugfs: SUCCESS (0.001s) [267.875841] [149/171] (733s left) vgem_basic (dmabuf-export) [268.021208] Starting subtest: dmabuf-export [268.047531] Subtest dmabuf-export: SUCCESS (0.025s) [268.163989] [150/171] (733s left) vgem_basic (dmabuf-fence) [268.304124] Starting subtest: dmabuf-fence [268.305251] Subtest dmabuf-fence: SUCCESS (0.001s) [268.376596] [151/171] (733s left) vgem_basic (dmabuf-fence-before) [268.523370] Starting subtest: dmabuf-fence-before [268.524444] Subtest dmabuf-fence-before: SUCCESS (0.001s) [268.592898] [152/171] (733s left) vgem_basic (dmabuf-mmap) [268.740397] Starting subtest: dmabuf-mmap [268.764981] Subtest dmabuf-mmap: SUCCESS (0.026s) [268.843472] [153/171] (733s left) vgem_basic (mmap) [268.989619] Starting subtest: mmap [269.005453] Subtest mmap: SUCCESS (0.017s) [269.076405] [154/171] (732s left) vgem_basic (second-client) [269.223741] Starting subtest: second-client [269.257387] Subtest second-client: SUCCESS (0.033s) [269.327070] [155/171] (732s left) vgem_basic (sysfs) [269.472674] Starting subtest: sysfs [269.473788] Subtest sysfs: SUCCESS (0.001s) [269.543057] [156/171] (732s left) core_hotunplug (unbind-rebind) [269.723064] Starting subtest: unbind-rebind [272.220971] Subtest unbind-rebind: SUCCESS (2.498s) [272.263131] [157/171] (729s left) vgem_basic (unload) [272.408054] Starting subtest: unload [301.447291] Subtest unload: SUCCESS (29.004s) [301.546443] [158/171] (700s left) i915_module_load (reload) [301.682953] Starting subtest: reload [305.204821] Subtest reload: SUCCESS (3.522s) [305.240201] [159/171] (696s left) gem_lmem_swapping (basic) [305.391308] Subtest basic: SKIP (0.000s) [305.439827] [160/171] (696s left) gem_lmem_swapping (parallel-random-engines) [305.589541] Subtest parallel-random-engines: SKIP (0.000s) [305.645946] [161/171] (696s left) gem_lmem_swapping (random-engines) [305.792258] Subtest random-engines: SKIP (0.000s) [305.839360] [162/171] (696s left) gem_lmem_swapping (verify-random) [305.985019] Subtest verify-random: SKIP (0.000s) [306.040689] [163/171] (696s left) i915_pm_rpm (module-reload) [318.546679] Starting subtest: module-reload [353.287739] Subtest module-reload: SUCCESS (34.734s) [353.313728] [164/171] (648s left) i915_selftest (live) [353.453483] Starting subtest: live [353.454799] Starting dynamic subtest: sanitycheck [355.264588] Dynamic subtest sanitycheck: SUCCESS (1.801s) [355.279939] Starting dynamic subtest: uncore [357.072362] Dynamic subtest uncore: SUCCESS (1.805s) [357.087831] Starting dynamic subtest: workarounds [359.173237] Dynamic subtest workarounds: SUCCESS (2.098s) [359.188706] Starting dynamic subtest: gt_engines [361.445506] Dynamic subtest gt_engines: SUCCESS (2.269s) [361.461103] Starting dynamic subtest: gt_timelines [373.932963] Dynamic subtest gt_timelines: SUCCESS (12.484s) [373.950053] Starting dynamic subtest: gt_contexts [375.836510] Dynamic subtest gt_contexts: SUCCESS (1.900s) [375.851475] Starting dynamic subtest: gt_lrc [380.200517] Dynamic subtest gt_lrc: SUCCESS (4.360s) [380.215750] Starting dynamic subtest: gt_mocs [382.095310] Dynamic subtest gt_mocs: SUCCESS (1.891s) [382.110727] Starting dynamic subtest: gt_pm [387.171494] Dynamic subtest gt_pm: SUCCESS (5.073s) [387.187087] Starting dynamic subtest: gt_heartbeat [389.076127] Dynamic subtest gt_heartbeat: SUCCESS (1.901s) [389.091772] Starting dynamic subtest: gt_tlb [392.197562] Dynamic subtest gt_tlb: SUCCESS (3.118s) [392.213039] Starting dynamic subtest: requests [399.813418] Dynamic subtest requests: SUCCESS (7.613s) [399.828878] Starting dynamic subtest: migrate [404.379471] Dynamic subtest migrate: SUCCESS (4.563s) [404.394894] Starting dynamic subtest: active [406.161504] Dynamic subtest active: SUCCESS (1.778s) [406.176798] Starting dynamic subtest: objects [409.492419] Dynamic subtest objects: SUCCESS (3.327s) [409.507855] Starting dynamic subtest: mman [416.412533] Dynamic subtest mman: SUCCESS (6.916s) [416.428246] Starting dynamic subtest: dmabuf [418.222441] Dynamic subtest dmabuf: SUCCESS (1.807s) [418.237800] Starting dynamic subtest: vma [420.062226] Dynamic subtest vma: SUCCESS (1.836s) [420.078130] Starting dynamic subtest: coherency [424.550311] Dynamic subtest coherency: SUCCESS (4.485s) [424.565828] Starting dynamic subtest: gtt [433.869531] Dynamic subtest gtt: SUCCESS (9.316s) [433.884973] Starting dynamic subtest: gem [435.812565] Dynamic subtest gem: SUCCESS (1.947s) [435.830301] Starting dynamic subtest: evict [439.578654] Dynamic subtest evict: SUCCESS (3.755s) [439.594366] Starting dynamic subtest: hugepages [446.465569] Dynamic subtest hugepages: SUCCESS (6.883s) [446.481082] Starting dynamic subtest: gem_contexts [461.791662] Dynamic subtest gem_contexts: SUCCESS (15.296s) [461.807800] Starting dynamic subtest: client [463.595445] Dynamic subtest client: SUCCESS (1.827s) [463.611325] Starting dynamic subtest: gem_migrate [465.438439] Dynamic subtest gem_migrate: SUCCESS (1.840s) [465.454497] Starting dynamic subtest: reset [470.783423] Dynamic subtest reset: SUCCESS (5.342s) [470.799641] Starting dynamic subtest: memory_region [472.598715] Dynamic subtest memory_region: SUCCESS (1.812s) [472.614886] Starting dynamic subtest: hangcheck [497.058473] Dynamic subtest hangcheck: SUCCESS (24.456s) [497.074316] Starting dynamic subtest: execlists [507.153566] Dynamic subtest execlists: SUCCESS (10.091s) [507.169772] Starting dynamic subtest: ring_submission [508.949438] Dynamic subtest ring_submission: SUCCESS (1.792s) [508.965144] Starting dynamic subtest: perf [510.870280] Dynamic subtest perf: SUCCESS (1.917s) [510.886631] Starting dynamic subtest: slpc [512.668451] Dynamic subtest slpc: SUCCESS (1.795s) [512.684332] Starting dynamic subtest: guc [514.518281] Dynamic subtest guc: SUCCESS (1.846s) [514.534264] Starting dynamic subtest: guc_multi_lrc [516.329521] Dynamic subtest guc_multi_lrc: SUCCESS (1.808s) [516.345663] Starting dynamic subtest: guc_hang [518.097410] Dynamic subtest guc_hang: SUCCESS (1.765s) [518.113715] Starting dynamic subtest: late_gt_pm [519.964349] Dynamic subtest late_gt_pm: SUCCESS (1.864s) [519.965805] Subtest live: SUCCESS (166.504s) [520.173201] [165/171] (482s left) dmabuf (all-tests) [520.314270] Starting subtest: all-tests [520.315656] Starting dynamic subtest: sanitycheck [520.381852] Dynamic subtest sanitycheck: SUCCESS (0.066s) [520.402415] Starting dynamic subtest: dma_fence [520.573074] Dynamic subtest dma_fence: SUCCESS (0.187s) [520.594221] Starting dynamic subtest: dma_fence_chain [538.327254] Dynamic subtest dma_fence_chain: SUCCESS (17.742s) [538.340225] Starting dynamic subtest: dma_fence_unwrap [538.386566] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [538.405936] Starting dynamic subtest: dma_resv [538.450728] Dynamic subtest dma_resv: SUCCESS (0.060s) [538.453080] Subtest all-tests: SUCCESS (18.138s) [538.484560] [166/171] (463s left) i915_suspend (basic-s2idle-without-i915) [538.620917] Starting subtest: basic-s2idle-without-i915 [562.922153] Subtest basic-s2idle-without-i915: SUCCESS (8.363s) [563.256624] [167/171] (454s left) i915_suspend (basic-s3-without-i915) [563.396732] Starting subtest: basic-s3-without-i915 [586.991647] Subtest basic-s3-without-i915: SUCCESS (7.118s) [587.295885] [168/171] (447s left) gem_exec_suspend (basic-s0) [587.453279] Starting subtest: basic-S0 [587.454527] Starting dynamic subtest: smem [607.077122] Dynamic subtest smem: SUCCESS (3.966s) [607.078261] Subtest basic-S0: SUCCESS (3.968s) [607.256274] [169/171] (443s left) gem_exec_suspend (basic-s3) [607.402320] Starting subtest: basic-S3 [607.403479] Starting dynamic subtest: smem [626.132383] Dynamic subtest smem: SUCCESS (3.743s) [626.133531] Subtest basic-S3: SUCCESS (3.744s) [626.335954] [170/171] (439s left) kms_chamelium_hpd (common-hpd-after-suspend) [626.824612] Subtest common-hpd-after-suspend: SKIP (0.000s) [627.727546] [171/171] (437s left) kms_pipe_crc_basic (suspend-read-crc) [627.891537] Starting subtest: suspend-read-crc [627.893525] Starting dynamic subtest: pipe-A-eDP-1 [645.991892] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.464s) [646.015538] Starting dynamic subtest: pipe-B-eDP-1 [663.922670] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.093s) [663.945706] Starting dynamic subtest: pipe-C-eDP-1 [682.926546] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.246s) [682.927640] Subtest suspend-read-crc: SUCCESS (8.821s) [683.804727] Closing watchdogs Done.