[39.792337] Initializing watchdogs [39.792510] /dev/watchdog0 [39.802624] [001/171] (960s left) i915_module_load (load) [39.931957] Starting subtest: load [42.378734] Subtest load: SUCCESS (2.447s) [42.401045] [002/171] (957s left) core_auth (basic-auth) [42.527351] Starting subtest: basic-auth [42.528456] Subtest basic-auth: SUCCESS (0.001s) [42.617393] [003/171] (957s left) debugfs_test (read_all_entries) [42.749602] Starting subtest: read_all_entries [42.814679] Subtest read_all_entries: SUCCESS (0.064s) [42.924730] [004/171] (957s left) debugfs_test (basic-hwmon) [43.056647] Starting subtest: basic-hwmon [43.059044] Subtest basic-hwmon: SKIP (0.000s) [43.160120] [005/171] (957s left) fbdev (eof) [43.317917] Starting subtest: eof [43.319089] Subtest eof: SUCCESS (0.000s) [43.376653] [006/171] (957s left) fbdev (info) [43.495306] Starting subtest: info [43.496498] Subtest info: SUCCESS (0.000s) [43.577161] [007/171] (956s left) fbdev (nullptr) [43.713296] Starting subtest: nullptr [43.714473] Subtest nullptr: SUCCESS (0.000s) [43.779261] [008/171] (956s left) fbdev (read) [43.912462] Starting subtest: read [51.014771] Subtest read: SUCCESS (7.068s) [51.058589] [009/171] (949s left) fbdev (write) [51.181325] Starting subtest: write [54.954955] Subtest write: SUCCESS (3.740s) [54.992259] [010/171] (945s left) gem_basic (bad-close) [55.109825] Starting subtest: bad-close [55.112250] Subtest bad-close: SUCCESS (0.000s) [55.192240] [011/171] (945s left) gem_basic (create-close) [55.310343] Starting subtest: create-close [55.312334] Subtest create-close: SUCCESS (0.000s) [55.408462] [012/171] (945s left) gem_basic (create-fd-close) [55.524972] Starting subtest: create-fd-close [55.526977] Subtest create-fd-close: SUCCESS (0.000s) [55.625288] [013/171] (944s left) gem_busy (busy@all-engines) [55.758731] Starting subtest: busy [55.759960] Starting dynamic subtest: all-engines [55.818694] Dynamic subtest all-engines: SUCCESS (0.060s) [55.820083] Subtest busy: SUCCESS (0.060s) [56.193242] [014/171] (944s left) gem_close_race (basic-process) [56.331963] Starting subtest: basic-process [56.397497] Subtest basic-process: SUCCESS (0.065s) [56.593301] [015/171] (944s left) gem_close_race (basic-threads) [56.728104] Starting subtest: basic-threads [57.889945] Subtest basic-threads: SUCCESS (1.162s) [58.103212] [016/171] (942s left) gem_ctx_create (basic) [58.237865] Starting subtest: basic [58.239186] Subtest basic: SUCCESS (0.000s) [58.443631] [017/171] (942s left) gem_ctx_create (basic-files) [58.573410] Starting subtest: basic-files [60.593466] Subtest basic-files: SUCCESS (2.020s) [60.839261] [018/171] (939s left) gem_ctx_exec (basic) [60.960604] Starting subtest: basic [60.965057] Subtest basic: SUCCESS (0.005s) [61.077224] [019/171] (939s left) gem_exec_basic (basic) [61.204244] Starting subtest: basic [61.205371] Starting dynamic subtest: rcs0-smem [61.206460] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [61.217100] Starting dynamic subtest: bcs0-smem [61.218391] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [61.228210] Starting dynamic subtest: vcs0-smem [61.229619] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [61.239446] Starting dynamic subtest: vecs0-smem [61.240844] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [61.242255] Subtest basic: SUCCESS (0.005s) [61.409873] [020/171] (939s left) gem_exec_create (basic) [61.541021] Starting subtest: basic [61.542244] Starting dynamic subtest: smem [63.583568] Dynamic subtest smem: SUCCESS (2.043s) [63.584767] Subtest basic: SUCCESS (2.043s) [63.792880] [021/171] (936s left) gem_exec_fence (basic-busy) [64.088754] Starting subtest: basic-busy [64.090096] Starting dynamic subtest: rcs0 [64.100260] Dynamic subtest rcs0: SUCCESS (0.020s) [64.110815] Starting dynamic subtest: bcs0 [64.126506] Dynamic subtest bcs0: SUCCESS (0.026s) [64.136821] Starting dynamic subtest: vcs0 [64.150642] Dynamic subtest vcs0: SUCCESS (0.024s) [64.161349] Starting dynamic subtest: vecs0 [64.173554] Dynamic subtest vecs0: SUCCESS (0.023s) [64.174862] Subtest basic-busy: SUCCESS (0.094s) [64.763860] [022/171] (935s left) gem_exec_fence (basic-wait) [65.049178] Starting subtest: basic-wait [65.050359] Starting dynamic subtest: rcs0 [65.067193] Dynamic subtest rcs0: SUCCESS (0.026s) [65.079114] Starting dynamic subtest: bcs0 [65.092789] Dynamic subtest bcs0: SUCCESS (0.026s) [65.103504] Starting dynamic subtest: vcs0 [65.113491] Dynamic subtest vcs0: SUCCESS (0.021s) [65.124360] Starting dynamic subtest: vecs0 [65.133441] Dynamic subtest vecs0: SUCCESS (0.020s) [65.135135] Subtest basic-wait: SUCCESS (0.093s) [65.660461] [023/171] (935s left) gem_exec_fence (basic-await) [65.943288] Starting subtest: basic-await [65.944434] Starting dynamic subtest: rcs0 [66.024243] Dynamic subtest rcs0: SUCCESS (0.088s) [66.049225] Starting dynamic subtest: bcs0 [66.133118] Dynamic subtest bcs0: SUCCESS (0.108s) [66.158459] Starting dynamic subtest: vcs0 [66.250299] Dynamic subtest vcs0: SUCCESS (0.116s) [66.275336] Starting dynamic subtest: vecs0 [66.367450] Dynamic subtest vecs0: SUCCESS (0.117s) [66.369574] Subtest basic-await: SUCCESS (0.432s) [66.944697] [024/171] (933s left) gem_exec_fence (nb-await) [67.230144] Starting subtest: nb-await [67.231380] Starting dynamic subtest: rcs0 [67.287807] Dynamic subtest rcs0: SUCCESS (0.065s) [67.307361] Starting dynamic subtest: bcs0 [67.357540] Dynamic subtest bcs0: SUCCESS (0.070s) [67.382955] Starting dynamic subtest: vcs0 [67.430898] Dynamic subtest vcs0: SUCCESS (0.073s) [67.458027] Starting dynamic subtest: vecs0 [67.506506] Dynamic subtest vecs0: SUCCESS (0.075s) [67.508455] Subtest nb-await: SUCCESS (0.284s) [68.062353] [025/171] (932s left) gem_exec_gttfill (basic) [68.195756] Starting subtest: basic [75.424262] Subtest basic: SUCCESS (7.220s) [75.615940] [026/171] (925s left) gem_exec_parallel (engines) [75.819490] Starting subtest: engines [75.820755] Starting dynamic subtest: basic [78.330709] Dynamic subtest basic: SUCCESS (2.491s) [78.358275] Starting dynamic subtest: contexts [81.600416] Dynamic subtest contexts: SUCCESS (3.281s) [81.613262] Starting dynamic subtest: fds [85.678453] Dynamic subtest fds: SUCCESS (4.087s) [85.691486] Starting dynamic subtest: userptr [88.219262] Dynamic subtest userptr: SUCCESS (2.514s) [88.226817] Subtest engines: SUCCESS (12.373s) [88.399297] [027/171] (912s left) gem_exec_store (basic) [88.533145] Starting subtest: basic [88.600274] Subtest basic: SUCCESS (0.067s) [88.796414] [028/171] (912s left) gem_flink_basic (bad-flink) [88.915199] Starting subtest: bad-flink [88.916335] Subtest bad-flink: SUCCESS (0.000s) [88.995481] [029/171] (911s left) gem_flink_basic (bad-open) [89.113697] Starting subtest: bad-open [89.114866] Subtest bad-open: SUCCESS (0.000s) [89.195159] [030/171] (911s left) gem_flink_basic (basic) [89.313819] Starting subtest: basic [89.314955] Subtest basic: SUCCESS (0.000s) [89.411857] [031/171] (911s left) gem_flink_basic (double-flink) [89.530901] Starting subtest: double-flink [89.532143] Subtest double-flink: SUCCESS (0.000s) [89.628838] [032/171] (911s left) gem_flink_basic (flink-lifetime) [89.747693] Starting subtest: flink-lifetime [89.748951] Subtest flink-lifetime: SUCCESS (0.002s) [89.845393] [033/171] (911s left) gem_huc_copy (huc-copy) [89.969364] Starting subtest: huc-copy [89.971454] Subtest huc-copy: SKIP (0.000s) [90.078487] [034/171] (910s left) gem_linear_blits (basic) [90.333521] Starting subtest: basic [90.347253] Subtest basic: SUCCESS (0.014s) [90.480701] [035/171] (910s left) gem_mmap (basic) [90.667599] Starting subtest: basic [90.672706] Subtest basic: SUCCESS (0.001s) [90.762039] [036/171] (910s left) gem_mmap_gtt (basic) [90.881867] Starting subtest: basic [90.883160] Subtest basic: SUCCESS (0.001s) [90.962783] [037/171] (910s left) gem_render_linear_blits (basic) [91.087435] Starting subtest: basic [91.137644] Subtest basic: SUCCESS (0.050s) [91.197043] [038/171] (909s left) gem_render_tiled_blits (basic) [91.323038] Starting subtest: basic [91.384284] Subtest basic: SUCCESS (0.061s) [91.447850] [039/171] (909s left) gem_ringfill (basic-all) [91.716505] Starting subtest: basic-all [92.947182] Subtest basic-all: SUCCESS (1.222s) [93.015206] [040/171] (908s left) gem_softpin (allocator-basic) [93.139059] Starting subtest: allocator-basic [93.301716] Subtest allocator-basic: SUCCESS (0.154s) [93.413747] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [93.560261] Starting subtest: allocator-basic-reserve [93.723759] Subtest allocator-basic-reserve: SUCCESS (0.155s) [93.836326] [042/171] (907s left) gem_softpin (safe-alignment) [93.982209] Starting subtest: safe-alignment [93.999217] Subtest safe-alignment: SUCCESS (0.017s) [94.112296] [043/171] (907s left) gem_sync (basic-all) [94.247441] Starting subtest: basic-all [96.727093] Subtest basic-all: SUCCESS (2.480s) [96.944134] [044/171] (904s left) gem_sync (basic-each) [97.090387] Starting subtest: basic-each [99.261860] Subtest basic-each: SUCCESS (2.171s) [99.481864] [045/171] (901s left) gem_tiled_blits (basic) [99.746939] Starting subtest: basic [99.776862] Subtest basic: SUCCESS (0.030s) [99.897939] [046/171] (901s left) gem_tiled_fence_blits (basic) [100.221655] Starting subtest: basic [100.248615] Subtest basic: SUCCESS (0.027s) [100.375821] [047/171] (900s left) gem_tiled_pread_basic [100.897502] [048/171] (900s left) gem_wait (busy@all-engines) [101.037960] Starting subtest: busy [101.039206] Starting dynamic subtest: all-engines [101.574497] Dynamic subtest all-engines: SUCCESS (0.537s) [101.575689] Subtest busy: SUCCESS (0.537s) [101.814393] [049/171] (899s left) gem_wait (wait@all-engines) [101.963515] Starting subtest: wait [101.964699] Starting dynamic subtest: all-engines [103.015373] Dynamic subtest all-engines: SUCCESS (1.051s) [103.017186] Subtest wait: SUCCESS (1.051s) [103.247842] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [103.364597] Starting subtest: basic-eu-total [103.366791] Subtest basic-eu-total: SUCCESS (0.000s) [103.445216] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [103.563842] Starting subtest: basic-subslice-total [103.566040] Subtest basic-subslice-total: SUCCESS (0.000s) [103.645670] [052/171] (897s left) i915_hangman (error-state-basic) [103.779065] Starting subtest: error-state-basic [103.792239] Subtest error-state-basic: SUCCESS (0.014s) [103.879256] [053/171] (897s left) i915_pciid [104.078962] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [104.198920] Starting subtest: addfb25-bad-modifier [104.200292] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [104.328460] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [104.447588] Starting subtest: addfb25-framebuffer-vs-set-tiling [104.448664] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.579765] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [104.700020] Starting subtest: addfb25-modifier-no-flag [104.701080] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [104.811551] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [104.931751] Starting subtest: addfb25-x-tiled-legacy [104.932897] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [105.045175] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [105.164384] Starting subtest: addfb25-x-tiled-mismatch-legacy [105.165482] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [105.297173] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [105.444715] Starting subtest: addfb25-yf-tiled-legacy [105.445825] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [105.545413] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.690196] Starting subtest: addfb25-y-tiled-legacy [105.691352] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [105.796317] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.942824] Starting subtest: addfb25-y-tiled-small-legacy [105.944197] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [106.028177] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [106.149494] Starting subtest: bad-pitch-0 [106.150730] Subtest bad-pitch-0: SUCCESS (0.000s) [106.278480] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [106.396677] Starting subtest: bad-pitch-1024 [106.397853] Subtest bad-pitch-1024: SUCCESS (0.000s) [106.511977] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [106.632129] Starting subtest: bad-pitch-128 [106.633208] Subtest bad-pitch-128: SUCCESS (0.000s) [106.762217] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [106.882789] Starting subtest: bad-pitch-256 [106.883984] Subtest bad-pitch-256: SUCCESS (0.000s) [106.994855] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [107.115211] Starting subtest: bad-pitch-32 [107.116377] Subtest bad-pitch-32: SUCCESS (0.000s) [107.228603] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [107.346957] Starting subtest: bad-pitch-63 [107.348137] Subtest bad-pitch-63: SUCCESS (0.000s) [107.462079] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [107.580859] Starting subtest: bad-pitch-65536 [107.582062] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.713289] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [107.830783] Starting subtest: bad-pitch-999 [107.831932] Subtest bad-pitch-999: SUCCESS (0.000s) [107.962833] [070/171] (893s left) kms_addfb_basic (basic) [108.086240] Starting subtest: basic [108.087423] Subtest basic: SUCCESS (0.000s) [108.211924] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [108.337012] Starting subtest: basic-x-tiled-legacy [108.338083] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [108.463676] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [108.583217] Starting subtest: basic-y-tiled-legacy [108.584299] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.694765] [073/171] (893s left) kms_addfb_basic (bo-too-small) [108.840548] Starting subtest: bo-too-small [108.841882] Subtest bo-too-small: SUCCESS (0.000s) [108.928574] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [109.075508] Starting subtest: bo-too-small-due-to-tiling [109.076805] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [109.161910] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [109.280130] Starting subtest: clobberred-modifier [109.281207] Subtest clobberred-modifier: SUCCESS (0.000s) [109.413175] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.531828] Starting subtest: framebuffer-vs-set-tiling [109.533187] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.645406] [077/171] (892s left) kms_addfb_basic (invalid-get-prop) [109.764092] Starting subtest: invalid-get-prop [109.765235] Subtest invalid-get-prop: SUCCESS (0.000s) [109.878297] [078/171] (892s left) kms_addfb_basic (invalid-get-prop-any) [109.996663] Starting subtest: invalid-get-prop-any [109.997906] Subtest invalid-get-prop-any: SUCCESS (0.000s) [110.111630] [079/171] (892s left) kms_addfb_basic (invalid-set-prop) [110.231188] Starting subtest: invalid-set-prop [110.232293] Subtest invalid-set-prop: SUCCESS (0.000s) [110.345151] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [110.464244] Starting subtest: invalid-set-prop-any [110.465332] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.578255] [081/171] (891s left) kms_addfb_basic (no-handle) [110.695824] Starting subtest: no-handle [110.697210] Subtest no-handle: SUCCESS (0.000s) [110.811293] [082/171] (891s left) kms_addfb_basic (size-max) [110.957492] Starting subtest: size-max [110.958747] Subtest size-max: SUCCESS (0.000s) [111.062707] [083/171] (891s left) kms_addfb_basic (small-bo) [111.210052] Starting subtest: small-bo [111.211117] Subtest small-bo: SUCCESS (0.000s) [111.295066] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [111.414883] Starting subtest: tile-pitch-mismatch [111.416090] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [111.528750] [085/171] (890s left) kms_addfb_basic (too-high) [111.675576] Starting subtest: too-high [111.676932] Subtest too-high: SUCCESS (0.001s) [111.778974] [086/171] (890s left) kms_addfb_basic (too-wide) [111.931460] Starting subtest: too-wide [111.932598] Subtest too-wide: SUCCESS (0.000s) [112.031796] [087/171] (890s left) kms_addfb_basic (unused-handle) [112.149829] Starting subtest: unused-handle [112.151260] Subtest unused-handle: SUCCESS (0.000s) [112.279716] [088/171] (890s left) kms_addfb_basic (unused-modifier) [112.397830] Starting subtest: unused-modifier [112.399061] Subtest unused-modifier: SUCCESS (0.000s) [112.529326] [089/171] (889s left) kms_addfb_basic (unused-offsets) [112.647306] Starting subtest: unused-offsets [112.648434] Subtest unused-offsets: SUCCESS (0.000s) [112.780281] [090/171] (889s left) kms_addfb_basic (unused-pitches) [112.897837] Starting subtest: unused-pitches [112.899231] Subtest unused-pitches: SUCCESS (0.000s) [113.029600] [091/171] (889s left) kms_busy (basic) [113.188493] Starting subtest: basic [113.190796] Starting dynamic subtest: flip [114.175059] Dynamic subtest flip: SUCCESS (0.977s) [114.189600] Starting dynamic subtest: modeset [118.040093] Dynamic subtest modeset: SUCCESS (3.872s) [118.041166] Subtest basic: SUCCESS (4.851s) [119.010401] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast) [119.478076] Subtest dp-hpd-fast: SKIP (0.000s) [120.366836] [093/171] (882s left) kms_chamelium_edid (dp-edid-read) [120.835830] Subtest dp-edid-read: SKIP (0.000s) [121.712553] [094/171] (880s left) kms_chamelium_frames (dp-crc-fast) [122.195065] Subtest dp-crc-fast: SKIP (0.000s) [123.057193] [095/171] (879s left) kms_chamelium_hpd (hdmi-hpd-fast) [123.524013] Subtest hdmi-hpd-fast: SKIP (0.000s) [124.405161] [096/171] (878s left) kms_chamelium_edid (hdmi-edid-read) [124.870635] Subtest hdmi-edid-read: SKIP (0.000s) [125.744614] [097/171] (876s left) kms_chamelium_frames (hdmi-crc-fast) [126.213662] Subtest hdmi-crc-fast: SKIP (0.000s) [127.087574] [098/171] (875s left) kms_chamelium_hpd (vga-hpd-fast) [127.556092] Subtest vga-hpd-fast: SKIP (0.000s) [128.434689] [099/171] (874s left) kms_chamelium_edid (vga-edid-read) [128.903261] Subtest vga-edid-read: SKIP (0.000s) [129.775913] [100/171] (872s left) kms_prop_blob (basic) [129.895814] Starting subtest: basic [129.897051] Subtest basic: SUCCESS (0.000s) [129.977460] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [130.125201] Starting subtest: basic-busy-flip-before-cursor-atomic [130.127250] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.205288] [102/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [130.351628] Starting subtest: basic-busy-flip-before-cursor-legacy [130.353744] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [130.421779] [103/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [130.568235] Starting subtest: basic-flip-after-cursor-atomic [131.841630] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.273s) [132.774832] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.922727] Starting subtest: basic-flip-after-cursor-legacy [134.202870] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.281s) [135.133584] [105/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [135.289551] Starting subtest: basic-flip-after-cursor-varying-size [136.579381] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.297s) [137.503431] [106/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.658472] Starting subtest: basic-flip-before-cursor-atomic [138.950922] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.292s) [139.868879] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [140.015108] Starting subtest: basic-flip-before-cursor-legacy [141.298485] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.283s) [142.239294] [108/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [142.387369] Starting subtest: basic-flip-before-cursor-varying-size [143.670262] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.283s) [144.608570] [109/171] (858s left) kms_flip (basic-flip-vs-dpms) [144.736653] Starting subtest: basic-flip-vs-dpms [144.739556] Starting dynamic subtest: A-eDP1 [147.614331] Dynamic subtest A-eDP1: SUCCESS (2.875s) [147.629965] Starting dynamic subtest: B-eDP1 [149.981698] Dynamic subtest B-eDP1: SUCCESS (2.366s) [149.999157] Starting dynamic subtest: C-eDP1 [152.339533] Dynamic subtest C-eDP1: SUCCESS (2.357s) [152.344178] Subtest basic-flip-vs-dpms: SUCCESS (7.606s) [153.247839] [110/171] (849s left) kms_flip (basic-flip-vs-modeset) [153.375772] Starting subtest: basic-flip-vs-modeset [153.378854] Starting dynamic subtest: A-eDP1 [156.247893] Dynamic subtest A-eDP1: SUCCESS (2.869s) [156.265400] Starting dynamic subtest: B-eDP1 [158.616364] Dynamic subtest B-eDP1: SUCCESS (2.369s) [158.632113] Starting dynamic subtest: C-eDP1 [160.976636] Dynamic subtest C-eDP1: SUCCESS (2.359s) [160.985444] Subtest basic-flip-vs-modeset: SUCCESS (7.605s) [161.888609] [111/171] (841s left) kms_flip (basic-flip-vs-wf_vblank) [162.016230] Starting subtest: basic-flip-vs-wf_vblank [162.019350] Starting dynamic subtest: A-eDP1 [164.355238] Dynamic subtest A-eDP1: SUCCESS (2.336s) [164.370861] Starting dynamic subtest: B-eDP1 [166.642535] Dynamic subtest B-eDP1: SUCCESS (2.287s) [166.658397] Starting dynamic subtest: C-eDP1 [168.882783] Dynamic subtest C-eDP1: SUCCESS (2.239s) [168.885214] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.870s) [170.143132] [112/171] (832s left) kms_flip (basic-plain-flip) [170.270108] Starting subtest: basic-plain-flip [170.273183] Starting dynamic subtest: A-eDP1 [172.327576] Dynamic subtest A-eDP1: SUCCESS (2.055s) [172.343115] Starting dynamic subtest: B-eDP1 [174.295295] Dynamic subtest B-eDP1: SUCCESS (1.966s) [174.310785] Starting dynamic subtest: C-eDP1 [176.277159] Dynamic subtest C-eDP1: SUCCESS (1.982s) [176.279609] Subtest basic-plain-flip: SUCCESS (6.011s) [177.567535] [113/171] (825s left) kms_force_connector_basic (force-connector-state) [177.693508] Starting subtest: force-connector-state [179.434176] Subtest force-connector-state: SUCCESS (1.740s) [180.045556] [114/171] (822s left) kms_force_connector_basic (force-edid) [180.192524] Starting subtest: force-edid [180.434788] Subtest force-edid: SUCCESS (0.251s) [180.545575] [115/171] (822s left) kms_force_connector_basic (force-load-detect) [180.674499] Starting subtest: force-load-detect [180.676881] Subtest force-load-detect: SKIP (0.000s) [180.795528] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [180.923397] Starting subtest: prune-stale-modes [181.228031] Subtest prune-stale-modes: SUCCESS (0.304s) [181.345398] [117/171] (821s left) kms_frontbuffer_tracking (basic) [181.499159] Starting subtest: basic [184.832042] Subtest basic: SUCCESS (3.331s) [184.947068] [118/171] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [185.099407] Starting subtest: compare-crc-sanitycheck [185.100476] Starting dynamic subtest: pipe-A-eDP-1 [185.780399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s) [185.802256] Starting dynamic subtest: pipe-B-eDP-1 [187.153213] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s) [187.168087] Starting dynamic subtest: pipe-C-eDP-1 [188.703670] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s) [188.704753] Subtest compare-crc-sanitycheck: SUCCESS (3.605s) [189.675553] [119/171] (813s left) kms_pipe_crc_basic (hang-read-crc) [189.826388] Starting subtest: hang-read-crc [189.827706] Starting dynamic subtest: pipe-A-eDP-1 [192.141270] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [192.156692] Starting dynamic subtest: pipe-B-eDP-1 [195.096487] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.942s) [195.111355] Starting dynamic subtest: pipe-C-eDP-1 [198.382275] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.294s) [198.383443] Subtest hang-read-crc: SUCCESS (8.556s) [199.325735] [120/171] (803s left) kms_pipe_crc_basic (nonblocking-crc) [199.501525] Starting subtest: nonblocking-crc [199.502891] Starting dynamic subtest: pipe-A-eDP-1 [200.351923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s) [200.367397] Starting dynamic subtest: pipe-B-eDP-1 [201.888739] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s) [201.906374] Starting dynamic subtest: pipe-C-eDP-1 [203.603397] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.711s) [203.604466] Subtest nonblocking-crc: SUCCESS (4.110s) [204.505951] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [204.655879] Starting subtest: nonblocking-crc-frame-sequence [204.659643] Starting dynamic subtest: pipe-A-eDP-1 [205.518523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s) [205.535365] Starting dynamic subtest: pipe-B-eDP-1 [207.054703] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s) [207.072392] Starting dynamic subtest: pipe-C-eDP-1 [208.764057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.706s) [208.765256] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.107s) [209.690692] [122/171] (793s left) kms_pipe_crc_basic (read-crc) [209.849421] Starting subtest: read-crc [209.853028] Starting dynamic subtest: pipe-A-eDP-1 [210.634724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [210.652175] Starting dynamic subtest: pipe-B-eDP-1 [212.125188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [212.140852] Starting dynamic subtest: pipe-C-eDP-1 [213.769883] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.642s) [213.771140] Subtest read-crc: SUCCESS (3.920s) [214.683058] [123/171] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence) [214.842634] Starting subtest: read-crc-frame-sequence [214.845865] Starting dynamic subtest: pipe-A-eDP-1 [215.643525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s) [215.659122] Starting dynamic subtest: pipe-B-eDP-1 [217.137570] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s) [217.153763] Starting dynamic subtest: pipe-C-eDP-1 [218.805282] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.665s) [218.806429] Subtest read-crc-frame-sequence: SUCCESS (3.962s) [219.739022] [124/171] (783s left) kms_psr (primary_page_flip) [219.892618] Starting subtest: primary_page_flip [224.181556] Subtest primary_page_flip: SUCCESS (4.272s) [225.114978] [125/171] (778s left) kms_psr (cursor_plane_move) [225.266508] Starting subtest: cursor_plane_move [229.416177] Subtest cursor_plane_move: SUCCESS (4.150s) [230.362091] [126/171] (772s left) kms_psr (sprite_plane_onoff) [230.520184] Starting subtest: sprite_plane_onoff [234.817249] Subtest sprite_plane_onoff: SUCCESS (4.295s) [235.737840] [127/171] (767s left) kms_psr (primary_mmap_gtt) [235.896557] Starting subtest: primary_mmap_gtt [240.144945] Subtest primary_mmap_gtt: SUCCESS (4.247s) [241.072885] [128/171] (762s left) kms_setmode (basic-clone-single-crtc) [241.196861] Starting subtest: basic-clone-single-crtc [241.200113] Subtest basic-clone-single-crtc: SKIP (0.000s) [241.272940] [129/171] (762s left) i915_pm_backlight (basic-brightness) [241.420343] Starting subtest: basic-brightness [241.532453] Starting dynamic subtest: eDP-1 [242.090241] Dynamic subtest eDP-1: SUCCESS (0.560s) [242.091515] Subtest basic-brightness: SUCCESS (0.665s) [243.034744] [130/171] (760s left) i915_pm_rpm (basic-pci-d3-state) [244.909469] Starting subtest: basic-pci-d3-state [249.278526] Subtest basic-pci-d3-state: SUCCESS (4.362s) [249.455958] [131/171] (753s left) i915_pm_rpm (basic-rte) [249.583791] Starting subtest: basic-rte [255.735563] Subtest basic-rte: SUCCESS (6.151s) [257.203726] [132/171] (746s left) i915_pm_rps (basic-api) [257.330399] Starting subtest: basic-api [257.334861] Subtest basic-api: SUCCESS (0.004s) [257.419554] [133/171] (746s left) prime_self_import (basic-llseek-bad) [257.537685] Starting subtest: basic-llseek-bad [257.541237] Subtest basic-llseek-bad: SUCCESS (0.003s) [257.635432] [134/171] (745s left) prime_self_import (basic-llseek-size) [257.761137] Starting subtest: basic-llseek-size [257.764659] Subtest basic-llseek-size: SUCCESS (0.004s) [257.852251] [135/171] (745s left) prime_self_import (basic-with_fd_dup) [257.968795] Starting subtest: basic-with_fd_dup [257.972435] Subtest basic-with_fd_dup: SUCCESS (0.004s) [258.068835] [136/171] (745s left) prime_self_import (basic-with_one_bo) [258.194369] Starting subtest: basic-with_one_bo [258.200292] Subtest basic-with_one_bo: SUCCESS (0.005s) [258.286175] [137/171] (745s left) prime_self_import (basic-with_one_bo_two_files) [258.412513] Starting subtest: basic-with_one_bo_two_files [258.416343] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [258.502345] [138/171] (745s left) prime_self_import (basic-with_two_bos) [258.628151] Starting subtest: basic-with_two_bos [258.634029] Subtest basic-with_two_bos: SUCCESS (0.004s) [258.718918] [139/171] (744s left) prime_vgem (basic-fence-flip) [258.865738] Starting subtest: basic-fence-flip [259.333508] Subtest basic-fence-flip: SUCCESS (0.468s) [259.436690] [140/171] (744s left) prime_vgem (basic-fence-mmap) [259.582743] Starting subtest: basic-fence-mmap [259.624118] Subtest basic-fence-mmap: SUCCESS (0.041s) [259.740982] [141/171] (743s left) prime_vgem (basic-fence-read) [259.875664] Starting subtest: basic-fence-read [259.942377] Subtest basic-fence-read: SUCCESS (0.066s) [260.024532] [142/171] (743s left) prime_vgem (basic-gtt) [260.170434] Starting subtest: basic-gtt [260.192397] Subtest basic-gtt: SUCCESS (0.022s) [260.308442] [143/171] (743s left) prime_vgem (basic-read) [260.442355] Starting subtest: basic-read [260.476157] Subtest basic-read: SUCCESS (0.034s) [260.593605] [144/171] (743s left) prime_vgem (basic-write) [260.747875] Starting subtest: basic-write [260.787889] Subtest basic-write: SUCCESS (0.040s) [260.872932] [145/171] (742s left) prime_vgem (basic-userptr) [261.008873] Starting subtest: basic-userptr [261.024596] Subtest basic-userptr: SKIP (0.014s) [261.131500] [146/171] (742s left) vgem_basic (setversion) [261.268458] Starting subtest: setversion [261.270887] Subtest setversion: SUCCESS (0.000s) [261.341249] [147/171] (742s left) vgem_basic (create) [261.486583] Starting subtest: create [261.488465] Subtest create: SUCCESS (0.001s) [261.557493] [148/171] (742s left) vgem_basic (debugfs) [261.701541] Starting subtest: debugfs [261.702873] Subtest debugfs: SUCCESS (0.001s) [261.777160] [149/171] (742s left) vgem_basic (dmabuf-export) [261.918208] Starting subtest: dmabuf-export [261.929378] Subtest dmabuf-export: SUCCESS (0.010s) [262.023985] [150/171] (741s left) vgem_basic (dmabuf-fence) [262.153397] Starting subtest: dmabuf-fence [262.154515] Subtest dmabuf-fence: SUCCESS (0.001s) [262.220151] [151/171] (741s left) vgem_basic (dmabuf-fence-before) [262.369469] Starting subtest: dmabuf-fence-before [262.370542] Subtest dmabuf-fence-before: SUCCESS (0.001s) [262.436791] [152/171] (741s left) vgem_basic (dmabuf-mmap) [262.569457] Starting subtest: dmabuf-mmap [262.594597] Subtest dmabuf-mmap: SUCCESS (0.025s) [262.670057] [153/171] (741s left) vgem_basic (mmap) [262.819629] Starting subtest: mmap [262.835720] Subtest mmap: SUCCESS (0.016s) [262.903174] [154/171] (741s left) vgem_basic (second-client) [263.053950] Starting subtest: second-client [263.103906] Subtest second-client: SUCCESS (0.049s) [263.170671] [155/171] (740s left) vgem_basic (sysfs) [263.303465] Starting subtest: sysfs [263.304633] Subtest sysfs: SUCCESS (0.001s) [263.369749] [156/171] (740s left) core_hotunplug (unbind-rebind) [263.536405] Starting subtest: unbind-rebind [265.860875] Subtest unbind-rebind: SUCCESS (2.325s) [265.917970] [157/171] (738s left) vgem_basic (unload) [266.044612] Starting subtest: unload [294.915357] Subtest unload: SUCCESS (28.836s) [295.015234] [158/171] (709s left) i915_module_load (reload) [295.132473] Starting subtest: reload [298.318975] Subtest reload: SUCCESS (3.186s) [298.347700] [159/171] (705s left) gem_lmem_swapping (basic) [298.487332] Subtest basic: SKIP (0.000s) [298.535818] [160/171] (705s left) gem_lmem_swapping (parallel-random-engines) [298.670384] Subtest parallel-random-engines: SKIP (0.000s) [298.721528] [161/171] (705s left) gem_lmem_swapping (random-engines) [298.860919] Subtest random-engines: SKIP (0.000s) [298.901819] [162/171] (705s left) gem_lmem_swapping (verify-random) [299.037300] Subtest verify-random: SKIP (0.000s) [299.085674] [163/171] (705s left) i915_pm_rpm (module-reload) [311.609712] Starting subtest: module-reload [345.768883] Subtest module-reload: SUCCESS (34.153s) [345.789208] [164/171] (658s left) i915_selftest (live) [345.921354] Starting subtest: live [345.922759] Starting dynamic subtest: sanitycheck [347.733655] Dynamic subtest sanitycheck: SUCCESS (1.803s) [347.748052] Starting dynamic subtest: uncore [349.525552] Dynamic subtest uncore: SUCCESS (1.791s) [349.539541] Starting dynamic subtest: workarounds [351.528551] Dynamic subtest workarounds: SUCCESS (2.002s) [351.542613] Starting dynamic subtest: gt_engines [353.693489] Dynamic subtest gt_engines: SUCCESS (2.164s) [353.707678] Starting dynamic subtest: gt_timelines [365.589695] Dynamic subtest gt_timelines: SUCCESS (11.895s) [365.603965] Starting dynamic subtest: gt_contexts [367.452600] Dynamic subtest gt_contexts: SUCCESS (1.862s) [367.466935] Starting dynamic subtest: gt_lrc [371.746825] Dynamic subtest gt_lrc: SUCCESS (4.293s) [371.761118] Starting dynamic subtest: gt_mocs [373.595533] Dynamic subtest gt_mocs: SUCCESS (1.848s) [373.609873] Starting dynamic subtest: gt_pm [378.591399] Dynamic subtest gt_pm: SUCCESS (4.995s) [378.605758] Starting dynamic subtest: gt_heartbeat [380.442681] Dynamic subtest gt_heartbeat: SUCCESS (1.850s) [380.457117] Starting dynamic subtest: requests [388.002703] Dynamic subtest requests: SUCCESS (7.559s) [388.017065] Starting dynamic subtest: migrate [392.522628] Dynamic subtest migrate: SUCCESS (4.523s) [392.536842] Starting dynamic subtest: active [394.267752] Dynamic subtest active: SUCCESS (1.740s) [394.282186] Starting dynamic subtest: objects [397.592543] Dynamic subtest objects: SUCCESS (3.324s) [397.606924] Starting dynamic subtest: mman [404.424585] Dynamic subtest mman: SUCCESS (6.831s) [404.439212] Starting dynamic subtest: dmabuf [406.243722] Dynamic subtest dmabuf: SUCCESS (1.818s) [406.258192] Starting dynamic subtest: vma [408.036447] Dynamic subtest vma: SUCCESS (1.792s) [408.050590] Starting dynamic subtest: coherency [412.439612] Dynamic subtest coherency: SUCCESS (4.402s) [412.454060] Starting dynamic subtest: gtt [423.665675] Dynamic subtest gtt: SUCCESS (11.225s) [423.680148] Starting dynamic subtest: gem [425.578403] Dynamic subtest gem: SUCCESS (1.912s) [425.593047] Starting dynamic subtest: evict [429.209438] Dynamic subtest evict: SUCCESS (3.630s) [429.223966] Starting dynamic subtest: hugepages [436.056614] Dynamic subtest hugepages: SUCCESS (6.846s) [436.071510] Starting dynamic subtest: gem_contexts [451.069839] Dynamic subtest gem_contexts: SUCCESS (15.012s) [451.084621] Starting dynamic subtest: client [452.899604] Dynamic subtest client: SUCCESS (1.829s) [452.914387] Starting dynamic subtest: gem_migrate [454.675590] Dynamic subtest gem_migrate: SUCCESS (1.775s) [454.690521] Starting dynamic subtest: reset [460.022562] Dynamic subtest reset: SUCCESS (5.346s) [460.037475] Starting dynamic subtest: memory_region [461.781555] Dynamic subtest memory_region: SUCCESS (1.758s) [461.796826] Starting dynamic subtest: hangcheck [486.150644] Dynamic subtest hangcheck: SUCCESS (24.368s) [486.165802] Starting dynamic subtest: execlists [496.068659] Dynamic subtest execlists: SUCCESS (9.917s) [496.083615] Starting dynamic subtest: ring_submission [497.812666] Dynamic subtest ring_submission: SUCCESS (1.743s) [497.827540] Starting dynamic subtest: perf [499.693135] Dynamic subtest perf: SUCCESS (1.881s) [499.708092] Starting dynamic subtest: slpc [501.459497] Dynamic subtest slpc: SUCCESS (1.764s) [501.474320] Starting dynamic subtest: guc [503.188589] Dynamic subtest guc: SUCCESS (1.728s) [503.203544] Starting dynamic subtest: guc_multi_lrc [504.915467] Dynamic subtest guc_multi_lrc: SUCCESS (1.726s) [504.930298] Starting dynamic subtest: guc_hang [506.705694] Dynamic subtest guc_hang: SUCCESS (1.789s) [506.720579] Starting dynamic subtest: late_gt_pm [508.510497] Dynamic subtest late_gt_pm: SUCCESS (1.804s) [508.511812] Subtest live: SUCCESS (162.581s) [508.588751] [165/171] (495s left) dmabuf (all-tests) [508.713948] Starting subtest: all-tests [508.716271] Starting dynamic subtest: sanitycheck [508.745727] Dynamic subtest sanitycheck: SUCCESS (0.031s) [508.757806] Starting dynamic subtest: dma_fence [508.886887] Dynamic subtest dma_fence: SUCCESS (0.140s) [508.898562] Starting dynamic subtest: dma_fence_chain [526.276205] Dynamic subtest dma_fence_chain: SUCCESS (17.380s) [526.289123] Starting dynamic subtest: dma_fence_unwrap [526.290508] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s) [526.302674] Starting dynamic subtest: dma_resv [526.314565] Dynamic subtest dma_resv: SUCCESS (0.023s) [526.315872] Subtest all-tests: SUCCESS (17.601s) [526.338962] [166/171] (478s left) i915_suspend (basic-s2idle-without-i915) [526.455172] Starting subtest: basic-s2idle-without-i915 [550.374223] Subtest basic-s2idle-without-i915: SUCCESS (8.148s) [550.660062] [167/171] (469s left) i915_suspend (basic-s3-without-i915) [550.789975] Starting subtest: basic-s3-without-i915 [573.484902] Subtest basic-s3-without-i915: SUCCESS (6.876s) [573.805234] [168/171] (462s left) gem_exec_suspend (basic-s0) [573.948040] Starting subtest: basic-S0 [573.949238] Starting dynamic subtest: smem [593.458287] Dynamic subtest smem: SUCCESS (3.604s) [593.459302] Subtest basic-S0: SUCCESS (3.605s) [593.620887] [169/171] (458s left) gem_exec_suspend (basic-s3) [593.755379] Starting subtest: basic-S3 [593.756877] Starting dynamic subtest: smem [612.445240] Dynamic subtest smem: SUCCESS (3.526s) [612.446280] Subtest basic-S3: SUCCESS (3.527s) [612.597378] [170/171] (454s left) kms_chamelium_hpd (common-hpd-after-suspend) [613.074318] Subtest common-hpd-after-suspend: SKIP (0.000s) [613.943707] [171/171] (453s left) kms_pipe_crc_basic (suspend-read-crc) [614.096584] Starting subtest: suspend-read-crc [614.097780] Starting dynamic subtest: pipe-A-eDP-1 [631.486615] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.486s) [631.507616] Starting dynamic subtest: pipe-B-eDP-1 [649.401226] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.073s) [649.421954] Starting dynamic subtest: pipe-C-eDP-1 [668.395217] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.218s) [668.396300] Subtest suspend-read-crc: SUCCESS (8.785s) [669.310504] Closing watchdogs Done.