builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1505492905.19 results: success (0) revision: 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.194358) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.194716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.194992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.242916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.243220) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 09:28:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.7M=0s 2017-09-15 09:28:25 (53.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.386230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.386525) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:25.436237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-15 09:28:25.436525) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 09:28:25,484 truncating revision to first 12 chars 2017-09-15 09:28:25,484 Setting DEBUG logging. 2017-09-15 09:28:25,484 attempt 1/10 2017-09-15 09:28:25,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84e4b6c526bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 09:28:26,144 unpacking tar archive at: mozilla-beta-84e4b6c526bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.033190 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-15 09:28:26.498391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:26.498657) ========= script_repo_revision: 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:26.499014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:26.499299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 09:28:26.521539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 09:28:26.521823) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:26 INFO - MultiFileLogger online at 20170915 09:28:26 in /builds/slave/test 09:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 09:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:26 INFO - {'append_to_log': False, 09:28:26 INFO - 'base_work_dir': '/builds/slave/test', 09:28:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:26 INFO - 'code_coverage': False, 09:28:26 INFO - 'config_files': ('talos/linux_config.py',), 09:28:26 INFO - 'default_actions': ('clobber', 09:28:26 INFO - 'read-buildbot-config', 09:28:26 INFO - 'download-and-extract', 09:28:26 INFO - 'populate-webroot', 09:28:26 INFO - 'create-virtualenv', 09:28:26 INFO - 'install', 09:28:26 INFO - 'setup-mitmproxy', 09:28:26 INFO - 'run-tests'), 09:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:26 INFO - 'disable_ccov_upload': False, 09:28:26 INFO - 'download_minidump_stackwalk': True, 09:28:26 INFO - 'download_symbols': 'ondemand', 09:28:26 INFO - 'enable_stylo': False, 09:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:26 INFO - 'gecko_profile': False, 09:28:26 INFO - 'gecko_profile_interval': 0, 09:28:26 INFO - 'installer_path': 'installer.exe', 09:28:26 INFO - 'log_level': 'info', 09:28:26 INFO - 'log_name': 'talos', 09:28:26 INFO - 'log_to_console': True, 09:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:26 INFO - 'opt_config_files': (), 09:28:26 INFO - 'pip_index': False, 09:28:26 INFO - 'suite': 'dromaeojs-e10s', 09:28:26 INFO - 'system_bits': '32', 09:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:26 INFO - 'title': 'talos-linux64-ix-023', 09:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:26 INFO - 'use_talos_json': True, 09:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:26 INFO - 'work_dir': 'build'} 09:28:26 INFO - [mozharness: 2017-09-15 16:28:26.675300Z] Running clobber step. 09:28:26 INFO - Running pre-action listener: _resource_record_pre_action 09:28:26 INFO - Running main action method: clobber 09:28:26 INFO - rmtree: /builds/slave/test/build 09:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:28 INFO - Running post-action listener: _resource_record_post_action 09:28:28 INFO - [mozharness: 2017-09-15 16:28:28.189474Z] Finished clobber step (success) 09:28:28 INFO - [mozharness: 2017-09-15 16:28:28.189575Z] Running read-buildbot-config step. 09:28:28 INFO - Running pre-action listener: _resource_record_pre_action 09:28:28 INFO - Running main action method: read_buildbot_config 09:28:28 INFO - Using buildbot properties: 09:28:28 INFO - { 09:28:28 INFO - "project": "", 09:28:28 INFO - "product": "firefox", 09:28:28 INFO - "who": "ryanvm@gmail.com", 09:28:28 INFO - "installer_path": "public/build/target.tar.bz2", 09:28:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:28:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:28:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:28:28 INFO - "stage_platform": "linux64", 09:28:28 INFO - "basedir": "/builds/slave/test", 09:28:28 INFO - "buildnumber": 86, 09:28:28 INFO - "platform": "ubuntu64_hw", 09:28:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:28:28 INFO - "slavebuilddir": "test", 09:28:28 INFO - "taskId": "KszK9On-QvuSkHNjfp5Qng", 09:28:28 INFO - "branch": "mozilla-beta", 09:28:28 INFO - "script_repo_revision": "production", 09:28:28 INFO - "revision": "84e4b6c526bb553d3885ff63a93f5c4a780ca2ab", 09:28:28 INFO - "slavename": "talos-linux64-ix-023", 09:28:28 INFO - "repo_path": "releases/mozilla-beta" 09:28:28 INFO - } 09:28:28 INFO - Finding installer, test and symbols from parent task. 09:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KszK9On-QvuSkHNjfp5Qng'}, attempt #1 09:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KszK9On-QvuSkHNjfp5Qng'}, attempt #1 09:28:29 INFO - Task dependencies: USRU6VmpTDy9FhWNXcd9TQ 09:28:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ'}, attempt #1 09:28:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 09:28:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.test_packages.json 09:28:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.crashreporter-symbols.zip 09:28:29 INFO - Running post-action listener: _resource_record_post_action 09:28:29 INFO - [mozharness: 2017-09-15 16:28:29.623425Z] Finished read-buildbot-config step (success) 09:28:29 INFO - [mozharness: 2017-09-15 16:28:29.623645Z] Running download-and-extract step. 09:28:29 INFO - Running pre-action listener: _resource_record_pre_action 09:28:29 INFO - Running main action method: download_and_extract 09:28:29 INFO - mkdir: /builds/slave/test/build/tests 09:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:29 INFO - trying https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.test_packages.json 09:28:29 INFO - Downloading https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:28:30 INFO - Downloaded 989 bytes. 09:28:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:28:30 INFO - Using the following test package requirements: 09:28:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:28:30 INFO - u'common': [u'target.common.tests.zip'], 09:28:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:28:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:28:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:28:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:28:30 INFO - u'mozbase': [u'target.common.tests.zip'], 09:28:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:28:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:28:30 INFO - u'web-platform': [u'target.common.tests.zip', 09:28:30 INFO - u'target.web-platform.tests.tar.gz'], 09:28:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:28:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:28:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.common.tests.zip 09:28:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:30 INFO - Fetch https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.common.tests.zip into memory 09:28:32 INFO - Content-Length response header: 72858373 09:28:32 INFO - Bytes received: 72858373 09:28:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.talos.tests.zip 09:28:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:28:43 INFO - Fetch https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.talos.tests.zip into memory 09:28:45 INFO - Content-Length response header: 14496472 09:28:45 INFO - Bytes received: 14496472 09:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:45 INFO - trying https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 09:28:45 INFO - Downloading https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:28:47 INFO - Downloaded 54270107 bytes. 09:28:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 09:28:48 INFO - mkdir: /builds/slave/test/properties 09:28:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:28:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:28:48 INFO - Contents: 09:28:48 INFO - build_url:https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 09:28:48 INFO - Running post-action listener: _resource_record_post_action 09:28:48 INFO - Running post-action listener: set_extra_try_arguments 09:28:48 INFO - [mozharness: 2017-09-15 16:28:48.022895Z] Finished download-and-extract step (success) 09:28:48 INFO - [mozharness: 2017-09-15 16:28:48.023125Z] Running populate-webroot step. 09:28:48 INFO - Running pre-action listener: _resource_record_pre_action 09:28:48 INFO - Running main action method: populate_webroot 09:28:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:28:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:28:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:28:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:28:48 INFO - 'tests': ['damp', 'tps']}, 09:28:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:28:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:28:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:28:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:28:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:28:48 INFO - 'ts_paint', 09:28:48 INFO - 'tpaint', 09:28:48 INFO - 'sessionrestore', 09:28:48 INFO - 'sessionrestore_many_windows', 09:28:48 INFO - 'sessionrestore_no_auto_restore', 09:28:48 INFO - 'tabpaint']}, 09:28:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:28:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:28:48 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:28:48 INFO - 'talos_options': ['--mitmproxy', 09:28:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:28:48 INFO - '--firstNonBlankPaint'], 09:28:48 INFO - 'tests': ['quantum_pageload_google', 09:28:48 INFO - 'quantum_pageload_youtube', 09:28:48 INFO - 'quantum_pageload_amazon', 09:28:48 INFO - 'quantum_pageload_facebook']}, 09:28:48 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:28:48 INFO - 'talos_options': ['--stylo', 09:28:48 INFO - '--mitmproxy', 09:28:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:28:48 INFO - '--firstNonBlankPaint'], 09:28:48 INFO - 'tests': ['quantum_pageload_google', 09:28:48 INFO - 'quantum_pageload_youtube', 09:28:48 INFO - 'quantum_pageload_amazon', 09:28:48 INFO - 'quantum_pageload_facebook']}, 09:28:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:28:48 INFO - 'tsvgr_opacity', 09:28:48 INFO - 'tart', 09:28:48 INFO - 'tscrollx', 09:28:48 INFO - 'cart', 09:28:48 INFO - 'tsvg_static']}, 09:28:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:28:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:28:48 INFO - 'talos_options': ['--stylo', 09:28:48 INFO - '--stylo-threads=1', 09:28:48 INFO - '--mitmproxy', 09:28:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:28:48 INFO - '--firstNonBlankPaint'], 09:28:48 INFO - 'tests': ['tp6_google', 09:28:48 INFO - 'tp6_youtube', 09:28:48 INFO - 'tp6_amazon', 09:28:48 INFO - 'tp6_facebook']}, 09:28:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:28:48 INFO - 'talos_options': ['--xperf_path', 09:28:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:48 INFO - 'tests': ['tp5n']}}} 09:28:48 INFO - Running post-action listener: _resource_record_post_action 09:28:48 INFO - [mozharness: 2017-09-15 16:28:48.038656Z] Finished populate-webroot step (success) 09:28:48 INFO - [mozharness: 2017-09-15 16:28:48.038747Z] Running create-virtualenv step. 09:28:48 INFO - Running pre-action listener: _resource_record_pre_action 09:28:48 INFO - Running main action method: create_virtualenv 09:28:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:28:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:28:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:28:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:28:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:28:48 INFO - Using real prefix '/usr' 09:28:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:28:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:28:50 INFO - Installing pip.................done. 09:28:50 INFO - Return code: 0 09:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:28:51 INFO - Reading from file tmpfile_stdout 09:28:51 INFO - Output received: 09:28:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:28:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:28:51 INFO - Using env: {'DISPLAY': ':0', 09:28:51 INFO - 'HOME': '/home/cltbld', 09:28:51 INFO - 'LANG': 'en_US.UTF-8', 09:28:51 INFO - 'LANGUAGE': 'en_US:en', 09:28:51 INFO - 'LOGNAME': 'cltbld', 09:28:51 INFO - 'MAIL': '/var/mail/cltbld', 09:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:51 INFO - 'MOZ_NO_REMOTE': '1', 09:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:51 INFO - 'NO_EM_RESTART': '1', 09:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:51 INFO - 'PWD': '/builds/slave/test', 09:28:51 INFO - 'SHELL': '/bin/bash', 09:28:51 INFO - 'SHLVL': '1', 09:28:51 INFO - 'TERM': 'linux', 09:28:51 INFO - 'TMOUT': '86400', 09:28:51 INFO - 'USER': 'cltbld', 09:28:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:51 INFO - '_': '/tools/buildbot/bin/python'} 09:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:28:51 INFO - Cleaning up... 09:28:51 INFO - Return code: 0 09:28:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:28:51 INFO - Using env: {'DISPLAY': ':0', 09:28:51 INFO - 'HOME': '/home/cltbld', 09:28:51 INFO - 'LANG': 'en_US.UTF-8', 09:28:51 INFO - 'LANGUAGE': 'en_US:en', 09:28:51 INFO - 'LOGNAME': 'cltbld', 09:28:51 INFO - 'MAIL': '/var/mail/cltbld', 09:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:51 INFO - 'MOZ_NO_REMOTE': '1', 09:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:51 INFO - 'NO_EM_RESTART': '1', 09:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:51 INFO - 'PWD': '/builds/slave/test', 09:28:51 INFO - 'SHELL': '/bin/bash', 09:28:51 INFO - 'SHLVL': '1', 09:28:51 INFO - 'TERM': 'linux', 09:28:51 INFO - 'TMOUT': '86400', 09:28:51 INFO - 'USER': 'cltbld', 09:28:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:51 INFO - '_': '/tools/buildbot/bin/python'} 09:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:51 INFO - Downloading/unpacking psutil>=3.1.1 09:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:52 INFO - Installing collected packages: psutil 09:28:52 INFO - Running setup.py install for psutil 09:28:52 INFO - building 'psutil._psutil_linux' extension 09:28:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:28:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:28:52 INFO - building 'psutil._psutil_posix' extension 09:28:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:28:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:28:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:53 INFO - Successfully installed psutil 09:28:53 INFO - Cleaning up... 09:28:54 INFO - Return code: 0 09:28:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:28:54 INFO - Using env: {'DISPLAY': ':0', 09:28:54 INFO - 'HOME': '/home/cltbld', 09:28:54 INFO - 'LANG': 'en_US.UTF-8', 09:28:54 INFO - 'LANGUAGE': 'en_US:en', 09:28:54 INFO - 'LOGNAME': 'cltbld', 09:28:54 INFO - 'MAIL': '/var/mail/cltbld', 09:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:54 INFO - 'MOZ_NO_REMOTE': '1', 09:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:54 INFO - 'NO_EM_RESTART': '1', 09:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:54 INFO - 'PWD': '/builds/slave/test', 09:28:54 INFO - 'SHELL': '/bin/bash', 09:28:54 INFO - 'SHLVL': '1', 09:28:54 INFO - 'TERM': 'linux', 09:28:54 INFO - 'TMOUT': '86400', 09:28:54 INFO - 'USER': 'cltbld', 09:28:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:54 INFO - '_': '/tools/buildbot/bin/python'} 09:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:28:56 INFO - Installing collected packages: mozsystemmonitor 09:28:56 INFO - Running setup.py install for mozsystemmonitor 09:28:56 INFO - Successfully installed mozsystemmonitor 09:28:56 INFO - Cleaning up... 09:28:56 INFO - Return code: 0 09:28:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:28:56 INFO - Using env: {'DISPLAY': ':0', 09:28:56 INFO - 'HOME': '/home/cltbld', 09:28:56 INFO - 'LANG': 'en_US.UTF-8', 09:28:56 INFO - 'LANGUAGE': 'en_US:en', 09:28:56 INFO - 'LOGNAME': 'cltbld', 09:28:56 INFO - 'MAIL': '/var/mail/cltbld', 09:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:56 INFO - 'MOZ_NO_REMOTE': '1', 09:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:56 INFO - 'NO_EM_RESTART': '1', 09:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:56 INFO - 'PWD': '/builds/slave/test', 09:28:56 INFO - 'SHELL': '/bin/bash', 09:28:56 INFO - 'SHLVL': '1', 09:28:56 INFO - 'TERM': 'linux', 09:28:56 INFO - 'TMOUT': '86400', 09:28:56 INFO - 'USER': 'cltbld', 09:28:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:56 INFO - '_': '/tools/buildbot/bin/python'} 09:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:28:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:28:58 INFO - warning: no files found matching '*.txt' 09:28:58 INFO - no previously-included directories found matching 'build' 09:28:58 INFO - no previously-included directories found matching 'dist' 09:28:58 INFO - no previously-included directories found matching '.git*' 09:28:58 INFO - Installing collected packages: jsonschema, functools32 09:28:58 INFO - Running setup.py install for functools32 09:28:58 INFO - warning: no files found matching '*.txt' 09:28:58 INFO - no previously-included directories found matching 'build' 09:28:58 INFO - no previously-included directories found matching 'dist' 09:28:58 INFO - no previously-included directories found matching '.git*' 09:28:58 INFO - Successfully installed jsonschema functools32 09:28:58 INFO - Cleaning up... 09:28:58 INFO - Return code: 0 09:28:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:28:58 INFO - Using env: {'DISPLAY': ':0', 09:28:58 INFO - 'HOME': '/home/cltbld', 09:28:58 INFO - 'LANG': 'en_US.UTF-8', 09:28:58 INFO - 'LANGUAGE': 'en_US:en', 09:28:58 INFO - 'LOGNAME': 'cltbld', 09:28:58 INFO - 'MAIL': '/var/mail/cltbld', 09:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:58 INFO - 'MOZ_NO_REMOTE': '1', 09:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:58 INFO - 'NO_EM_RESTART': '1', 09:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:58 INFO - 'PWD': '/builds/slave/test', 09:28:58 INFO - 'SHELL': '/bin/bash', 09:28:58 INFO - 'SHLVL': '1', 09:28:58 INFO - 'TERM': 'linux', 09:28:58 INFO - 'TMOUT': '86400', 09:28:58 INFO - 'USER': 'cltbld', 09:28:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:58 INFO - '_': '/tools/buildbot/bin/python'} 09:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:28:58 INFO - Cleaning up... 09:28:58 INFO - Return code: 0 09:28:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:28:58 INFO - Using env: {'DISPLAY': ':0', 09:28:58 INFO - 'HOME': '/home/cltbld', 09:28:58 INFO - 'LANG': 'en_US.UTF-8', 09:28:58 INFO - 'LANGUAGE': 'en_US:en', 09:28:58 INFO - 'LOGNAME': 'cltbld', 09:28:58 INFO - 'MAIL': '/var/mail/cltbld', 09:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:58 INFO - 'MOZ_NO_REMOTE': '1', 09:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:58 INFO - 'NO_EM_RESTART': '1', 09:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:58 INFO - 'PWD': '/builds/slave/test', 09:28:58 INFO - 'SHELL': '/bin/bash', 09:28:58 INFO - 'SHLVL': '1', 09:28:58 INFO - 'TERM': 'linux', 09:28:58 INFO - 'TMOUT': '86400', 09:28:58 INFO - 'USER': 'cltbld', 09:28:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:58 INFO - '_': '/tools/buildbot/bin/python'} 09:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:00 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:00 INFO - Downloading docopt-0.6.1.tar.gz 09:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:00 INFO - Running setup.py install for blobuploader 09:29:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:00 INFO - Running setup.py install for requests 09:29:01 INFO - Running setup.py install for docopt 09:29:01 INFO - Successfully installed blobuploader requests docopt 09:29:01 INFO - Cleaning up... 09:29:01 INFO - Return code: 0 09:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:01 INFO - Using env: {'DISPLAY': ':0', 09:29:01 INFO - 'HOME': '/home/cltbld', 09:29:01 INFO - 'LANG': 'en_US.UTF-8', 09:29:01 INFO - 'LANGUAGE': 'en_US:en', 09:29:01 INFO - 'LOGNAME': 'cltbld', 09:29:01 INFO - 'MAIL': '/var/mail/cltbld', 09:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:01 INFO - 'MOZ_NO_REMOTE': '1', 09:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:01 INFO - 'NO_EM_RESTART': '1', 09:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:01 INFO - 'PWD': '/builds/slave/test', 09:29:01 INFO - 'SHELL': '/bin/bash', 09:29:01 INFO - 'SHLVL': '1', 09:29:01 INFO - 'TERM': 'linux', 09:29:01 INFO - 'TMOUT': '86400', 09:29:01 INFO - 'USER': 'cltbld', 09:29:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:01 INFO - '_': '/tools/buildbot/bin/python'} 09:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:01 INFO - Running setup.py (path:/tmp/pip-u2IupD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:01 INFO - Running setup.py (path:/tmp/pip-AyvNUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:01 INFO - Running setup.py (path:/tmp/pip-g2HYXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:01 INFO - Running setup.py (path:/tmp/pip-ZQFYZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:01 INFO - Running setup.py (path:/tmp/pip-621kwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:01 INFO - Running setup.py (path:/tmp/pip-iM3nBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:02 INFO - Running setup.py (path:/tmp/pip-rI8KMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:02 INFO - Running setup.py (path:/tmp/pip-nJscWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:02 INFO - Running setup.py (path:/tmp/pip-lse2Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:02 INFO - Running setup.py (path:/tmp/pip-ZEoHMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:02 INFO - Running setup.py (path:/tmp/pip-CM4FyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:02 INFO - Running setup.py (path:/tmp/pip-PL7MOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:02 INFO - Running setup.py (path:/tmp/pip-jFYQvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:02 INFO - Running setup.py (path:/tmp/pip-2Ec8d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:02 INFO - Running setup.py (path:/tmp/pip-E5pIFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:02 INFO - Running setup.py (path:/tmp/pip-0adxzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:02 INFO - Running setup.py (path:/tmp/pip-cDszvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:02 INFO - Running setup.py install for manifestparser 09:29:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:02 INFO - Running setup.py install for mozcrash 09:29:03 INFO - Running setup.py install for mozdebug 09:29:03 INFO - Running setup.py install for mozdevice 09:29:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for mozfile 09:29:03 INFO - Running setup.py install for mozhttpd 09:29:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for mozinfo 09:29:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for mozInstall 09:29:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for mozleak 09:29:03 INFO - Running setup.py install for mozlog 09:29:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for moznetwork 09:29:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:03 INFO - Running setup.py install for mozprocess 09:29:04 INFO - Running setup.py install for mozprofile 09:29:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:04 INFO - Running setup.py install for mozrunner 09:29:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:04 INFO - Running setup.py install for mozscreenshot 09:29:04 INFO - Running setup.py install for moztest 09:29:04 INFO - Running setup.py install for mozversion 09:29:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:04 INFO - Cleaning up... 09:29:04 INFO - Return code: 0 09:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:04 INFO - Using env: {'DISPLAY': ':0', 09:29:04 INFO - 'HOME': '/home/cltbld', 09:29:04 INFO - 'LANG': 'en_US.UTF-8', 09:29:04 INFO - 'LANGUAGE': 'en_US:en', 09:29:04 INFO - 'LOGNAME': 'cltbld', 09:29:04 INFO - 'MAIL': '/var/mail/cltbld', 09:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:04 INFO - 'MOZ_NO_REMOTE': '1', 09:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:04 INFO - 'NO_EM_RESTART': '1', 09:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:04 INFO - 'PWD': '/builds/slave/test', 09:29:04 INFO - 'SHELL': '/bin/bash', 09:29:04 INFO - 'SHLVL': '1', 09:29:04 INFO - 'TERM': 'linux', 09:29:04 INFO - 'TMOUT': '86400', 09:29:04 INFO - 'USER': 'cltbld', 09:29:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:04 INFO - '_': '/tools/buildbot/bin/python'} 09:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:04 INFO - Running setup.py (path:/tmp/pip-GeJLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:04 INFO - Running setup.py (path:/tmp/pip-IT40Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:04 INFO - Running setup.py (path:/tmp/pip-l44W2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:05 INFO - Running setup.py (path:/tmp/pip-USAzC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:05 INFO - Running setup.py (path:/tmp/pip-ReRYJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:05 INFO - Running setup.py (path:/tmp/pip-jyEI4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:05 INFO - Running setup.py (path:/tmp/pip-c5Fx1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:05 INFO - Running setup.py (path:/tmp/pip-TKFz1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:05 INFO - Running setup.py (path:/tmp/pip-CIipyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:05 INFO - Running setup.py (path:/tmp/pip-DNIPHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:05 INFO - Running setup.py (path:/tmp/pip-vdcLWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:05 INFO - Running setup.py (path:/tmp/pip-xfwgTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:05 INFO - Running setup.py (path:/tmp/pip-rJb56h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:05 INFO - Running setup.py (path:/tmp/pip-OT8gyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:05 INFO - Running setup.py (path:/tmp/pip-5TqGk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:05 INFO - Running setup.py (path:/tmp/pip-v8gnWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:05 INFO - Running setup.py (path:/tmp/pip-po8MZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:07 INFO - Downloading blessings-1.6.tar.gz 09:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:07 INFO - Installing collected packages: blessings 09:29:07 INFO - Running setup.py install for blessings 09:29:07 INFO - Successfully installed blessings 09:29:07 INFO - Cleaning up... 09:29:07 INFO - Return code: 0 09:29:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:07 INFO - Reading from file tmpfile_stdout 09:29:07 INFO - Current package versions: 09:29:07 INFO - argparse == 1.2.1 09:29:07 INFO - blessings == 1.6 09:29:07 INFO - blobuploader == 1.2.4 09:29:07 INFO - docopt == 0.6.1 09:29:07 INFO - functools32 == 3.2.3-2 09:29:07 INFO - jsonschema == 2.5.1 09:29:07 INFO - manifestparser == 1.1 09:29:07 INFO - mozInstall == 1.13 09:29:07 INFO - mozcrash == 1.0 09:29:07 INFO - mozdebug == 0.1 09:29:07 INFO - mozdevice == 0.51 09:29:07 INFO - mozfile == 1.2 09:29:07 INFO - mozhttpd == 0.7 09:29:07 INFO - mozinfo == 0.10 09:29:07 INFO - mozleak == 0.1 09:29:07 INFO - mozlog == 3.5 09:29:07 INFO - moznetwork == 0.27 09:29:07 INFO - mozprocess == 0.25 09:29:07 INFO - mozprofile == 0.28 09:29:07 INFO - mozrunner == 6.13 09:29:07 INFO - mozscreenshot == 0.1 09:29:07 INFO - mozsystemmonitor == 0.3 09:29:07 INFO - moztest == 0.8 09:29:07 INFO - mozversion == 1.4 09:29:07 INFO - psutil == 3.1.1 09:29:07 INFO - requests == 1.2.3 09:29:07 INFO - wsgiref == 0.1.2 09:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:07 INFO - Using env: {'DISPLAY': ':0', 09:29:07 INFO - 'HOME': '/home/cltbld', 09:29:07 INFO - 'LANG': 'en_US.UTF-8', 09:29:07 INFO - 'LANGUAGE': 'en_US:en', 09:29:07 INFO - 'LOGNAME': 'cltbld', 09:29:07 INFO - 'MAIL': '/var/mail/cltbld', 09:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:07 INFO - 'MOZ_NO_REMOTE': '1', 09:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:07 INFO - 'NO_EM_RESTART': '1', 09:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:07 INFO - 'PWD': '/builds/slave/test', 09:29:07 INFO - 'SHELL': '/bin/bash', 09:29:07 INFO - 'SHLVL': '1', 09:29:07 INFO - 'TERM': 'linux', 09:29:07 INFO - 'TMOUT': '86400', 09:29:07 INFO - 'USER': 'cltbld', 09:29:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:07 INFO - '_': '/tools/buildbot/bin/python'} 09:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:29:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:09 INFO - Installing collected packages: simplejson 09:29:09 INFO - Running setup.py install for simplejson 09:29:09 INFO - building 'simplejson._speedups' extension 09:29:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 09:29:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 09:29:10 INFO - Successfully installed simplejson 09:29:10 INFO - Cleaning up... 09:29:10 INFO - Return code: 0 09:29:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:29:10 INFO - Using env: {'DISPLAY': ':0', 09:29:10 INFO - 'HOME': '/home/cltbld', 09:29:10 INFO - 'LANG': 'en_US.UTF-8', 09:29:10 INFO - 'LANGUAGE': 'en_US:en', 09:29:10 INFO - 'LOGNAME': 'cltbld', 09:29:10 INFO - 'MAIL': '/var/mail/cltbld', 09:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:10 INFO - 'MOZ_NO_REMOTE': '1', 09:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:10 INFO - 'NO_EM_RESTART': '1', 09:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:10 INFO - 'PWD': '/builds/slave/test', 09:29:10 INFO - 'SHELL': '/bin/bash', 09:29:10 INFO - 'SHLVL': '1', 09:29:10 INFO - 'TERM': 'linux', 09:29:10 INFO - 'TMOUT': '86400', 09:29:10 INFO - 'USER': 'cltbld', 09:29:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:10 INFO - '_': '/tools/buildbot/bin/python'} 09:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:10 INFO - Cleaning up... 09:29:10 INFO - Return code: 0 09:29:10 INFO - Running post-action listener: _resource_record_post_action 09:29:10 INFO - Running post-action listener: _start_resource_monitoring 09:29:10 INFO - Starting resource monitoring. 09:29:10 INFO - [mozharness: 2017-09-15 16:29:10.317266Z] Finished create-virtualenv step (success) 09:29:10 INFO - [mozharness: 2017-09-15 16:29:10.317729Z] Running install step. 09:29:10 INFO - Running pre-action listener: _resource_record_pre_action 09:29:10 INFO - Running main action method: install 09:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:10 INFO - Reading from file tmpfile_stdout 09:29:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:10 INFO - Reading from file tmpfile_stdout 09:29:10 INFO - Output received: 09:29:10 INFO - Usage: mozinstall [options] installer 09:29:10 INFO - Options: 09:29:10 INFO - -h, --help show this help message and exit 09:29:10 INFO - -d DEST, --destination=DEST 09:29:10 INFO - Directory to install application into. [default: 09:29:10 INFO - "/builds/slave/test"] 09:29:10 INFO - --app=APP Application being installed. [default: firefox] 09:29:10 INFO - mkdir: /builds/slave/test/build/application 09:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:29:25 INFO - Reading from file tmpfile_stdout 09:29:25 INFO - Output received: 09:29:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:25 INFO - Running post-action listener: _resource_record_post_action 09:29:25 INFO - [mozharness: 2017-09-15 16:29:25.494125Z] Finished install step (success) 09:29:25 INFO - [mozharness: 2017-09-15 16:29:25.494381Z] Running setup-mitmproxy step. 09:29:25 INFO - Running pre-action listener: _resource_record_pre_action 09:29:25 INFO - Running main action method: setup_mitmproxy 09:29:25 INFO - Skipping: mitmproxy is not required 09:29:25 INFO - Running post-action listener: _resource_record_post_action 09:29:25 INFO - [mozharness: 2017-09-15 16:29:25.495519Z] Finished setup-mitmproxy step (success) 09:29:25 INFO - [mozharness: 2017-09-15 16:29:25.495739Z] Running run-tests step. 09:29:25 INFO - Running pre-action listener: _resource_record_pre_action 09:29:25 INFO - Running pre-action listener: _set_gcov_prefix 09:29:25 INFO - Running main action method: run_tests 09:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:25 INFO - Python 2.7.3 09:29:25 INFO - Return code: 0 09:29:25 INFO - grabbing minidump binary from tooltool 09:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029050>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202a3e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:29:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:29:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:29:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:25 INFO - Return code: 0 09:29:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:25 INFO - ENV: RUST_BACKTRACE is now 1 09:29:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:29:25 INFO - Using env: {'DISPLAY': ':0', 09:29:25 INFO - 'HOME': '/home/cltbld', 09:29:25 INFO - 'LANG': 'en_US.UTF-8', 09:29:25 INFO - 'LANGUAGE': 'en_US:en', 09:29:25 INFO - 'LOGNAME': 'cltbld', 09:29:25 INFO - 'MAIL': '/var/mail/cltbld', 09:29:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:25 INFO - 'MOZ_NO_REMOTE': '1', 09:29:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:25 INFO - 'NO_EM_RESTART': '1', 09:29:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:25 INFO - 'PWD': '/builds/slave/test', 09:29:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:25 INFO - 'RUST_BACKTRACE': '1', 09:29:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:29:25 INFO - 'SHELL': '/bin/bash', 09:29:25 INFO - 'SHLVL': '1', 09:29:25 INFO - 'TERM': 'linux', 09:29:25 INFO - 'TMOUT': '86400', 09:29:25 INFO - 'USER': 'cltbld', 09:29:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672', 09:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:25 INFO - '_': '/tools/buildbot/bin/python'} 09:29:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:29:25 INFO - mozversion application_buildid: 20170915151551 09:29:25 INFO - mozversion application_changeset: 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab 09:29:25 INFO - mozversion application_display_name: Firefox 09:29:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:25 INFO - mozversion application_name: Firefox 09:29:25 INFO - mozversion application_remotingname: firefox 09:29:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:29:25 INFO - mozversion application_vendor: Mozilla 09:29:25 INFO - mozversion application_version: 56.0 09:29:25 INFO - mozversion platform_buildid: 20170915151551 09:29:25 INFO - mozversion platform_changeset: 84e4b6c526bb553d3885ff63a93f5c4a780ca2ab 09:29:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:29:25 INFO - mozversion platform_version: 56.0 09:29:25 INFO - using testdate: 1505492965 09:29:25 INFO - actual date: 1505492965 09:29:25 INFO - starting webserver on 'localhost:49639' 09:29:25 INFO - SUITE-START | Running 2 tests 09:29:25 INFO - TEST-START | dromaeo_css 09:29:25 INFO - Initialising browser for dromaeo_css test... 09:29:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49639/getInfo.html -profile /tmp/tmpgwAHnn/profile 09:29:25 INFO - TEST-INFO | started process 5332 (/builds/slave/test/build/application/firefox/firefox http://localhost:49639/getInfo.html) 09:29:31 INFO - TEST-INFO | 5332: exit 0 09:29:31 INFO - Browser initialized. 09:29:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:29:31 INFO - TEST-INFO | started process 5497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwAHnn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:42 INFO - PID 5497 | RSS: Main: 154492928 09:29:42 INFO - PID 5497 | 09:32:39 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49639/tests/dromaeo/cssquery-ext.html) 09:32:41 INFO - PID 5497 | RSS: Main: 160227328 09:32:41 INFO - PID 5497 | 09:35:42 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-ext.html (next: http://localhost:49639/tests/dromaeo/cssquery-jquery.html) 09:35:43 INFO - PID 5497 | RSS: Main: 157564928 09:35:43 INFO - PID 5497 | 09:38:44 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49639/tests/dromaeo/cssquery-mootools.html) 09:38:45 INFO - PID 5497 | RSS: Main: 159518720 09:38:45 INFO - PID 5497 | 09:41:47 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49639/tests/dromaeo/cssquery-prototype.html) 09:41:47 INFO - PID 5497 | RSS: Main: 159555584 09:41:47 INFO - PID 5497 | 09:44:50 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49639/tests/dromaeo/cssquery-yui.html) 09:44:51 INFO - PID 5497 | RSS: Main: 161304576 09:44:51 INFO - PID 5497 | 09:47:52 INFO - PID 5497 | Cycle 1(1): loaded http://localhost:49639/tests/dromaeo/cssquery-yui.html (next: http://localhost:49639/tests/dromaeo/cssquery-dojo.html) 09:47:53 INFO - PID 5497 | RSS: Main: 164753408 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | __start_tp_report 09:47:53 INFO - PID 5497 | _x_x_mozilla_page_load 09:47:53 INFO - PID 5497 | _x_x_mozilla_page_load_details 09:47:53 INFO - PID 5497 | |i|pagename|runs| 09:47:53 INFO - PID 5497 | |0;dojo.html;3487.2676737885045;3545.2377738786163;3559.786412815233;3591.371509985752;3613.620569840167;6261.46777523911;6310.305866354697;6320.241571011474;6365.363463653626;6374.203224596926;6298.7165577549;6300.149479820223;6382.26603940547;6384.744610215585;6395.424411802936;5432.320959880015;5490.505854473096;5499.780008799643;5545.445455454463;5563.082091454905;5501.834944951658;5507.284053073095;5512.255845460872;5519.061759500894;5543.695096769676;5471.480209380123;5499.807506737265;5554.2779438673115;5566.638168519034;5583.134614134816;5474.069408200616;5515.310586176728;5516.503514683698;5574.749136288877;5579.469950354751;5525.171224316385;5541.6674999499755;5545.334559852803;5565.693886836222;5567.944320556783;6210.223722034746;6219.378062193789;6310.779122730728;6326.93673063268;6344.04839274108;6793.592384456899;6795.286494918012;6845.828854278683;6848.041274221563;6911.5853048816725;6919.584824910471;6979.790606281819;6997.685104170274;7011.123609548807;7031.296870312979;6373.776917807901;6397.840053998687;6433.195850518685;6498.1552398188405;6512.348765123497;6891.483138764513;6896.655167241618;6920.342567456084;6923.238443771181;7142;6728.495362847806;6775.966120169368;6789.524733268624;6794.72821087151;6806.421454176351;6833.863322733617;6846.520743548003;6855.965720171467;6913.827154321182;6925.722971081201;6757.898631520531;6782.864342713118;6796.524243302922;6837.247902730695;6881.8967715484305;6797.286284940109;6823.897641535381;6871.209810871714;6875.415589674833;6903.482238832007;4988.102141614471;5055.393352797614;5057.544820966131;5058.317127187856;5099.158638824552;4430.645548356124;4516.187086324493;4539.477960034572;4549.0447006128425;4563.726176429424;6388.39310265524;6392.872142557123;6399.8080057598345;6406.967965160237;6472.190976127984;6801.115854938926;6808.761693340709;6835.897461538081;6881.311868813079;6938.340857618518;6490.4807615390655;6517.055027021055;6518.120053792677;6518.185226846645;6544.0183972403565;5726.3700992890745;5744.339400968942;5764.164196191528;5806.361300256968;5819.76720931158;6816.318368163144;6937.479689023344;6970.756023539253;7012.403945664573;7078.787636370917;6841.486888483483;6903.171619405603;6907.551009184387;6950.165980082423;6971.895421568782;7015.123109611299;7024.402925751164;7025.613591252531;7101.4673899458785;7102.644867756489;6626.6686665667485;6726.8654626908165;6750.594964302158;6835.829104272433;6849.520533562602;6799.796006119825;6819.147606549182;6858.8285292866085;6897.482688798461;6898.586084834926;6543.967280163569;6550.082988381535;6614.272430032596;6760.08738820253;6779.559328643622;6615.801525954229;6639.004149377632;6642.800715978528;6656.334366563305;6662.067310576426;6635.601863888182;6652.501062420241;6710.865782684416;6727.192736871607;6761.154855643044;6580.8354791130605;6681.09805176295;6723.092382528296;6735.326467353226;6796.388325050769;6404.327545607831;6413.877571424889;6425.58233714807;6457.806265812033;6465.903011454926 09:47:53 INFO - PID 5497 | |1;ext.html;866.0584101781369;910.0717268386246;941.7975135345902;976.3117002513229;978.7504186432459;45067.32399014013;45111;45911.540884591144;46029.07941841165;46044;40935;40953.18093638126;41106.17787644245;41193.79403102988;41220.58779412205;7161.17646470656;7347.191808901017;7351.669174887116;7354.963225183893;7359.190489046201;7268.0914885639295;7347.7795666130105;7357.963210183968;7383.335499805016;7386.778396648109;7360.337569618733;7832.099308579501;8057.798555036113;8063.838723225532;8067.556284404355;7936.44444888858;7951.926489923873;7959.8408031839035;7962.283394494523;7970.163132871081;7730.613469326511;7784.883226751604;7824.256695613907;7842.647080881374;7859.056913170399;42161.36757948633;42532.57467425317;42548;42703.57296427027;42877.78561107206;3576.445650924111;3581.391163502211;3584.4085725855202;3595.065283026432;3612.9883632582655;32277.354452911044;32483.51274730881;32618.184545386317;32836.179095522566;32888.6711132888;5125.103106956268;5195.662281951699;5259.447757985433;5271.736413179326;5276.155815069609;219273.32543360905;220399;222359;223875;234314.99999999828;54334.45665543373;54450;54665.453345466034;54689.453105468434;54701.726491368085;56441.435585643616;56613.71693141508;56952;57053.71473142691;57107.42892571104;16819.32722691103;16948.576285592713;16955.830441695423;16957.236924338435;17007.914960425365;13821.585352439442;13994.510192143227;13999.580012599637;14008.229547374789;14045.227512486706;15698;15727.68544629101;15730.370785168465;15788.684226315409;15797.210139493209;5971.412918970085;6028.276606807123;6035.668038257938;6110.725017374229;6127.387261273926;1101.6970333158445;1108.8059589571792;1108.8225883858706;1115.7880002799604;1127.3292391027326;24760.25719228426;24823.751762482505;24826.875865620557;24941.376465588506;24958.875205623855;1210.9939450302693;1227.1655274413486;1228.705110773408;1234.0682784497826;1235.0490122605543;17588.38440654571;17675.558111047325;17708;17918.820811791975;18042.27830886776;265579;267224;268234;268251;269034;55670.16494752582;55982;56133.71933140308;56169.43830561642;56272.71863640656;1547.3423794887128;1563.1715190948814;1584.5484037049387;1600.8399160083898;1610.2673283656143;29006.27484312909;29363.706362936096;30134;30318;30369;41520.792396037825;41848.58151418569;41879.371809423494;41918.371224431045;41974.160516788885;232661;233302;233693;233744;234654;36608;38884;40672;40919.38620920629;40924.1815163701;50365.489035328996;51599.226011609106;51617.225741613154;51667.483325166264;52036;36559.81720091382;36893.81553092218;37021.44467833039;37042.629573704995;37442.43836342511;36771.26457470889;36944.63055369412;37232.25535489329;37509.81245093866;37577;43459.78270108629;43474.56525434705;43802;43841.123177535635;44122.338164928195;34722;34901.82549087238;34949.65050349464;35156.12109697278;35608.109797255274;27043.72956270491;27272.590911136747;27311.72688273092;27493.17520474389;27746.5838012434 09:47:53 INFO - PID 5497 | |2;jquery.html;597.944627732053;605.2434456928839;608.7899674612257;614.4469977020681;630.7855329188075;23622.527549449;23702.525949481;24162.516749664996;24373.26880193595;24415.511689766194;26647.467050658975;27141.18576442705;27472;27475;27508.312292192706;6266.99728043512;6399.456046236076;6410.23077230733;6424.646644434554;6445.38768816964;6038.33578306386;6286.497080233593;6313.810585682437;6538.509611779135;6562.573432726857;6497.22033355998;6498.772542960997;6504.609723416586;6516.055172000057;6525.836854078639;6480.513961452886;6495;6496.512761542903;6505.512086593524;6514;6049.848753781147;6064.090386442069;6092.208012958331;6110.663913484756;6113.419225173601;31201.37597248065;31457.05628831139;32018;32733.18167045819;32747;2324.1168356024773;2389.6057150570136;2390.1634427950253;2390.3904504351453;2392.9162479313313;20533.38399847992;21153.68269475959;21199.25802596902;21238.150473981023;21258;2384.2966324934187;2451.534208500379;2488.029668429314;2490.452100537879;2499.0378704199015;150670;154081.22959385245;154267.2286638571;154904;157884;15774.60563485899;16190;16572.917135414486;16978.90632810152;16980.830191698173;25603.61594576083;25638.487230255665;25779.226623201335;25898.093566725074;25985.350366240997;11447.08423326132;11650.94174529139;11669.941650291694;11691.824622630667;11770.705732356759;10775.515101820436;10819.729506762236;10866.836997445045;10910.61812836547;10993.175511836644;8395.580220989048;9811.32075471698;9949.80100397988;9971.152452041513;10436.739081523023;2790.972090279112;2851.230167854668;2882.466743652431;2935.9008309059127;2966.3770608172094;1064.8988346107108;1068.7755571329951;1068.8183008888507;1075.1774892207468;1086.9456527173609;21820.672689909665;22103.44741381478;22131.77868221297;22213.22253721112;22499.887500562392;1143.2111842828422;1151.83874257604;1156.67613068341;1157.2246594781516;1162.3607016141088;12116.212446191146;12314.50741970329;12328.383580820922;12380.504779808707;12484.188527745668;555924;556643;558823;563802;597083;135447.32276338554;136834;139209;139278;140558.2972085133;1321.7620828250815;1328.2561765411401;1337.2043634037732;1362.3052243355762;1373.8488766235705;23027.309180724606;23130.306090817303;23590.52818943646;23712.762872371746;24030.75969240285;65024.674876625315;66270;67348.3265167342;68000.97998529927;68221;84500;84708;85585;86246.56876715827;86966.56516717376;15938.60153496172;16036.118013508902;16141.838581614504;16228.432004879773;16238.188090595659;24888.37779055538;24945;25155.119570814935;25193.49613007693;25426.74573254318;19988.400347989584;20458.488537786674;20462.181512739324;20462.897685511478;20696.689549656465;16240.756388653943;16464.917675411547;17057.14714264257;17673.20470578853;18475.63048738991;21438.892805536496;21715.67426488572;21781.23765668194;21949.451263718536;22104.557908841412;16027.118508481679;16112.274947627151;16314.918425407797;16385.34458621642;16434.75347869759;20211.0905009272;20315.492112697302;20501.692474612595;20780;20834.687479687513 09:47:53 INFO - PID 5497 | |3;mootools.html;1508.1780429665832;1549.7699249018938;1554.1685198418847;1570.8429157084292;1573.6301969037281;15696.686066278668;15940.601484962881;16285.75571366429;16322.857399982006;16334.673306533863;16764.497065088035;16883.409080682177;16930.576735581617;16947.57631059221;16959.236834342453;2994.3562134141157;2998.3253767902265;3062.0660698486954;3071.9385612287742;3072.9078127656207;3020.2298413904423;3041.5133578627424;3082.6763189864964;3084.0439463766193;3087.0893086539413;2977.136630377188;2978.1810002249445;3011.638603367588;3012.18670958841;3075.584796052538;2970.0495841330676;2978.731914127739;2982.284251779568;2993.685663005386;3003.6695963444004;2879.5248783950624;2940.808847424932;2956.1574951138823;2959.511680572703;2961.6446026476747;15634.140122293269;15955.601109972227;16017.679646407123;16020.038797672178;16046.679066418606;8620.913790862074;8878.778030549223;8904.73285801427;8913.688020919237;8916.955415222947;5860.300771318985;5962.880742385128;6022.187004754346;6157.415045570664;6188.84527886802;1996.790337014607;2003.9398818035481;2005.7764763494256;2011.5876245369664;2036.531597732515;27707.445851083066;27952.301192470146;27979.440411191867;28006.299842503897;28023.579646305323;7324.414046876237;7521.210272921265;7571.924280757232;7576.4317676174505;7685.923140768521;18969.146388412555;19010.144543495575;19014.61970760577;19030.714539281922;19031.90484047571;8534.103919088531;8752;8776.736697899074;8808.11918808114;8826.205641492297;6912.308769123048;7920.722774702973;7955.761327160194;8059.274665280153;8105.351571874236;5919.052951527735;5939.495142912814;5956.374580669054;6035.39646035393;6066.302375226817;1685.9072750998812;1700.4048582995852;1728.7752592162938;1734.340950438825;1762.8060913299528;964.7732782796037;972.1153750087386;977.53567055648;994;997.8852431970271;8263.256306932404;8264.421490495608;8287.41988060842;8448.23965843077;8469.534175620276;770;783.7296132834163;798.8242586630931;800.2357748350312;805.9758207253792;5219.712915789668;5299.49654782795;5334.91997620036;5339.145736682112;5393.78424863009;22952.540949180922;23778.908741863448;23993.400164995666;24022.51954960891;24023.27930162098;22114;23109.19117830868;23501.764982350298;23518.88240558786;23519.17682881091;12138.332391718364;12405.255684658949;12466.002719782397;12493.56272530439;12517.687057823445;9255.074492550692;9384.67153649619;9432.481213533047;9443.95278023633;9531.57107930131;19317.8068219316;19534.31629892947;19864.50338741543;20226.89886550558;20637.896810515853;20685.482862927944;20693.172273108907;20840.687389688865;20944.68582971287;21075.78924210738;10747.516361763895;11864.406779661154;12326.876731232573;12366.567170149001;12370.567030153901;14809.481668141563;14868.553943381716;14988.625284367541;14989.925050375115;15008.174550399834;12050.493688288963;12188.634340969786;12213.14507984468;12271.447784849524;12350.197237179555;11159.44202789841;11248.887511124783;11359.318440893572;11592.1305902056;11597.304161750322;9905.702828915144;10002.099811017044;10092.495375231356;10112.949435252776;10129.936356682738;7868.52788832649;7909.52542847431;7935.484193527403;7974.003249593801;7987.281144696773;7702.499337543042;7849.646765895434;7865.370770338245;7908.485948413335;7961.920380796118 09:47:53 INFO - PID 5497 | |4;prototype.html;529.6716036057644;529.90726622841;559.734126290012;560.8429639700882;561.2535328013743;6010.459058684717;6049.455549000589;6052.517133302336;6053.152558641783;6086.969565152168;5816.651000939946;5908.586398952075;5952.672603006833;5961.284645842505;5978.641281523101;4726.810927562893;4727.9834835510355;4792.376990991166;4800.639952003597;4813.735244561548;4695.624350052005;4755.262934245197;4774.85675429736;4802;4813.446453657839;4694.530546945312;4698.530146985308;4752.833650822222;4769.236922092466;4777.730577975469;4735.295293694285;4745.810167593292;4760.547747963938;4784.091022705675;4801.375821143229;4311.762853043081;4322.135572885435;4384.890377740582;4394.978025109854;4395.1868904252815;5959.523238140939;5981.880362392728;6000.699965001732;6012.278526576795;6036.486898613623;5710.200571919934;5725.341585717654;5756.798512052058;5797.275340582427;5812.651240925558;6499.545031847772;6541.803745887631;6543.476521878239;6568.80293591193;6578.440832529241;4948.406191257036;4961.826336078256;4983.451820299764;4983.90032199354;4987.476314986947;6722.781482110891;6768.864622707568;6785.558938668971;6856.142982127234;6857.691403886837;5077.898442031213;5085.364329458817;5099.770510327045;5108.438071812097;5108.974455127701;5141.742912854343;5158;5160.277561141368;5182.533571978464;5203.16749320107;5595.160725891067;5650.689212093374;5652.463016013472;5678.176664383641;5750.568707346882;6340.397662222082;6387.297397286295;6413.647249401234;6482.967585162044;6485.935140648533;1694.7118989771768;1719.9422355251431;1730.9614231461023;1773.4059090204669;1791.1492041280549;1242.310517662706;1245.5765039886483;1253.091508656217;1254.6549698832712;1276.3554405025588;5971.731272092767;6133.6319820810895;6170.765846830652;6190.907136392958;6293.465055470245;6562.212534495796;6565.967170164214;6596.4393026592315;6599.406053455212;6671.166104236971;6135.723892424851;6178.876422471525;6197.907031394533;6222.502199824004;6268.341824108403;3476.721862251014;3486.8430920608635;3513.982430087833;3526.8236588171003;3545.1137215696076;6777.525573209828;6798.354156355138;6843;6886.24251332353;6929.203141638776;6674.199096108498;6681.432078273304;6750.966245168841;6790.456763458911;6809.182898052265;6801.387875091166;6816.659167041628;6901.930980690129;6908.343707347894;6918.827029324307;6540.313267107075;6574.389274627747;6627.602343859384;6637.402633762985;6675.332466753286;6480.157579514633;6522.7717029905625;6553.246376666553;6581.934180658132;6627.541940773022;6768.593884366954;6805.89791153143;6839.62382068991;6841.62371069596;6872.278410766998;5069.645124841226;5070.4929507049;5096.796128154832;5103.387593488805;5120.923186152137;6401.3598640135615;6501.122348482894;6627.271000190071;6679.23188833271;6682.665866706742;6294.874102518015;6433.8713225736155;6448;6490.058941453557;6507.577007494498;6446.8388290293115;6457.870842583216;6459.192600924885;6463.866923915003;6468.5472016958365;6196.535259855619;6329.49364050884;6330.936690633035;6447.6131432114225;6471.449926756279;6359.20509936258;6414.454771344488;6439.428006115711;6474.546781725234;6526.869462610626;6191.378043844222;6235.937640623717;6366.745330186741;6378.77674281398;6392.840178995562 09:47:53 INFO - PID 5497 | |5;yui.html;926.3793258516797;961.3030552849184;969.3602222533125;992.7468495533637;994.4878387630376;15892.76160857588;16235.83764162358;16475.2586133624;16881.40915067973;19363.612727745436;19731.309404170857;19983;20098.49753756157;20103;20114.497137571532;1002.8445590933417;1004.1815920025156;1004.6734811186357;1006.3458751811327;1056.2131212246886;988.9109980101789;1085.7719878825455;1087.6736978906335;1090.7436752363187;1093.20742461715;1146.5700362364114;1146.9025132863717;1152.4813833774792;1153.089059642881;1154.3766366162263;1119.8488204092466;1151.228676786555;1152.1071169843356;1155.1682788392345;1155.6648571914134;809.3929552835374;835.4110352201744;842.8314337132537;843.886075379822;844.1178967978477;17877.106144692712;17908.55228619282;18062.36781712647;18226;18252.726209106873;19700.901495492573;19759.40721778349;19785.307514237076;19963;20186.39440816778;15135.697286054217;15439.922800386039;15467.226638668135;15565.22173891301;15637.374505019785;3703.777773333609;3722.3671975764187;3722.9255414891823;3723.2181241939224;3724.7951362675044;141286.29356853254;141820.99999999898;142364;142982;144475.83286250714;16404.425845095364;16667;16708.916455417646;16760.078195699352;16824.242909069122;30740.69259307423;31498.685013150032;31785.52321715176;31958.36083278368;31993.680063199536;8175.877361839577;8317.750467485985;9296.30277729173;9312.813743725088;9549.379290346105;4223.13425747721;4263.658907287409;4264.402983582301;4284.785760712014;4289.120730250291;5775.768969241268;5803.071508558611;5821.27234095738;5868.413158684183;5912.822615321547;1146.7591805720892;1172.7302720374191;1192.803187474057;1196.1208511743862;1196.5752157983964;736.4329466310911;754.7358424551472;757.0650246945019;768.6771555946516;777.4014009212874;12858.678533036562;13433.66415839612;13438.731225375437;14017.789733154012;14156;734.8824188129873;742.254034695128;742.7029188324714;743.3644234179807;759.1914610939332;6819.624920629413;6982.895256571155;7051.294870512907;7327.706891724271;7398.149212840484;126954.65226738626;129746;131886;132056;132221;112268;112854;116493.41753291179;117031;120529;95568;96396.51801741087;96507;97260;98689.847564012;13058.281794501014;13198.538051168547;13223.140495867738;13251.933740331237;13278;46293.07413851637;46923.765381172874;47529;48347.516524834304;49118.75440622774;61648;61932;62188.68905655443;63188.68405657943;63639;18246;18369.448916532525;18413.631727365646;18482.445526634223;18765.718514222026;22434.887825560767;22747.203847865247;22781.088756449557;22878.656820148044;23249.070037198322;19337.8066219336;19907.701384479533;19947.800521994595;19965.60068798645;20082.196712131936;20094.89952550228;20333.694994575388;21317.786822132202;22009.449763756034;22231.77768222362;19277.421677349703;19534;19556.315528956417;19645.31241406544;19705.211791528178;13877.583672489438;13964.650883727989;14129.505467308594;14457.421703131757;15500.767488487456;14752.55742327732;15501.534953951399;15562.610934726723;15694.9215253923;16363.345466181696 09:47:53 INFO - PID 5497 | __end_tp_report 09:47:53 INFO - PID 5497 | __start_cc_report 09:47:53 INFO - PID 5497 | _x_x_mozilla_cycle_collect,305 09:47:53 INFO - PID 5497 | __end_cc_report 09:47:53 INFO - PID 5497 | __startTimestamp1505494073240__endTimestamp 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | ------- Summary: start ------- 09:47:53 INFO - PID 5497 | Number of tests: 6 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#0] dojo.html Cycles:165 Average:6287.94 Median:6580.84 stddev:795.73 (12.1%) stddev-sans-first:767.24 09:47:53 INFO - PID 5497 | Values: 3487.3 3545.2 3559.8 3591.4 3613.6 6261.5 6310.3 6320.2 6365.4 6374.2 6298.7 6300.1 6382.3 6384.7 6395.4 5432.3 5490.5 5499.8 5545.4 5563.1 5501.8 5507.3 5512.3 5519.1 5543.7 5471.5 5499.8 5554.3 5566.6 5583.1 5474.1 5515.3 5516.5 5574.7 5579.5 5525.2 5541.7 5545.3 5565.7 5567.9 6210.2 6219.4 6310.8 6326.9 6344.0 6793.6 6795.3 6845.8 6848.0 6911.6 6919.6 6979.8 6997.7 7011.1 7031.3 6373.8 6397.8 6433.2 6498.2 6512.3 6891.5 6896.7 6920.3 6923.2 7142.0 6728.5 6776.0 6789.5 6794.7 6806.4 6833.9 6846.5 6856.0 6913.8 6925.7 6757.9 6782.9 6796.5 6837.2 6881.9 6797.3 6823.9 6871.2 6875.4 6903.5 4988.1 5055.4 5057.5 5058.3 5099.2 4430.6 4516.2 4539.5 4549.0 4563.7 6388.4 6392.9 6399.8 6407.0 6472.2 6801.1 6808.8 6835.9 6881.3 6938.3 6490.5 6517.1 6518.1 6518.2 6544.0 5726.4 5744.3 5764.2 5806.4 5819.8 6816.3 6937.5 6970.8 7012.4 7078.8 6841.5 6903.2 6907.6 6950.2 6971.9 7015.1 7024.4 7025.6 7101.5 7102.6 6626.7 6726.9 6750.6 6835.8 6849.5 6799.8 6819.1 6858.8 6897.5 6898.6 6544.0 6550.1 6614.3 6760.1 6779.6 6615.8 6639.0 6642.8 6656.3 6662.1 6635.6 6652.5 6710.9 6727.2 6761.2 6580.8 6681.1 6723.1 6735.3 6796.4 6404.3 6413.9 6425.6 6457.8 6465.9 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#1] ext.html Cycles:180 Average:42919.75 Median:38230.50 stddev:62906.94 (164.5%) stddev-sans-first:63004.16 09:47:53 INFO - PID 5497 | Values: 866.1 910.1 941.8 976.3 978.8 45067.3 45111.0 45911.5 46029.1 46044.0 40935.0 40953.2 41106.2 41193.8 41220.6 7161.2 7347.2 7351.7 7355.0 7359.2 7268.1 7347.8 7358.0 7383.3 7386.8 7360.3 7832.1 8057.8 8063.8 8067.6 7936.4 7951.9 7959.8 7962.3 7970.2 7730.6 7784.9 7824.3 7842.6 7859.1 42161.4 42532.6 42548.0 42703.6 42877.8 3576.4 3581.4 3584.4 3595.1 3613.0 32277.4 32483.5 32618.2 32836.2 32888.7 5125.1 5195.7 5259.4 5271.7 5276.2 219273.3 220399.0 222359.0 223875.0 234315.0 54334.5 54450.0 54665.5 54689.5 54701.7 56441.4 56613.7 56952.0 57053.7 57107.4 16819.3 16948.6 16955.8 16957.2 17007.9 13821.6 13994.5 13999.6 14008.2 14045.2 15698.0 15727.7 15730.4 15788.7 15797.2 5971.4 6028.3 6035.7 6110.7 6127.4 1101.7 1108.8 1108.8 1115.8 1127.3 24760.3 24823.8 24826.9 24941.4 24958.9 1211.0 1227.2 1228.7 1234.1 1235.0 17588.4 17675.6 17708.0 17918.8 18042.3 265579.0 267224.0 268234.0 268251.0 269034.0 55670.2 55982.0 56133.7 56169.4 56272.7 1547.3 1563.2 1584.5 1600.8 1610.3 29006.3 29363.7 30134.0 30318.0 30369.0 41520.8 41848.6 41879.4 41918.4 41974.2 232661.0 233302.0 233693.0 233744.0 234654.0 36608.0 38884.0 40672.0 40919.4 40924.2 50365.5 51599.2 51617.2 51667.5 52036.0 36559.8 36893.8 37021.4 37042.6 37442.4 36771.3 36944.6 37232.3 37509.8 37577.0 43459.8 43474.6 43802.0 43841.1 44122.3 34722.0 34901.8 34949.7 35156.1 35608.1 27043.7 27272.6 27311.7 27493.2 27746.6 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#2] jquery.html Cycles:180 Average:39714.22 Median:23662.53 stddev:95626.00 (404.1%) stddev-sans-first:95849.16 09:47:53 INFO - PID 5497 | Values: 597.9 605.2 608.8 614.4 630.8 23622.5 23702.5 24162.5 24373.3 24415.5 26647.5 27141.2 27472.0 27475.0 27508.3 6267.0 6399.5 6410.2 6424.6 6445.4 6038.3 6286.5 6313.8 6538.5 6562.6 6497.2 6498.8 6504.6 6516.1 6525.8 6480.5 6495.0 6496.5 6505.5 6514.0 6049.8 6064.1 6092.2 6110.7 6113.4 31201.4 31457.1 32018.0 32733.2 32747.0 2324.1 2389.6 2390.2 2390.4 2392.9 20533.4 21153.7 21199.3 21238.2 21258.0 2384.3 2451.5 2488.0 2490.5 2499.0 150670.0 154081.2 154267.2 154904.0 157884.0 15774.6 16190.0 16572.9 16978.9 16980.8 25603.6 25638.5 25779.2 25898.1 25985.4 11447.1 11650.9 11669.9 11691.8 11770.7 10775.5 10819.7 10866.8 10910.6 10993.2 8395.6 9811.3 9949.8 9971.2 10436.7 2791.0 2851.2 2882.5 2935.9 2966.4 1064.9 1068.8 1068.8 1075.2 1086.9 21820.7 22103.4 22131.8 22213.2 22499.9 1143.2 1151.8 1156.7 1157.2 1162.4 12116.2 12314.5 12328.4 12380.5 12484.2 555924.0 556643.0 558823.0 563802.0 597083.0 135447.3 136834.0 139209.0 139278.0 140558.3 1321.8 1328.3 1337.2 1362.3 1373.8 23027.3 23130.3 23590.5 23712.8 24030.8 65024.7 66270.0 67348.3 68001.0 68221.0 84500.0 84708.0 85585.0 86246.6 86966.6 15938.6 16036.1 16141.8 16228.4 16238.2 24888.4 24945.0 25155.1 25193.5 25426.7 19988.4 20458.5 20462.2 20462.9 20696.7 16240.8 16464.9 17057.1 17673.2 18475.6 21438.9 21715.7 21781.2 21949.5 22104.6 16027.1 16112.3 16314.9 16385.3 16434.8 20211.1 20315.5 20501.7 20780.0 20834.7 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#3] mootools.html Cycles:180 Average:10066.36 Median:2948.48 stddev:7163.67 (243.0%) stddev-sans-first:7154.91 09:47:53 INFO - PID 5497 | Values: 1508.2 1549.8 1554.2 1570.8 1573.6 15696.7 15940.6 16285.8 16322.9 16334.7 16764.5 16883.4 16930.6 16947.6 16959.2 2994.4 2998.3 3062.1 3071.9 3072.9 3020.2 3041.5 3082.7 3084.0 3087.1 2977.1 2978.2 3011.6 3012.2 3075.6 2970.0 2978.7 2982.3 2993.7 3003.7 2879.5 2940.8 2956.2 2959.5 2961.6 15634.1 15955.6 16017.7 16020.0 16046.7 8620.9 8878.8 8904.7 8913.7 8917.0 5860.3 5962.9 6022.2 6157.4 6188.8 1996.8 2003.9 2005.8 2011.6 2036.5 27707.4 27952.3 27979.4 28006.3 28023.6 7324.4 7521.2 7571.9 7576.4 7685.9 18969.1 19010.1 19014.6 19030.7 19031.9 8534.1 8752.0 8776.7 8808.1 8826.2 6912.3 7920.7 7955.8 8059.3 8105.4 5919.1 5939.5 5956.4 6035.4 6066.3 1685.9 1700.4 1728.8 1734.3 1762.8 964.8 972.1 977.5 994.0 997.9 8263.3 8264.4 8287.4 8448.2 8469.5 770.0 783.7 798.8 800.2 806.0 5219.7 5299.5 5334.9 5339.1 5393.8 22952.5 23778.9 23993.4 24022.5 24023.3 22114.0 23109.2 23501.8 23518.9 23519.2 12138.3 12405.3 12466.0 12493.6 12517.7 9255.1 9384.7 9432.5 9444.0 9531.6 19317.8 19534.3 19864.5 20226.9 20637.9 20685.5 20693.2 20840.7 20944.7 21075.8 10747.5 11864.4 12326.9 12366.6 12370.6 14809.5 14868.6 14988.6 14989.9 15008.2 12050.5 12188.6 12213.1 12271.4 12350.2 11159.4 11248.9 11359.3 11592.1 11597.3 9905.7 10002.1 10092.5 10112.9 10129.9 7868.5 7909.5 7935.5 7974.0 7987.3 7702.5 7849.6 7865.4 7908.5 7961.9 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#4] prototype.html Cycles:180 Average:5498.31 Median:6110.30 stddev:1550.50 (25.4%) stddev-sans-first:1509.34 09:47:53 INFO - PID 5497 | Values: 529.7 529.9 559.7 560.8 561.3 6010.5 6049.5 6052.5 6053.2 6087.0 5816.7 5908.6 5952.7 5961.3 5978.6 4726.8 4728.0 4792.4 4800.6 4813.7 4695.6 4755.3 4774.9 4802.0 4813.4 4694.5 4698.5 4752.8 4769.2 4777.7 4735.3 4745.8 4760.5 4784.1 4801.4 4311.8 4322.1 4384.9 4395.0 4395.2 5959.5 5981.9 6000.7 6012.3 6036.5 5710.2 5725.3 5756.8 5797.3 5812.7 6499.5 6541.8 6543.5 6568.8 6578.4 4948.4 4961.8 4983.5 4983.9 4987.5 6722.8 6768.9 6785.6 6856.1 6857.7 5077.9 5085.4 5099.8 5108.4 5109.0 5141.7 5158.0 5160.3 5182.5 5203.2 5595.2 5650.7 5652.5 5678.2 5750.6 6340.4 6387.3 6413.6 6483.0 6485.9 1694.7 1719.9 1731.0 1773.4 1791.1 1242.3 1245.6 1253.1 1254.7 1276.4 5971.7 6133.6 6170.8 6190.9 6293.5 6562.2 6566.0 6596.4 6599.4 6671.2 6135.7 6178.9 6197.9 6222.5 6268.3 3476.7 3486.8 3514.0 3526.8 3545.1 6777.5 6798.4 6843.0 6886.2 6929.2 6674.2 6681.4 6751.0 6790.5 6809.2 6801.4 6816.7 6901.9 6908.3 6918.8 6540.3 6574.4 6627.6 6637.4 6675.3 6480.2 6522.8 6553.2 6581.9 6627.5 6768.6 6805.9 6839.6 6841.6 6872.3 5069.6 5070.5 5096.8 5103.4 5120.9 6401.4 6501.1 6627.3 6679.2 6682.7 6294.9 6433.9 6448.0 6490.1 6507.6 6446.8 6457.9 6459.2 6463.9 6468.5 6196.5 6329.5 6330.9 6447.6 6471.4 6359.2 6414.5 6439.4 6474.5 6526.9 6191.4 6235.9 6366.7 6378.8 6392.8 09:47:53 INFO - PID 5497 | 09:47:53 INFO - PID 5497 | [#5] yui.html Cycles:180 Average:25889.48 Median:19718.26 stddev:36723.04 (186.2%) stddev-sans-first:36778.22 09:47:53 INFO - PID 5497 | Values: 926.4 961.3 969.4 992.7 994.5 15892.8 16235.8 16475.3 16881.4 19363.6 19731.3 19983.0 20098.5 20103.0 20114.5 1002.8 1004.2 1004.7 1006.3 1056.2 988.9 1085.8 1087.7 1090.7 1093.2 1146.6 1146.9 1152.5 1153.1 1154.4 1119.8 1151.2 1152.1 1155.2 1155.7 809.4 835.4 842.8 843.9 844.1 17877.1 17908.6 18062.4 18226.0 18252.7 19700.9 19759.4 19785.3 19963.0 20186.4 15135.7 15439.9 15467.2 15565.2 15637.4 3703.8 3722.4 3722.9 3723.2 3724.8 141286.3 141821.0 142364.0 142982.0 144475.8 16404.4 16667.0 16708.9 16760.1 16824.2 30740.7 31498.7 31785.5 31958.4 31993.7 8175.9 8317.8 9296.3 9312.8 9549.4 4223.1 4263.7 4264.4 4284.8 4289.1 5775.8 5803.1 5821.3 5868.4 5912.8 1146.8 1172.7 1192.8 1196.1 1196.6 736.4 754.7 757.1 768.7 777.4 12858.7 13433.7 13438.7 14017.8 14156.0 734.9 742.3 742.7 743.4 759.2 6819.6 6982.9 7051.3 7327.7 7398.1 126954.7 129746.0 131886.0 132056.0 132221.0 112268.0 112854.0 116493.4 117031.0 120529.0 95568.0 96396.5 96507.0 97260.0 98689.8 13058.3 13198.5 13223.1 13251.9 13278.0 46293.1 46923.8 47529.0 48347.5 49118.8 61648.0 61932.0 62188.7 63188.7 63639.0 18246.0 18369.4 18413.6 18482.4 18765.7 22434.9 22747.2 22781.1 22878.7 23249.1 19337.8 19907.7 19947.8 19965.6 20082.2 20094.9 20333.7 21317.8 22009.4 22231.8 19277.4 19534.0 19556.3 19645.3 19705.2 13877.6 13964.7 14129.5 14457.4 15500.8 14752.6 15501.5 15562.6 15694.9 16363.3 09:47:53 INFO - PID 5497 | -------- Summary: end -------- 09:47:53 INFO - PID 5497 | 09:47:53 INFO - TEST-INFO | 5497: exit 0 09:47:53 INFO - TEST-OK | dromaeo_css | took 1107972ms 09:47:53 INFO - TEST-START | kraken 09:47:53 INFO - Initialising browser for kraken test... 09:47:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49639/getInfo.html -profile /tmp/tmpzr3iXb/profile 09:47:53 INFO - TEST-INFO | started process 5860 (/builds/slave/test/build/application/firefox/firefox http://localhost:49639/getInfo.html) 09:47:58 INFO - TEST-INFO | 5860: exit 0 09:47:58 INFO - Browser initialized. 09:47:58 INFO - Running cycle 1/1 for kraken test... 09:47:58 INFO - TEST-INFO | started process 6026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzr3iXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:10 INFO - PID 6026 | RSS: Main: 152145920 09:48:10 INFO - PID 6026 | 09:48:12 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49639/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:13 INFO - PID 6026 | RSS: Main: 159313920 09:48:13 INFO - PID 6026 | 09:48:16 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49639/tests/kraken/driver.html?testName=audio-dft) 09:48:16 INFO - PID 6026 | RSS: Main: 160337920 09:48:16 INFO - PID 6026 | 09:48:19 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49639/tests/kraken/driver.html?testName=audio-fft) 09:48:20 INFO - PID 6026 | RSS: Main: 160395264 09:48:20 INFO - PID 6026 | 09:48:22 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49639/tests/kraken/driver.html?testName=audio-oscillator) 09:48:22 INFO - PID 6026 | RSS: Main: 160190464 09:48:22 INFO - PID 6026 | 09:48:25 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:48:25 INFO - PID 6026 | RSS: Main: 160018432 09:48:25 INFO - PID 6026 | 09:48:28 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49639/tests/kraken/driver.html?testName=imaging-darkroom) 09:48:29 INFO - PID 6026 | RSS: Main: 160071680 09:48:29 INFO - PID 6026 | 09:48:32 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49639/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:33 INFO - PID 6026 | RSS: Main: 162942976 09:48:33 INFO - PID 6026 | 09:48:35 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49639/tests/kraken/driver.html?testName=json-parse-financial) 09:48:36 INFO - PID 6026 | RSS: Main: 163418112 09:48:36 INFO - PID 6026 | 09:48:38 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:48:38 INFO - PID 6026 | RSS: Main: 163008512 09:48:38 INFO - PID 6026 | 09:48:40 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:48:41 INFO - PID 6026 | RSS: Main: 163295232 09:48:41 INFO - PID 6026 | 09:48:43 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:48:43 INFO - PID 6026 | RSS: Main: 162705408 09:48:43 INFO - PID 6026 | 09:48:46 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:48:46 INFO - PID 6026 | RSS: Main: 163520512 09:48:46 INFO - PID 6026 | 09:48:49 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:48:50 INFO - PID 6026 | RSS: Main: 163799040 09:48:50 INFO - PID 6026 | 09:48:51 INFO - PID 6026 | Cycle 1(1): loaded http://localhost:49639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49639/tests/kraken/driver.html?testName=ai-astar) 09:48:52 INFO - PID 6026 | RSS: Main: 165154816 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | __start_tp_report 09:48:52 INFO - PID 6026 | _x_x_mozilla_page_load 09:48:52 INFO - PID 6026 | _x_x_mozilla_page_load_details 09:48:52 INFO - PID 6026 | |i|pagename|runs| 09:48:52 INFO - PID 6026 | |0;ai-astar;96;105;100;106;106;109;109;100;106;106 09:48:52 INFO - PID 6026 | |1;audio-beat-detection;145;115;147;171;117;142;143;113;163;120 09:48:52 INFO - PID 6026 | |2;audio-dft;162;162;162;164;163;162;164;160;163;162 09:48:52 INFO - PID 6026 | |3;audio-fft;76;75;74;196;76;74;73;76;175;76 09:48:52 INFO - PID 6026 | |4;audio-oscillator;78;77;121;77;78;78;124;77;78;136 09:48:52 INFO - PID 6026 | |5;imaging-gaussian-blur;114;114;114;114;116;114;114;114;114;113 09:48:52 INFO - PID 6026 | |6;imaging-darkroom;148;148;148;147;147;151;147;149;147;148 09:48:52 INFO - PID 6026 | |7;imaging-desaturate;93;95;94;94;94;94;94;95;94;94 09:48:52 INFO - PID 6026 | |8;json-parse-financial;46;45;45;45;45;45;47;45;47;47 09:48:52 INFO - PID 6026 | |9;json-stringify-tinderbox;53;53;53;53;57;52;53;53;53;52 09:48:52 INFO - PID 6026 | |10;stanford-crypto-aes;77;80;74;76;73;73;73;73;75;75 09:48:52 INFO - PID 6026 | |11;stanford-crypto-ccm;133;115;115;139;122;119;117;120;119;145 09:48:52 INFO - PID 6026 | |12;stanford-crypto-pbkdf2;163;166;164;157;164;157;154;169;158;159 09:48:52 INFO - PID 6026 | |13;stanford-crypto-sha256-iterative;59;59;61;59;60;59;59;57;57;59 09:48:52 INFO - PID 6026 | __end_tp_report 09:48:52 INFO - PID 6026 | __start_cc_report 09:48:52 INFO - PID 6026 | _x_x_mozilla_cycle_collect,840 09:48:52 INFO - PID 6026 | __end_cc_report 09:48:52 INFO - PID 6026 | __startTimestamp1505494132231__endTimestamp 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | ------- Summary: start ------- 09:48:52 INFO - PID 6026 | Number of tests: 14 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#0] ai-astar Cycles:10 Average:104.30 Median:106.00 stddev:4.24 (4.0%) stddev-sans-first:3.27 09:48:52 INFO - PID 6026 | Values: 96.0 105.0 100.0 106.0 106.0 109.0 109.0 100.0 106.0 106.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:144.00 stddev:20.55 (14.3%) stddev-sans-first:21.63 09:48:52 INFO - PID 6026 | Values: 145.0 115.0 147.0 171.0 117.0 142.0 143.0 113.0 163.0 120.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:48:52 INFO - PID 6026 | Values: 162.0 162.0 162.0 164.0 163.0 162.0 164.0 160.0 163.0 162.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#3] audio-fft Cycles:10 Average:97.10 Median:75.50 stddev:46.86 (62.1%) stddev-sans-first:49.08 09:48:52 INFO - PID 6026 | Values: 76.0 75.0 74.0 196.0 76.0 74.0 73.0 76.0 175.0 76.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:77.50 stddev:24.17 (31.2%) stddev-sans-first:25.07 09:48:52 INFO - PID 6026 | Values: 78.0 77.0 121.0 77.0 78.0 78.0 124.0 77.0 78.0 136.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:48:52 INFO - PID 6026 | Values: 114.0 114.0 114.0 114.0 116.0 114.0 114.0 114.0 114.0 113.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 09:48:52 INFO - PID 6026 | Values: 148.0 148.0 148.0 147.0 147.0 151.0 147.0 149.0 147.0 148.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 09:48:52 INFO - PID 6026 | Values: 93.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:45.50 stddev:0.95 (2.1%) stddev-sans-first:1.00 09:48:52 INFO - PID 6026 | Values: 46.0 45.0 45.0 45.0 45.0 45.0 47.0 45.0 47.0 47.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#9] json-stringify-tinderbox Cycles:10 Average:53.20 Median:53.00 stddev:1.40 (2.6%) stddev-sans-first:1.48 09:48:52 INFO - PID 6026 | Values: 53.0 53.0 53.0 53.0 57.0 52.0 53.0 53.0 53.0 52.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:2.28 (3.0%) stddev-sans-first:2.29 09:48:52 INFO - PID 6026 | Values: 77.0 80.0 74.0 76.0 73.0 73.0 73.0 73.0 75.0 75.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:121.00 stddev:10.68 (8.8%) stddev-sans-first:10.86 09:48:52 INFO - PID 6026 | Values: 133.0 115.0 115.0 139.0 122.0 119.0 117.0 120.0 119.0 145.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:163.50 stddev:4.77 (2.9%) stddev-sans-first:5.01 09:48:52 INFO - PID 6026 | Values: 163.0 166.0 164.0 157.0 164.0 157.0 154.0 169.0 158.0 159.0 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.90 Median:59.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 09:48:52 INFO - PID 6026 | Values: 59.0 59.0 61.0 59.0 60.0 59.0 59.0 57.0 57.0 59.0 09:48:52 INFO - PID 6026 | -------- Summary: end -------- 09:48:52 INFO - PID 6026 | 09:48:52 INFO - PID 6026 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:48:52 INFO - TEST-INFO | 6026: exit 0 09:48:52 INFO - TEST-OK | kraken | took 59106ms 09:48:52 INFO - SUITE-END | took 1167s 09:48:53 INFO - Completed test suite (00:19:27) 09:48:53 INFO - javascript benchmark 09:48:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9048.724437861894, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3487.2676737885045, 3545.2377738786163, 3559.786412815233, 3591.371509985752, 3613.620569840167, 6261.46777523911, 6310.305866354697, 6320.241571011474, 6365.363463653626, 6374.203224596926, 6298.7165577549, 6300.149479820223, 6382.26603940547, 6384.744610215585, 6395.424411802936, 5432.320959880015, 5490.505854473096, 5499.780008799643, 5545.445455454463, 5563.082091454905, 5501.834944951658, 5507.284053073095, 5512.255845460872, 5519.061759500894, 5543.695096769676, 5471.480209380123, 5499.807506737265, 5554.2779438673115, 5566.638168519034, 5583.134614134816, 5474.069408200616, 5515.310586176728, 5516.503514683698, 5574.749136288877, 5579.469950354751, 5525.171224316385, 5541.6674999499755, 5545.334559852803, 5565.693886836222, 5567.944320556783, 6210.223722034746, 6219.378062193789, 6310.779122730728, 6326.93673063268, 6344.04839274108, 6793.592384456899, 6795.286494918012, 6845.828854278683, 6848.041274221563, 6911.5853048816725, 6919.584824910471, 6979.790606281819, 6997.685104170274, 7011.123609548807, 7031.296870312979, 6373.776917807901, 6397.840053998687, 6433.195850518685, 6498.1552398188405, 6512.348765123497, 6891.483138764513, 6896.655167241618, 6920.342567456084, 6923.238443771181, 7142.0, 6728.495362847806, 6775.966120169368, 6789.524733268624, 6794.72821087151, 6806.421454176351, 6833.863322733617, 6846.520743548003, 6855.965720171467, 6913.827154321182, 6925.722971081201, 6757.898631520531, 6782.864342713118, 6796.524243302922, 6837.247902730695, 6881.8967715484305, 6797.286284940109, 6823.897641535381, 6871.209810871714, 6875.415589674833, 6903.482238832007, 4988.102141614471, 5055.393352797614, 5057.544820966131, 5058.317127187856, 5099.158638824552, 4430.645548356124, 4516.187086324493, 4539.477960034572, 4549.0447006128425, 4563.726176429424, 6388.39310265524, 6392.872142557123, 6399.8080057598345, 6406.967965160237, 6472.190976127984, 6801.115854938926, 6808.761693340709, 6835.897461538081, 6881.311868813079, 6938.340857618518, 6490.4807615390655, 6517.055027021055, 6518.120053792677, 6518.185226846645, 6544.0183972403565, 5726.3700992890745, 5744.339400968942, 5764.164196191528, 5806.361300256968, 5819.76720931158, 6816.318368163144, 6937.479689023344, 6970.756023539253, 7012.403945664573, 7078.787636370917, 6841.486888483483, 6903.171619405603, 6907.551009184387, 6950.165980082423, 6971.895421568782, 7015.123109611299, 7024.402925751164, 7025.613591252531, 7101.4673899458785, 7102.644867756489, 6626.6686665667485, 6726.8654626908165, 6750.594964302158, 6835.829104272433, 6849.520533562602, 6799.796006119825, 6819.147606549182, 6858.8285292866085, 6897.482688798461, 6898.586084834926, 6543.967280163569, 6550.082988381535, 6614.272430032596, 6760.08738820253, 6779.559328643622, 6615.801525954229, 6639.004149377632, 6642.800715978528, 6656.334366563305, 6662.067310576426, 6635.601863888182, 6652.501062420241, 6710.865782684416, 6727.192736871607, 6761.154855643044, 6580.8354791130605, 6681.09805176295, 6723.092382528296, 6735.326467353226, 6796.388325050769, 6404.327545607831, 6413.877571424889, 6425.58233714807, 6457.806265812033, 6465.903011454926], "value": 6228.319571753354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.0584101781369, 910.0717268386246, 941.7975135345902, 976.3117002513229, 978.7504186432459, 45067.32399014013, 45111.0, 45911.540884591144, 46029.07941841165, 46044.0, 40935.0, 40953.18093638126, 41106.17787644245, 41193.79403102988, 41220.58779412205, 7161.17646470656, 7347.191808901017, 7351.669174887116, 7354.963225183893, 7359.190489046201, 7268.0914885639295, 7347.7795666130105, 7357.963210183968, 7383.335499805016, 7386.778396648109, 7360.337569618733, 7832.099308579501, 8057.798555036113, 8063.838723225532, 8067.556284404355, 7936.44444888858, 7951.926489923873, 7959.8408031839035, 7962.283394494523, 7970.163132871081, 7730.613469326511, 7784.883226751604, 7824.256695613907, 7842.647080881374, 7859.056913170399, 42161.36757948633, 42532.57467425317, 42548.0, 42703.57296427027, 42877.78561107206, 3576.445650924111, 3581.391163502211, 3584.4085725855202, 3595.065283026432, 3612.9883632582655, 32277.354452911044, 32483.51274730881, 32618.184545386317, 32836.179095522566, 32888.6711132888, 5125.103106956268, 5195.662281951699, 5259.447757985433, 5271.736413179326, 5276.155815069609, 219273.32543360905, 220399.0, 222359.0, 223875.0, 234314.99999999828, 54334.45665543373, 54450.0, 54665.453345466034, 54689.453105468434, 54701.726491368085, 56441.435585643616, 56613.71693141508, 56952.0, 57053.71473142691, 57107.42892571104, 16819.32722691103, 16948.576285592713, 16955.830441695423, 16957.236924338435, 17007.914960425365, 13821.585352439442, 13994.510192143227, 13999.580012599637, 14008.229547374789, 14045.227512486706, 15698.0, 15727.68544629101, 15730.370785168465, 15788.684226315409, 15797.210139493209, 5971.412918970085, 6028.276606807123, 6035.668038257938, 6110.725017374229, 6127.387261273926, 1101.6970333158445, 1108.8059589571792, 1108.8225883858706, 1115.7880002799604, 1127.3292391027326, 24760.25719228426, 24823.751762482505, 24826.875865620557, 24941.376465588506, 24958.875205623855, 1210.9939450302693, 1227.1655274413486, 1228.705110773408, 1234.0682784497826, 1235.0490122605543, 17588.38440654571, 17675.558111047325, 17708.0, 17918.820811791975, 18042.27830886776, 265579.0, 267224.0, 268234.0, 268251.0, 269034.0, 55670.16494752582, 55982.0, 56133.71933140308, 56169.43830561642, 56272.71863640656, 1547.3423794887128, 1563.1715190948814, 1584.5484037049387, 1600.8399160083898, 1610.2673283656143, 29006.27484312909, 29363.706362936096, 30134.0, 30318.0, 30369.0, 41520.792396037825, 41848.58151418569, 41879.371809423494, 41918.371224431045, 41974.160516788885, 232661.0, 233302.0, 233693.0, 233744.0, 234654.0, 36608.0, 38884.0, 40672.0, 40919.38620920629, 40924.1815163701, 50365.489035328996, 51599.226011609106, 51617.225741613154, 51667.483325166264, 52036.0, 36559.81720091382, 36893.81553092218, 37021.44467833039, 37042.629573704995, 37442.43836342511, 36771.26457470889, 36944.63055369412, 37232.25535489329, 37509.81245093866, 37577.0, 43459.78270108629, 43474.56525434705, 43802.0, 43841.123177535635, 44122.338164928195, 34722.0, 34901.82549087238, 34949.65050349464, 35156.12109697278, 35608.109797255274, 27043.72956270491, 27272.590911136747, 27311.72688273092, 27493.17520474389, 27746.5838012434], "value": 18918.5290619362, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.944627732053, 605.2434456928839, 608.7899674612257, 614.4469977020681, 630.7855329188075, 23622.527549449, 23702.525949481, 24162.516749664996, 24373.26880193595, 24415.511689766194, 26647.467050658975, 27141.18576442705, 27472.0, 27475.0, 27508.312292192706, 6266.99728043512, 6399.456046236076, 6410.23077230733, 6424.646644434554, 6445.38768816964, 6038.33578306386, 6286.497080233593, 6313.810585682437, 6538.509611779135, 6562.573432726857, 6497.22033355998, 6498.772542960997, 6504.609723416586, 6516.055172000057, 6525.836854078639, 6480.513961452886, 6495.0, 6496.512761542903, 6505.512086593524, 6514.0, 6049.848753781147, 6064.090386442069, 6092.208012958331, 6110.663913484756, 6113.419225173601, 31201.37597248065, 31457.05628831139, 32018.0, 32733.18167045819, 32747.0, 2324.1168356024773, 2389.6057150570136, 2390.1634427950253, 2390.3904504351453, 2392.9162479313313, 20533.38399847992, 21153.68269475959, 21199.25802596902, 21238.150473981023, 21258.0, 2384.2966324934187, 2451.534208500379, 2488.029668429314, 2490.452100537879, 2499.0378704199015, 150670.0, 154081.22959385245, 154267.2286638571, 154904.0, 157884.0, 15774.60563485899, 16190.0, 16572.917135414486, 16978.90632810152, 16980.830191698173, 25603.61594576083, 25638.487230255665, 25779.226623201335, 25898.093566725074, 25985.350366240997, 11447.08423326132, 11650.94174529139, 11669.941650291694, 11691.824622630667, 11770.705732356759, 10775.515101820436, 10819.729506762236, 10866.836997445045, 10910.61812836547, 10993.175511836644, 8395.580220989048, 9811.32075471698, 9949.80100397988, 9971.152452041513, 10436.739081523023, 2790.972090279112, 2851.230167854668, 2882.466743652431, 2935.9008309059127, 2966.3770608172094, 1064.8988346107108, 1068.7755571329951, 1068.8183008888507, 1075.1774892207468, 1086.9456527173609, 21820.672689909665, 22103.44741381478, 22131.77868221297, 22213.22253721112, 22499.887500562392, 1143.2111842828422, 1151.83874257604, 1156.67613068341, 1157.2246594781516, 1162.3607016141088, 12116.212446191146, 12314.50741970329, 12328.383580820922, 12380.504779808707, 12484.188527745668, 555924.0, 556643.0, 558823.0, 563802.0, 597083.0, 135447.32276338554, 136834.0, 139209.0, 139278.0, 140558.2972085133, 1321.7620828250815, 1328.2561765411401, 1337.2043634037732, 1362.3052243355762, 1373.8488766235705, 23027.309180724606, 23130.306090817303, 23590.52818943646, 23712.762872371746, 24030.75969240285, 65024.674876625315, 66270.0, 67348.3265167342, 68000.97998529927, 68221.0, 84500.0, 84708.0, 85585.0, 86246.56876715827, 86966.56516717376, 15938.60153496172, 16036.118013508902, 16141.838581614504, 16228.432004879773, 16238.188090595659, 24888.37779055538, 24945.0, 25155.119570814935, 25193.49613007693, 25426.74573254318, 19988.400347989584, 20458.488537786674, 20462.181512739324, 20462.897685511478, 20696.689549656465, 16240.756388653943, 16464.917675411547, 17057.14714264257, 17673.20470578853, 18475.63048738991, 21438.892805536496, 21715.67426488572, 21781.23765668194, 21949.451263718536, 22104.557908841412, 16027.118508481679, 16112.274947627151, 16314.918425407797, 16385.34458621642, 16434.75347869759, 20211.0905009272, 20315.492112697302, 20501.692474612595, 20780.0, 20834.687479687513], "value": 13151.377176134576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.1780429665832, 1549.7699249018938, 1554.1685198418847, 1570.8429157084292, 1573.6301969037281, 15696.686066278668, 15940.601484962881, 16285.75571366429, 16322.857399982006, 16334.673306533863, 16764.497065088035, 16883.409080682177, 16930.576735581617, 16947.57631059221, 16959.236834342453, 2994.3562134141157, 2998.3253767902265, 3062.0660698486954, 3071.9385612287742, 3072.9078127656207, 3020.2298413904423, 3041.5133578627424, 3082.6763189864964, 3084.0439463766193, 3087.0893086539413, 2977.136630377188, 2978.1810002249445, 3011.638603367588, 3012.18670958841, 3075.584796052538, 2970.0495841330676, 2978.731914127739, 2982.284251779568, 2993.685663005386, 3003.6695963444004, 2879.5248783950624, 2940.808847424932, 2956.1574951138823, 2959.511680572703, 2961.6446026476747, 15634.140122293269, 15955.601109972227, 16017.679646407123, 16020.038797672178, 16046.679066418606, 8620.913790862074, 8878.778030549223, 8904.73285801427, 8913.688020919237, 8916.955415222947, 5860.300771318985, 5962.880742385128, 6022.187004754346, 6157.415045570664, 6188.84527886802, 1996.790337014607, 2003.9398818035481, 2005.7764763494256, 2011.5876245369664, 2036.531597732515, 27707.445851083066, 27952.301192470146, 27979.440411191867, 28006.299842503897, 28023.579646305323, 7324.414046876237, 7521.210272921265, 7571.924280757232, 7576.4317676174505, 7685.923140768521, 18969.146388412555, 19010.144543495575, 19014.61970760577, 19030.714539281922, 19031.90484047571, 8534.103919088531, 8752.0, 8776.736697899074, 8808.11918808114, 8826.205641492297, 6912.308769123048, 7920.722774702973, 7955.761327160194, 8059.274665280153, 8105.351571874236, 5919.052951527735, 5939.495142912814, 5956.374580669054, 6035.39646035393, 6066.302375226817, 1685.9072750998812, 1700.4048582995852, 1728.7752592162938, 1734.340950438825, 1762.8060913299528, 964.7732782796037, 972.1153750087386, 977.53567055648, 994.0, 997.8852431970271, 8263.256306932404, 8264.421490495608, 8287.41988060842, 8448.23965843077, 8469.534175620276, 770.0, 783.7296132834163, 798.8242586630931, 800.2357748350312, 805.9758207253792, 5219.712915789668, 5299.49654782795, 5334.91997620036, 5339.145736682112, 5393.78424863009, 22952.540949180922, 23778.908741863448, 23993.400164995666, 24022.51954960891, 24023.27930162098, 22114.0, 23109.19117830868, 23501.764982350298, 23518.88240558786, 23519.17682881091, 12138.332391718364, 12405.255684658949, 12466.002719782397, 12493.56272530439, 12517.687057823445, 9255.074492550692, 9384.67153649619, 9432.481213533047, 9443.95278023633, 9531.57107930131, 19317.8068219316, 19534.31629892947, 19864.50338741543, 20226.89886550558, 20637.896810515853, 20685.482862927944, 20693.172273108907, 20840.687389688865, 20944.68582971287, 21075.78924210738, 10747.516361763895, 11864.406779661154, 12326.876731232573, 12366.567170149001, 12370.567030153901, 14809.481668141563, 14868.553943381716, 14988.625284367541, 14989.925050375115, 15008.174550399834, 12050.493688288963, 12188.634340969786, 12213.14507984468, 12271.447784849524, 12350.197237179555, 11159.44202789841, 11248.887511124783, 11359.318440893572, 11592.1305902056, 11597.304161750322, 9905.702828915144, 10002.099811017044, 10092.495375231356, 10112.949435252776, 10129.936356682738, 7868.52788832649, 7909.52542847431, 7935.484193527403, 7974.003249593801, 7987.281144696773, 7702.499337543042, 7849.646765895434, 7865.370770338245, 7908.485948413335, 7961.920380796118], "value": 7195.7632170015595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.6716036057644, 529.90726622841, 559.734126290012, 560.8429639700882, 561.2535328013743, 6010.459058684717, 6049.455549000589, 6052.517133302336, 6053.152558641783, 6086.969565152168, 5816.651000939946, 5908.586398952075, 5952.672603006833, 5961.284645842505, 5978.641281523101, 4726.810927562893, 4727.9834835510355, 4792.376990991166, 4800.639952003597, 4813.735244561548, 4695.624350052005, 4755.262934245197, 4774.85675429736, 4802.0, 4813.446453657839, 4694.530546945312, 4698.530146985308, 4752.833650822222, 4769.236922092466, 4777.730577975469, 4735.295293694285, 4745.810167593292, 4760.547747963938, 4784.091022705675, 4801.375821143229, 4311.762853043081, 4322.135572885435, 4384.890377740582, 4394.978025109854, 4395.1868904252815, 5959.523238140939, 5981.880362392728, 6000.699965001732, 6012.278526576795, 6036.486898613623, 5710.200571919934, 5725.341585717654, 5756.798512052058, 5797.275340582427, 5812.651240925558, 6499.545031847772, 6541.803745887631, 6543.476521878239, 6568.80293591193, 6578.440832529241, 4948.406191257036, 4961.826336078256, 4983.451820299764, 4983.90032199354, 4987.476314986947, 6722.781482110891, 6768.864622707568, 6785.558938668971, 6856.142982127234, 6857.691403886837, 5077.898442031213, 5085.364329458817, 5099.770510327045, 5108.438071812097, 5108.974455127701, 5141.742912854343, 5158.0, 5160.277561141368, 5182.533571978464, 5203.16749320107, 5595.160725891067, 5650.689212093374, 5652.463016013472, 5678.176664383641, 5750.568707346882, 6340.397662222082, 6387.297397286295, 6413.647249401234, 6482.967585162044, 6485.935140648533, 1694.7118989771768, 1719.9422355251431, 1730.9614231461023, 1773.4059090204669, 1791.1492041280549, 1242.310517662706, 1245.5765039886483, 1253.091508656217, 1254.6549698832712, 1276.3554405025588, 5971.731272092767, 6133.6319820810895, 6170.765846830652, 6190.907136392958, 6293.465055470245, 6562.212534495796, 6565.967170164214, 6596.4393026592315, 6599.406053455212, 6671.166104236971, 6135.723892424851, 6178.876422471525, 6197.907031394533, 6222.502199824004, 6268.341824108403, 3476.721862251014, 3486.8430920608635, 3513.982430087833, 3526.8236588171003, 3545.1137215696076, 6777.525573209828, 6798.354156355138, 6843.0, 6886.24251332353, 6929.203141638776, 6674.199096108498, 6681.432078273304, 6750.966245168841, 6790.456763458911, 6809.182898052265, 6801.387875091166, 6816.659167041628, 6901.930980690129, 6908.343707347894, 6918.827029324307, 6540.313267107075, 6574.389274627747, 6627.602343859384, 6637.402633762985, 6675.332466753286, 6480.157579514633, 6522.7717029905625, 6553.246376666553, 6581.934180658132, 6627.541940773022, 6768.593884366954, 6805.89791153143, 6839.62382068991, 6841.62371069596, 6872.278410766998, 5069.645124841226, 5070.4929507049, 5096.796128154832, 5103.387593488805, 5120.923186152137, 6401.3598640135615, 6501.122348482894, 6627.271000190071, 6679.23188833271, 6682.665866706742, 6294.874102518015, 6433.8713225736155, 6448.0, 6490.058941453557, 6507.577007494498, 6446.8388290293115, 6457.870842583216, 6459.192600924885, 6463.866923915003, 6468.5472016958365, 6196.535259855619, 6329.49364050884, 6330.936690633035, 6447.6131432114225, 6471.449926756279, 6359.20509936258, 6414.454771344488, 6439.428006115711, 6474.546781725234, 6526.869462610626, 6191.378043844222, 6235.937640623717, 6366.745330186741, 6378.77674281398, 6392.840178995562], "value": 5051.671986291221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.3793258516797, 961.3030552849184, 969.3602222533125, 992.7468495533637, 994.4878387630376, 15892.76160857588, 16235.83764162358, 16475.2586133624, 16881.40915067973, 19363.612727745436, 19731.309404170857, 19983.0, 20098.49753756157, 20103.0, 20114.497137571532, 1002.8445590933417, 1004.1815920025156, 1004.6734811186357, 1006.3458751811327, 1056.2131212246886, 988.9109980101789, 1085.7719878825455, 1087.6736978906335, 1090.7436752363187, 1093.20742461715, 1146.5700362364114, 1146.9025132863717, 1152.4813833774792, 1153.089059642881, 1154.3766366162263, 1119.8488204092466, 1151.228676786555, 1152.1071169843356, 1155.1682788392345, 1155.6648571914134, 809.3929552835374, 835.4110352201744, 842.8314337132537, 843.886075379822, 844.1178967978477, 17877.106144692712, 17908.55228619282, 18062.36781712647, 18226.0, 18252.726209106873, 19700.901495492573, 19759.40721778349, 19785.307514237076, 19963.0, 20186.39440816778, 15135.697286054217, 15439.922800386039, 15467.226638668135, 15565.22173891301, 15637.374505019785, 3703.777773333609, 3722.3671975764187, 3722.9255414891823, 3723.2181241939224, 3724.7951362675044, 141286.29356853254, 141820.99999999898, 142364.0, 142982.0, 144475.83286250714, 16404.425845095364, 16667.0, 16708.916455417646, 16760.078195699352, 16824.242909069122, 30740.69259307423, 31498.685013150032, 31785.52321715176, 31958.36083278368, 31993.680063199536, 8175.877361839577, 8317.750467485985, 9296.30277729173, 9312.813743725088, 9549.379290346105, 4223.13425747721, 4263.658907287409, 4264.402983582301, 4284.785760712014, 4289.120730250291, 5775.768969241268, 5803.071508558611, 5821.27234095738, 5868.413158684183, 5912.822615321547, 1146.7591805720892, 1172.7302720374191, 1192.803187474057, 1196.1208511743862, 1196.5752157983964, 736.4329466310911, 754.7358424551472, 757.0650246945019, 768.6771555946516, 777.4014009212874, 12858.678533036562, 13433.66415839612, 13438.731225375437, 14017.789733154012, 14156.0, 734.8824188129873, 742.254034695128, 742.7029188324714, 743.3644234179807, 759.1914610939332, 6819.624920629413, 6982.895256571155, 7051.294870512907, 7327.706891724271, 7398.149212840484, 126954.65226738626, 129746.0, 131886.0, 132056.0, 132221.0, 112268.0, 112854.0, 116493.41753291179, 117031.0, 120529.0, 95568.0, 96396.51801741087, 96507.0, 97260.0, 98689.847564012, 13058.281794501014, 13198.538051168547, 13223.140495867738, 13251.933740331237, 13278.0, 46293.07413851637, 46923.765381172874, 47529.0, 48347.516524834304, 49118.75440622774, 61648.0, 61932.0, 62188.68905655443, 63188.68405657943, 63639.0, 18246.0, 18369.448916532525, 18413.631727365646, 18482.445526634223, 18765.718514222026, 22434.887825560767, 22747.203847865247, 22781.088756449557, 22878.656820148044, 23249.070037198322, 19337.8066219336, 19907.701384479533, 19947.800521994595, 19965.60068798645, 20082.196712131936, 20094.89952550228, 20333.694994575388, 21317.786822132202, 22009.449763756034, 22231.77768222362, 19277.421677349703, 19534.0, 19556.315528956417, 19645.31241406544, 19705.211791528178, 13877.583672489438, 13964.650883727989, 14129.505467308594, 14457.421703131757, 15500.767488487456, 14752.55742327732, 15501.534953951399, 15562.610934726723, 15694.9215253923, 16363.345466181696], "value": 9744.376542820495, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 100.0, 106.0, 106.0, 109.0, 109.0, 100.0, 106.0, 106.0], "value": 104.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 147.0, 171.0, 117.0, 142.0, 143.0, 113.0, 163.0, 120.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 163.0, 162.0, 164.0, 160.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 196.0, 76.0, 74.0, 73.0, 76.0, 175.0, 76.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 121.0, 77.0, 78.0, 78.0, 124.0, 77.0, 78.0, 136.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 151.0, 147.0, 149.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 45.0, 45.0, 45.0, 45.0, 47.0, 45.0, 47.0, 47.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 57.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 74.0, 76.0, 73.0, 73.0, 73.0, 73.0, 75.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 115.0, 115.0, 139.0, 122.0, 119.0, 117.0, 120.0, 119.0, 145.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 157.0, 164.0, 157.0, 154.0, 169.0, 158.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 59.0, 60.0, 59.0, 59.0, 57.0, 57.0, 59.0], "value": 58.9, "unit": "score"}]}]} 09:48:53 INFO - Return code: 0 09:48:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:48:53 INFO - # TBPL SUCCESS # 09:48:53 INFO - Running post-action listener: _package_coverage_data 09:48:53 INFO - Running post-action listener: _resource_record_post_action 09:48:53 INFO - [mozharness: 2017-09-15 16:48:53.534521Z] Finished run-tests step (success) 09:48:53 INFO - Running post-run listener: _resource_record_post_run 09:48:53 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 499712; Write bytes: 291385344; Read time: 60; Write time: 159828 09:48:53 INFO - TinderboxPrint: CPU usage
13.0% 09:48:53 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 60 09:48:53 INFO - TinderboxPrint: I/O write bytes / time
291,385,344 / 159,828 09:48:53 INFO - TinderboxPrint: CPU idle
8,204.1 (87.0%) 09:48:53 INFO - TinderboxPrint: CPU user
1,180.1 (12.5%) 09:48:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:48:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13213696; Read time: 0; Write time: 3764 09:48:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:48:53 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 495616; Write bytes: 277237760; Read time: 28; Write time: 156040 09:48:54 INFO - Running post-run listener: _upload_blobber_files 09:48:54 INFO - Blob upload gear active. 09:48:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:48:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:48:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:55 INFO - (blobuploader) - INFO - Done attempting. 09:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:56 INFO - (blobuploader) - INFO - Done attempting. 09:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:57 INFO - (blobuploader) - INFO - Done attempting. 09:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:04 INFO - (blobuploader) - INFO - Done attempting. 09:49:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:04 INFO - Return code: 0 09:49:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db267f6540e75c5698d28fbcad0b390bcd41ec7608454ae5a6acbf184c6844ad8ef4487bfdb4d5bbca0f804cac23b568d8706a6bc28d52dfe9f82d1720a19f2e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89e71e6f52222d11ea167c2a9dfd6be311af2e3e27144e7485ff5db14ace5fe9f4113144840d77f7e6f0dba6edbcfd102e723ea6492b8c012be45ce9dfc60f16", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31a36c7680e09a4497084a7eb94e701a8730a3792ae212950b02b0c06a0a9d1bfbbc82e80d7d9d5ef96c31554533bb2e05903b1b9bfe9338bb1ff35798ce93ba", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ae802f92901187c3806cbd55478c4e9bfbca2be6eaaff9b531d03579e11337d15cb519c0c9b273ebdfe57876e29203c40d5555ba00de41cf1d90f3233ef0f29"} 09:49:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:04 INFO - Contents: 09:49:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db267f6540e75c5698d28fbcad0b390bcd41ec7608454ae5a6acbf184c6844ad8ef4487bfdb4d5bbca0f804cac23b568d8706a6bc28d52dfe9f82d1720a19f2e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89e71e6f52222d11ea167c2a9dfd6be311af2e3e27144e7485ff5db14ace5fe9f4113144840d77f7e6f0dba6edbcfd102e723ea6492b8c012be45ce9dfc60f16", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31a36c7680e09a4497084a7eb94e701a8730a3792ae212950b02b0c06a0a9d1bfbbc82e80d7d9d5ef96c31554533bb2e05903b1b9bfe9338bb1ff35798ce93ba", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ae802f92901187c3806cbd55478c4e9bfbca2be6eaaff9b531d03579e11337d15cb519c0c9b273ebdfe57876e29203c40d5555ba00de41cf1d90f3233ef0f29"} 09:49:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:04 INFO - Copying logs to upload dir... 09:49:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.134572 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-15 09:49:04.689677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 09:49:04.697154) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db267f6540e75c5698d28fbcad0b390bcd41ec7608454ae5a6acbf184c6844ad8ef4487bfdb4d5bbca0f804cac23b568d8706a6bc28d52dfe9f82d1720a19f2e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89e71e6f52222d11ea167c2a9dfd6be311af2e3e27144e7485ff5db14ace5fe9f4113144840d77f7e6f0dba6edbcfd102e723ea6492b8c012be45ce9dfc60f16", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31a36c7680e09a4497084a7eb94e701a8730a3792ae212950b02b0c06a0a9d1bfbbc82e80d7d9d5ef96c31554533bb2e05903b1b9bfe9338bb1ff35798ce93ba", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ae802f92901187c3806cbd55478c4e9bfbca2be6eaaff9b531d03579e11337d15cb519c0c9b273ebdfe57876e29203c40d5555ba00de41cf1d90f3233ef0f29"} build_url:https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011760 build_url: 'https://queue.taskcluster.net/v1/task/USRU6VmpTDy9FhWNXcd9TQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db267f6540e75c5698d28fbcad0b390bcd41ec7608454ae5a6acbf184c6844ad8ef4487bfdb4d5bbca0f804cac23b568d8706a6bc28d52dfe9f82d1720a19f2e", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89e71e6f52222d11ea167c2a9dfd6be311af2e3e27144e7485ff5db14ace5fe9f4113144840d77f7e6f0dba6edbcfd102e723ea6492b8c012be45ce9dfc60f16", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31a36c7680e09a4497084a7eb94e701a8730a3792ae212950b02b0c06a0a9d1bfbbc82e80d7d9d5ef96c31554533bb2e05903b1b9bfe9338bb1ff35798ce93ba", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ae802f92901187c3806cbd55478c4e9bfbca2be6eaaff9b531d03579e11337d15cb519c0c9b273ebdfe57876e29203c40d5555ba00de41cf1d90f3233ef0f29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 09:49:04.725203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:49:04.725516) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505491802.38070-1888049672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004765 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 09:49:04.778577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 09:49:04.780909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 09:49:04.781213) ========= ========= Total master_lag: 0.18 =========