builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-070 starttime: 1488744865.47 results: success (0) revision: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.467634) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.468036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.468345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.512656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.513054) ========= 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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-05 12:14:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2017-03-05 12:14:26 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.604162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.604474) ========= 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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:25.657974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 12:14:25.658286) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 --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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-05 12:14:26,892 truncating revision to first 12 chars 2017-03-05 12:14:26,892 Setting DEBUG logging. 2017-03-05 12:14:26,892 attempt 1/10 2017-03-05 12:14:26,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a94edff8355a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 12:14:27,590 unpacking tar archive at: mozilla-aurora-a94edff8355a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039319 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 12:14:26.711231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:26.711526) ========= script_repo_revision: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:26.711891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:26.712173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 12:14:26.721007) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-03-05 12:14:26.721315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:28 INFO - MultiFileLogger online at 20170305 12:14:28 in /builds/slave/test 12:14:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 12:14:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:28 INFO - {'append_to_log': False, 12:14:28 INFO - 'base_work_dir': '/builds/slave/test', 12:14:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 12:14:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:28 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 12:14:28 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:28 INFO - 'config_files': ('talos/linux_config.py',), 12:14:28 INFO - 'default_actions': ('clobber', 12:14:28 INFO - 'read-buildbot-config', 12:14:28 INFO - 'download-and-extract', 12:14:28 INFO - 'populate-webroot', 12:14:28 INFO - 'create-virtualenv', 12:14:28 INFO - 'install', 12:14:28 INFO - 'run-tests'), 12:14:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:28 INFO - 'download_minidump_stackwalk': True, 12:14:28 INFO - 'download_symbols': 'ondemand', 12:14:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:28 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:28 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:28 INFO - 'installer_path': 'installer.exe', 12:14:28 INFO - 'log_level': 'info', 12:14:28 INFO - 'log_name': 'talos', 12:14:28 INFO - 'log_to_console': True, 12:14:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:28 INFO - 'opt_config_files': (), 12:14:28 INFO - 'pip_index': False, 12:14:28 INFO - 'sps_profile': False, 12:14:28 INFO - 'sps_profile_interval': 0, 12:14:28 INFO - 'suite': 'dromaeojs', 12:14:28 INFO - 'system_bits': '32', 12:14:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:28 INFO - 'title': 'talos-linux64-ix-070', 12:14:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:28 INFO - 'use_talos_json': True, 12:14:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:28 INFO - 'work_dir': 'build'} 12:14:28 INFO - [mozharness: 2017-03-05 20:14:28.050255Z] Running clobber step. 12:14:28 INFO - Running pre-action listener: _resource_record_pre_action 12:14:28 INFO - Running main action method: clobber 12:14:28 INFO - rmtree: /builds/slave/test/build 12:14:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:29 INFO - Running post-action listener: _resource_record_post_action 12:14:29 INFO - [mozharness: 2017-03-05 20:14:29.030672Z] Finished clobber step (success) 12:14:29 INFO - [mozharness: 2017-03-05 20:14:29.030771Z] Running read-buildbot-config step. 12:14:29 INFO - Running pre-action listener: _resource_record_pre_action 12:14:29 INFO - Running main action method: read_buildbot_config 12:14:29 INFO - Using buildbot properties: 12:14:29 INFO - { 12:14:29 INFO - "project": "", 12:14:29 INFO - "product": "firefox", 12:14:29 INFO - "who": "ryanvm@gmail.com", 12:14:29 INFO - "installer_path": "public/build/target.tar.bz2", 12:14:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:14:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 12:14:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 12:14:29 INFO - "stage_platform": "linux64", 12:14:29 INFO - "basedir": "/builds/slave/test", 12:14:29 INFO - "buildnumber": 62, 12:14:29 INFO - "platform": "ubuntu64_hw", 12:14:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:14:29 INFO - "slavebuilddir": "test", 12:14:29 INFO - "taskId": "bL-9HFisT-WrzgfvwLdoCw", 12:14:29 INFO - "branch": "mozilla-aurora", 12:14:29 INFO - "script_repo_revision": "production", 12:14:29 INFO - "revision": "a94edff8355a1c83ad2bfad80d48540a3cfdfcf6", 12:14:29 INFO - "slavename": "talos-linux64-ix-070", 12:14:29 INFO - "repo_path": "releases/mozilla-aurora" 12:14:29 INFO - } 12:14:29 INFO - Finding installer, test and symbols from parent task. 12:14:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bL-9HFisT-WrzgfvwLdoCw'}, attempt #1 12:14:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bL-9HFisT-WrzgfvwLdoCw'}, attempt #1 12:14:29 INFO - Task dependencies: DFaMYxWESz2KCdI-yvrACQ 12:14:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ'}, attempt #1 12:14:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 12:14:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/test_packages.json 12:14:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.crashreporter-symbols.zip 12:14:30 INFO - Running post-action listener: _resource_record_post_action 12:14:30 INFO - [mozharness: 2017-03-05 20:14:30.405818Z] Finished read-buildbot-config step (success) 12:14:30 INFO - [mozharness: 2017-03-05 20:14:30.406035Z] Running download-and-extract step. 12:14:30 INFO - Running pre-action listener: _resource_record_pre_action 12:14:30 INFO - Running main action method: download_and_extract 12:14:30 INFO - mkdir: /builds/slave/test/build/tests 12:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:30 INFO - trying https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.test_packages.json 12:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:14:30 INFO - Downloaded 896 bytes. 12:14:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:14:30 INFO - Using the following test package requirements: 12:14:30 INFO - {u'common': [u'target.common.tests.zip'], 12:14:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:14:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:14:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:14:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:14:30 INFO - u'mozbase': [u'target.common.tests.zip'], 12:14:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:14:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:14:30 INFO - u'web-platform': [u'target.common.tests.zip', 12:14:30 INFO - u'target.web-platform.tests.zip'], 12:14:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:14:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:14:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip 12:14:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:14:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip into memory 12:14:31 INFO - Expected file size: 21861327 12:14:31 INFO - Obtained file size: 21861327 12:14:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:14:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip 12:14:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:14:35 INFO - Fetch https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.common.tests.zip into memory 12:14:36 INFO - Expected file size: 21861327 12:14:36 INFO - Obtained file size: 21861327 12:14:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.talos.tests.zip 12:14:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:14:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.talos.tests.zip into memory 12:14:41 INFO - Expected file size: 14403650 12:14:41 INFO - Obtained file size: 14403650 12:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:41 INFO - trying https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 12:14:41 INFO - Downloading https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:14:43 INFO - Downloaded 66134543 bytes. 12:14:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 12:14:43 INFO - mkdir: /builds/slave/test/properties 12:14:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:43 INFO - Contents: 12:14:43 INFO - build_url:https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 12:14:43 INFO - Running post-action listener: _resource_record_post_action 12:14:43 INFO - Running post-action listener: set_extra_try_arguments 12:14:43 INFO - [mozharness: 2017-03-05 20:14:43.124198Z] Finished download-and-extract step (success) 12:14:43 INFO - [mozharness: 2017-03-05 20:14:43.124294Z] Running populate-webroot step. 12:14:43 INFO - Running pre-action listener: _resource_record_pre_action 12:14:43 INFO - Running main action method: populate_webroot 12:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:43 INFO - '--tppagecycles', 12:14:43 INFO - '7'], 12:14:43 INFO - 'tests': ['tsvgm']}}, 12:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['damp', 'tps']}, 12:14:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'tests': ['damp', 'tps']}, 12:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['dromaeo_dom']}, 12:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['basic_compositor_video']}, 12:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['a11yr', 12:14:43 INFO - 'ts_paint', 12:14:43 INFO - 'tpaint', 12:14:43 INFO - 'sessionrestore', 12:14:43 INFO - 'sessionrestore_no_auto_restore', 12:14:43 INFO - 'tabpaint']}, 12:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['tsvgx', 12:14:43 INFO - 'tsvgr_opacity', 12:14:43 INFO - 'tart', 12:14:43 INFO - 'tscrollx', 12:14:43 INFO - 'cart', 12:14:43 INFO - 'tsvg_static']}, 12:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:43 INFO - 'tsvgr_opacity', 12:14:43 INFO - 'tart', 12:14:43 INFO - 'tscrollx', 12:14:43 INFO - 'cart', 12:14:43 INFO - 'tsvg_static']}, 12:14:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'talos_options': ['--disable-e10s'], 12:14:43 INFO - 'tests': ['tp5o']}, 12:14:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:14:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'talos_options': ['--disable-e10s', 12:14:43 INFO - '--xperf_path', 12:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:43 INFO - 'tests': ['tp5n']}, 12:14:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:14:43 INFO - 'talos_options': ['--xperf_path', 12:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:43 INFO - 'tests': ['tp5n']}}, 12:14:43 INFO - 'talos.zip': {'path': '', 12:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:43 INFO - Running post-action listener: _resource_record_post_action 12:14:43 INFO - [mozharness: 2017-03-05 20:14:43.137355Z] Finished populate-webroot step (success) 12:14:43 INFO - [mozharness: 2017-03-05 20:14:43.137444Z] Running create-virtualenv step. 12:14:43 INFO - Running pre-action listener: _resource_record_pre_action 12:14:43 INFO - Running main action method: create_virtualenv 12:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:43 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 12:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:43 INFO - Using real prefix '/usr' 12:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:45 INFO - Installing pip.................done. 12:14:45 INFO - Return code: 0 12:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:14:45 INFO - Reading from file tmpfile_stdout 12:14:45 INFO - Output received: 12:14:45 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) 12:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:45 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:45 INFO - Using env: {'DISPLAY': ':0', 12:14:45 INFO - 'HOME': '/home/cltbld', 12:14:45 INFO - 'LANG': 'en_US.UTF-8', 12:14:45 INFO - 'LANGUAGE': 'en_US:en', 12:14:45 INFO - 'LOGNAME': 'cltbld', 12:14:45 INFO - 'MAIL': '/var/mail/cltbld', 12:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:45 INFO - 'MOZ_NO_REMOTE': '1', 12:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:45 INFO - 'NO_EM_RESTART': '1', 12:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:45 INFO - 'PWD': '/builds/slave/test', 12:14:45 INFO - 'SHELL': '/bin/bash', 12:14:45 INFO - 'SHLVL': '1', 12:14:45 INFO - 'TERM': 'linux', 12:14:45 INFO - 'TMOUT': '86400', 12:14:45 INFO - 'USER': 'cltbld', 12:14:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:45 INFO - '_': '/tools/buildbot/bin/python'} 12:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:46 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 12:14:46 INFO - Cleaning up... 12:14:46 INFO - Return code: 0 12:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:14:46 INFO - Using env: {'DISPLAY': ':0', 12:14:46 INFO - 'HOME': '/home/cltbld', 12:14:46 INFO - 'LANG': 'en_US.UTF-8', 12:14:46 INFO - 'LANGUAGE': 'en_US:en', 12:14:46 INFO - 'LOGNAME': 'cltbld', 12:14:46 INFO - 'MAIL': '/var/mail/cltbld', 12:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:46 INFO - 'MOZ_NO_REMOTE': '1', 12:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:46 INFO - 'NO_EM_RESTART': '1', 12:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:46 INFO - 'PWD': '/builds/slave/test', 12:14:46 INFO - 'SHELL': '/bin/bash', 12:14:46 INFO - 'SHLVL': '1', 12:14:46 INFO - 'TERM': 'linux', 12:14:46 INFO - 'TMOUT': '86400', 12:14:46 INFO - 'USER': 'cltbld', 12:14:46 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:46 INFO - '_': '/tools/buildbot/bin/python'} 12:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:46 INFO - Downloading/unpacking psutil>=3.1.1 12:14:46 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 12:14:46 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 12:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:46 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 12:14:46 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 12:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:48 INFO - Installing collected packages: psutil 12:14:48 INFO - Running setup.py install for psutil 12:14:48 INFO - building 'psutil._psutil_linux' extension 12:14:48 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 12:14:48 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 12:14:48 INFO - building 'psutil._psutil_posix' extension 12:14:48 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 12:14:48 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 12:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:49 INFO - Successfully installed psutil 12:14:49 INFO - Cleaning up... 12:14:49 INFO - Return code: 0 12:14:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:14:49 INFO - Using env: {'DISPLAY': ':0', 12:14:49 INFO - 'HOME': '/home/cltbld', 12:14:49 INFO - 'LANG': 'en_US.UTF-8', 12:14:49 INFO - 'LANGUAGE': 'en_US:en', 12:14:49 INFO - 'LOGNAME': 'cltbld', 12:14:49 INFO - 'MAIL': '/var/mail/cltbld', 12:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:49 INFO - 'MOZ_NO_REMOTE': '1', 12:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:49 INFO - 'NO_EM_RESTART': '1', 12:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:49 INFO - 'PWD': '/builds/slave/test', 12:14:49 INFO - 'SHELL': '/bin/bash', 12:14:49 INFO - 'SHLVL': '1', 12:14:49 INFO - 'TERM': 'linux', 12:14:49 INFO - 'TMOUT': '86400', 12:14:49 INFO - 'USER': 'cltbld', 12:14:49 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:49 INFO - '_': '/tools/buildbot/bin/python'} 12:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:49 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 12:14:49 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 12:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:49 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 12:14:49 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 12:14:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:51 INFO - Installing collected packages: mozsystemmonitor 12:14:51 INFO - Running setup.py install for mozsystemmonitor 12:14:51 INFO - Successfully installed mozsystemmonitor 12:14:51 INFO - Cleaning up... 12:14:51 INFO - Return code: 0 12:14:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:14:51 INFO - Using env: {'DISPLAY': ':0', 12:14:51 INFO - 'HOME': '/home/cltbld', 12:14:51 INFO - 'LANG': 'en_US.UTF-8', 12:14:51 INFO - 'LANGUAGE': 'en_US:en', 12:14:51 INFO - 'LOGNAME': 'cltbld', 12:14:51 INFO - 'MAIL': '/var/mail/cltbld', 12:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:51 INFO - 'MOZ_NO_REMOTE': '1', 12:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:51 INFO - 'NO_EM_RESTART': '1', 12:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:51 INFO - 'PWD': '/builds/slave/test', 12:14:51 INFO - 'SHELL': '/bin/bash', 12:14:51 INFO - 'SHLVL': '1', 12:14:51 INFO - 'TERM': 'linux', 12:14:51 INFO - 'TMOUT': '86400', 12:14:51 INFO - 'USER': 'cltbld', 12:14:51 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:51 INFO - '_': '/tools/buildbot/bin/python'} 12:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 12:14: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 12:14: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 12:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14: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 12:14: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 12:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14:53 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 12:14:53 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 12:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:53 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 12:14:53 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 12:14:53 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:54 INFO - warning: no files found matching '*.txt' 12:14:54 INFO - no previously-included directories found matching 'build' 12:14:54 INFO - no previously-included directories found matching 'dist' 12:14:54 INFO - no previously-included directories found matching '.git*' 12:14:54 INFO - Installing collected packages: jsonschema, functools32 12:14:54 INFO - Running setup.py install for functools32 12:14:54 INFO - warning: no files found matching '*.txt' 12:14:54 INFO - no previously-included directories found matching 'build' 12:14:54 INFO - no previously-included directories found matching 'dist' 12:14:54 INFO - no previously-included directories found matching '.git*' 12:14:54 INFO - Successfully installed jsonschema functools32 12:14:54 INFO - Cleaning up... 12:14:54 INFO - Return code: 0 12:14:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:14:54 INFO - Using env: {'DISPLAY': ':0', 12:14:54 INFO - 'HOME': '/home/cltbld', 12:14:54 INFO - 'LANG': 'en_US.UTF-8', 12:14:54 INFO - 'LANGUAGE': 'en_US:en', 12:14:54 INFO - 'LOGNAME': 'cltbld', 12:14:54 INFO - 'MAIL': '/var/mail/cltbld', 12:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:54 INFO - 'MOZ_NO_REMOTE': '1', 12:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:54 INFO - 'NO_EM_RESTART': '1', 12:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:54 INFO - 'PWD': '/builds/slave/test', 12:14:54 INFO - 'SHELL': '/bin/bash', 12:14:54 INFO - 'SHLVL': '1', 12:14:54 INFO - 'TERM': 'linux', 12:14:54 INFO - 'TMOUT': '86400', 12:14:54 INFO - 'USER': 'cltbld', 12:14:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:54 INFO - '_': '/tools/buildbot/bin/python'} 12:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:14:54 INFO - Cleaning up... 12:14:54 INFO - Return code: 0 12:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:14:54 INFO - Using env: {'DISPLAY': ':0', 12:14:54 INFO - 'HOME': '/home/cltbld', 12:14:54 INFO - 'LANG': 'en_US.UTF-8', 12:14:54 INFO - 'LANGUAGE': 'en_US:en', 12:14:54 INFO - 'LOGNAME': 'cltbld', 12:14:54 INFO - 'MAIL': '/var/mail/cltbld', 12:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:54 INFO - 'MOZ_NO_REMOTE': '1', 12:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:54 INFO - 'NO_EM_RESTART': '1', 12:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:54 INFO - 'PWD': '/builds/slave/test', 12:14:54 INFO - 'SHELL': '/bin/bash', 12:14:54 INFO - 'SHLVL': '1', 12:14:54 INFO - 'TERM': 'linux', 12:14:54 INFO - 'TMOUT': '86400', 12:14:54 INFO - 'USER': 'cltbld', 12:14:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:54 INFO - '_': '/tools/buildbot/bin/python'} 12:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:14: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 12:14: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 12:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14: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 12:14: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 12:14:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:56 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 12:14:56 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 12:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 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 12:14:56 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 12:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14: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 12:14: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 12:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14: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 12:14: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 12:14:57 INFO - Downloading docopt-0.6.1.tar.gz 12:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:57 INFO - Running setup.py install for blobuploader 12:14:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:57 INFO - Running setup.py install for requests 12:14:57 INFO - Running setup.py install for docopt 12:14:58 INFO - Successfully installed blobuploader requests docopt 12:14:58 INFO - Cleaning up... 12:14:58 INFO - Return code: 0 12:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:14:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:14:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:58 INFO - Using env: {'DISPLAY': ':0', 12:14:58 INFO - 'HOME': '/home/cltbld', 12:14:58 INFO - 'LANG': 'en_US.UTF-8', 12:14:58 INFO - 'LANGUAGE': 'en_US:en', 12:14:58 INFO - 'LOGNAME': 'cltbld', 12:14:58 INFO - 'MAIL': '/var/mail/cltbld', 12:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:58 INFO - 'MOZ_NO_REMOTE': '1', 12:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:58 INFO - 'NO_EM_RESTART': '1', 12:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:58 INFO - 'PWD': '/builds/slave/test', 12:14:58 INFO - 'SHELL': '/bin/bash', 12:14:58 INFO - 'SHLVL': '1', 12:14:58 INFO - 'TERM': 'linux', 12:14:58 INFO - 'TMOUT': '86400', 12:14:58 INFO - 'USER': 'cltbld', 12:14:58 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:58 INFO - '_': '/tools/buildbot/bin/python'} 12:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:58 INFO - Running setup.py (path:/tmp/pip-3NPToW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:58 INFO - Running setup.py (path:/tmp/pip-0QjQXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:58 INFO - Running setup.py (path:/tmp/pip-ORKhXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:58 INFO - Running setup.py (path:/tmp/pip-ANJniG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:58 INFO - Running setup.py (path:/tmp/pip-t2u28A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:58 INFO - Running setup.py (path:/tmp/pip-R9drP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:58 INFO - Running setup.py (path:/tmp/pip-p53D4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:58 INFO - Running setup.py (path:/tmp/pip-FMMLXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:58 INFO - Running setup.py (path:/tmp/pip-Xn0_OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:59 INFO - Running setup.py (path:/tmp/pip-r3xnPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:59 INFO - Running setup.py (path:/tmp/pip-wcAJcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:59 INFO - Running setup.py (path:/tmp/pip-7j_JnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:59 INFO - Running setup.py (path:/tmp/pip-UMl_Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:59 INFO - Running setup.py (path:/tmp/pip-g7eCRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:59 INFO - Running setup.py (path:/tmp/pip-bx3j_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:59 INFO - Running setup.py (path:/tmp/pip-egzRMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:59 INFO - Running setup.py (path:/tmp/pip-NXtZLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:59 INFO - Running setup.py install for manifestparser 12:14:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:59 INFO - Running setup.py install for mozcrash 12:14:59 INFO - Running setup.py install for mozdebug 12:14:59 INFO - Running setup.py install for mozdevice 12:15:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozfile 12:15:00 INFO - Running setup.py install for mozhttpd 12:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozinfo 12:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozInstall 12:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozleak 12:15:00 INFO - Running setup.py install for mozlog 12:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for moznetwork 12:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozprocess 12:15:00 INFO - Running setup.py install for mozprofile 12:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:00 INFO - Running setup.py install for mozrunner 12:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:01 INFO - Running setup.py install for mozscreenshot 12:15:01 INFO - Running setup.py install for moztest 12:15:01 INFO - Running setup.py install for mozversion 12:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:01 INFO - Cleaning up... 12:15:01 INFO - Return code: 0 12:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:15:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:01 INFO - Using env: {'DISPLAY': ':0', 12:15:01 INFO - 'HOME': '/home/cltbld', 12:15:01 INFO - 'LANG': 'en_US.UTF-8', 12:15:01 INFO - 'LANGUAGE': 'en_US:en', 12:15:01 INFO - 'LOGNAME': 'cltbld', 12:15:01 INFO - 'MAIL': '/var/mail/cltbld', 12:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:01 INFO - 'MOZ_NO_REMOTE': '1', 12:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:01 INFO - 'NO_EM_RESTART': '1', 12:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:01 INFO - 'PWD': '/builds/slave/test', 12:15:01 INFO - 'SHELL': '/bin/bash', 12:15:01 INFO - 'SHLVL': '1', 12:15:01 INFO - 'TERM': 'linux', 12:15:01 INFO - 'TMOUT': '86400', 12:15:01 INFO - 'USER': 'cltbld', 12:15:01 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:01 INFO - '_': '/tools/buildbot/bin/python'} 12:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:01 INFO - Running setup.py (path:/tmp/pip-cRQa8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:01 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)) 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:01 INFO - Running setup.py (path:/tmp/pip-iNejs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:01 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)) 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:01 INFO - Running setup.py (path:/tmp/pip-YoOaut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:01 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)) 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:01 INFO - Running setup.py (path:/tmp/pip-bjAyf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:01 INFO - Running setup.py (path:/tmp/pip-IHkAWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:01 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)) 12:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:01 INFO - Running setup.py (path:/tmp/pip-3tnzXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:02 INFO - Running setup.py (path:/tmp/pip-HhkTi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:02 INFO - Running setup.py (path:/tmp/pip-Ngppko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:02 INFO - Running setup.py (path:/tmp/pip-kl14dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:02 INFO - Running setup.py (path:/tmp/pip-aegip7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:02 INFO - Running setup.py (path:/tmp/pip-R8YakV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:02 INFO - Running setup.py (path:/tmp/pip-KaDWKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:02 INFO - Running setup.py (path:/tmp/pip-BbcH8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:02 INFO - Running setup.py (path:/tmp/pip-ds3Diu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:02 INFO - Running setup.py (path:/tmp/pip-AKf7PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:02 INFO - Running setup.py (path:/tmp/pip-FnA1Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:02 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)) 12:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:02 INFO - Running setup.py (path:/tmp/pip-XJEJ1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:02 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)) 12:15:02 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)) 12:15:02 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)) 12:15:02 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)) 12:15:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:02 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 12:15:02 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 12:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 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 12:15:02 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 12:15:05 INFO - Downloading blessings-1.6.tar.gz 12:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:05 INFO - Installing collected packages: blessings 12:15:05 INFO - Running setup.py install for blessings 12:15:06 INFO - Successfully installed blessings 12:15:06 INFO - Cleaning up... 12:15:06 INFO - Return code: 0 12:15:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:06 INFO - Reading from file tmpfile_stdout 12:15:06 INFO - Current package versions: 12:15:06 INFO - argparse == 1.2.1 12:15:06 INFO - blessings == 1.6 12:15:06 INFO - blobuploader == 1.2.4 12:15:06 INFO - docopt == 0.6.1 12:15:06 INFO - functools32 == 3.2.3-2 12:15:06 INFO - jsonschema == 2.5.1 12:15:06 INFO - manifestparser == 1.1 12:15:06 INFO - mozInstall == 1.12 12:15:06 INFO - mozcrash == 1.0 12:15:06 INFO - mozdebug == 0.1 12:15:06 INFO - mozdevice == 0.49 12:15:06 INFO - mozfile == 1.2 12:15:06 INFO - mozhttpd == 0.7 12:15:06 INFO - mozinfo == 0.9 12:15:06 INFO - mozleak == 0.1 12:15:06 INFO - mozlog == 3.4 12:15:06 INFO - moznetwork == 0.27 12:15:06 INFO - mozprocess == 0.24 12:15:06 INFO - mozprofile == 0.28 12:15:06 INFO - mozrunner == 6.13 12:15:06 INFO - mozscreenshot == 0.1 12:15:06 INFO - mozsystemmonitor == 0.3 12:15:06 INFO - moztest == 0.8 12:15:06 INFO - mozversion == 1.4 12:15:06 INFO - psutil == 3.1.1 12:15:06 INFO - requests == 1.2.3 12:15:06 INFO - wsgiref == 0.1.2 12:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:15:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:06 INFO - Using env: {'DISPLAY': ':0', 12:15:06 INFO - 'HOME': '/home/cltbld', 12:15:06 INFO - 'LANG': 'en_US.UTF-8', 12:15:06 INFO - 'LANGUAGE': 'en_US:en', 12:15:06 INFO - 'LOGNAME': 'cltbld', 12:15:06 INFO - 'MAIL': '/var/mail/cltbld', 12:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:06 INFO - 'MOZ_NO_REMOTE': '1', 12:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:06 INFO - 'NO_EM_RESTART': '1', 12:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:06 INFO - 'PWD': '/builds/slave/test', 12:15:06 INFO - 'SHELL': '/bin/bash', 12:15:06 INFO - 'SHLVL': '1', 12:15:06 INFO - 'TERM': 'linux', 12:15:06 INFO - 'TMOUT': '86400', 12:15:06 INFO - 'USER': 'cltbld', 12:15:06 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:06 INFO - '_': '/tools/buildbot/bin/python'} 12:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 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)) 12:15:06 INFO - Cleaning up... 12:15:06 INFO - Return code: 0 12:15:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1643a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, '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': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', '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 12:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:15:06 INFO - Using env: {'DISPLAY': ':0', 12:15:06 INFO - 'HOME': '/home/cltbld', 12:15:06 INFO - 'LANG': 'en_US.UTF-8', 12:15:06 INFO - 'LANGUAGE': 'en_US:en', 12:15:06 INFO - 'LOGNAME': 'cltbld', 12:15:06 INFO - 'MAIL': '/var/mail/cltbld', 12:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:06 INFO - 'MOZ_NO_REMOTE': '1', 12:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:06 INFO - 'NO_EM_RESTART': '1', 12:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:06 INFO - 'PWD': '/builds/slave/test', 12:15:06 INFO - 'SHELL': '/bin/bash', 12:15:06 INFO - 'SHLVL': '1', 12:15:06 INFO - 'TERM': 'linux', 12:15:06 INFO - 'TMOUT': '86400', 12:15:06 INFO - 'USER': 'cltbld', 12:15:06 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:06 INFO - '_': '/tools/buildbot/bin/python'} 12:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:06 INFO - Cleaning up... 12:15:06 INFO - Return code: 0 12:15:06 INFO - Running post-action listener: _resource_record_post_action 12:15:06 INFO - Running post-action listener: _start_resource_monitoring 12:15:06 INFO - Starting resource monitoring. 12:15:06 INFO - [mozharness: 2017-03-05 20:15:06.842812Z] Finished create-virtualenv step (success) 12:15:06 INFO - [mozharness: 2017-03-05 20:15:06.843317Z] Running install step. 12:15:06 INFO - Running pre-action listener: _resource_record_pre_action 12:15:06 INFO - Running main action method: install 12:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:07 INFO - Reading from file tmpfile_stdout 12:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:07 INFO - Reading from file tmpfile_stdout 12:15:07 INFO - Output received: 12:15:07 INFO - Usage: mozinstall [options] installer 12:15:07 INFO - Options: 12:15:07 INFO - -h, --help show this help message and exit 12:15:07 INFO - -d DEST, --destination=DEST 12:15:07 INFO - Directory to install application into. [default: 12:15:07 INFO - "/builds/slave/test"] 12:15:07 INFO - --app=APP Application being installed. [default: firefox] 12:15:07 INFO - mkdir: /builds/slave/test/build/application 12:15:07 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'] 12:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:15:23 INFO - Reading from file tmpfile_stdout 12:15:23 INFO - Output received: 12:15:23 INFO - /builds/slave/test/build/application/firefox/firefox 12:15:23 INFO - Running post-action listener: _resource_record_post_action 12:15:23 INFO - [mozharness: 2017-03-05 20:15:23.699970Z] Finished install step (success) 12:15:23 INFO - [mozharness: 2017-03-05 20:15:23.700121Z] Running run-tests step. 12:15:23 INFO - Running pre-action listener: _resource_record_pre_action 12:15:23 INFO - Running main action method: run_tests 12:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:23 INFO - Python 2.7.3 12:15:23 INFO - Return code: 0 12:15:23 INFO - grabbing minidump binary from tooltool 12:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:23 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 0x17e5d00>, '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 0x17e6a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e6eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:23 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 12:15:23 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 12:15:23 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 12:15:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:23 INFO - Return code: 0 12:15:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:15:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:15:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:15:23 INFO - Using env: {'DISPLAY': ':0', 12:15:23 INFO - 'HOME': '/home/cltbld', 12:15:23 INFO - 'LANG': 'en_US.UTF-8', 12:15:23 INFO - 'LANGUAGE': 'en_US:en', 12:15:23 INFO - 'LOGNAME': 'cltbld', 12:15:23 INFO - 'MAIL': '/var/mail/cltbld', 12:15:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:23 INFO - 'MOZ_NO_REMOTE': '1', 12:15:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:23 INFO - 'NO_EM_RESTART': '1', 12:15:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:23 INFO - 'PWD': '/builds/slave/test', 12:15:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:23 INFO - 'SHELL': '/bin/bash', 12:15:23 INFO - 'SHLVL': '1', 12:15:23 INFO - 'TERM': 'linux', 12:15:23 INFO - 'TMOUT': '86400', 12:15:23 INFO - 'USER': 'cltbld', 12:15:23 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078', 12:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:23 INFO - '_': '/tools/buildbot/bin/python'} 12:15:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:15:23 INFO - mozversion application_buildid: 20170305192237 12:15:23 INFO - mozversion application_changeset: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 12:15:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:15:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:23 INFO - mozversion application_name: Firefox 12:15:23 INFO - mozversion application_remotingname: firefox-dev 12:15:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:15:23 INFO - mozversion application_vendor: Mozilla 12:15:23 INFO - mozversion application_version: 53.0a2 12:15:23 INFO - mozversion platform_buildid: 20170305192237 12:15:23 INFO - mozversion platform_changeset: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 12:15:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:15:23 INFO - mozversion platform_version: 53.0a2 12:15:23 INFO - using testdate: 1488744923 12:15:23 INFO - actual date: 1488744923 12:15:23 INFO - starting webserver on 'localhost:51764' 12:15:23 INFO - SUITE-START | Running 2 tests 12:15:23 INFO - TEST-START | dromaeo_css 12:15:23 INFO - operating with platform_type : linux_ 12:15:23 INFO - Initialising browser for dromaeo_css test... 12:15:24 INFO - TEST-INFO | started process 6106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdnmd3F/profile http://localhost:51764/getInfo.html) 12:15:27 INFO - PROCESS | 6106 | __metrics Screen width/height:1600/1200 12:15:27 INFO - PROCESS | 6106 | colorDepth:24 12:15:27 INFO - PROCESS | 6106 | Browser inner width/height: 1024/697 12:15:27 INFO - PROCESS | 6106 | __metrics 12:15:28 INFO - PROCESS | 6106 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:15:28 INFO - PROCESS | 6106 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:29 INFO - TEST-INFO | 6106: exit 0 12:15:29 INFO - Browser initialized. 12:15:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:29 INFO - TEST-INFO | started process 6200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdnmd3F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:41 INFO - PROCESS | 6200 | RSS: Main: 137994240 12:15:41 INFO - PROCESS | 6200 | 12:18:41 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51764/tests/dromaeo/cssquery-ext.html) 12:18:42 INFO - PROCESS | 6200 | RSS: Main: 237334528 12:18:42 INFO - PROCESS | 6200 | 12:20:31 INFO - PROCESS | 6200 | ************************* 12:20:31 INFO - PROCESS | 6200 | A coding exception was thrown and uncaught in a Task. 12:20:31 INFO - PROCESS | 6200 | 12:20:31 ERROR - PROCESS | 6200 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:20:31 INFO - PROCESS | 6200 | Full stack: 12:20:31 INFO - PROCESS | 6200 | ************************* 12:21:45 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-ext.html (next: http://localhost:51764/tests/dromaeo/cssquery-jquery.html) 12:21:45 INFO - PROCESS | 6200 | RSS: Main: 224886784 12:21:45 INFO - PROCESS | 6200 | 12:24:47 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51764/tests/dromaeo/cssquery-mootools.html) 12:24:48 INFO - PROCESS | 6200 | RSS: Main: 176168960 12:24:48 INFO - PROCESS | 6200 | 12:27:50 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51764/tests/dromaeo/cssquery-prototype.html) 12:27:50 INFO - PROCESS | 6200 | RSS: Main: 211783680 12:27:50 INFO - PROCESS | 6200 | 12:30:53 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51764/tests/dromaeo/cssquery-yui.html) 12:30:53 INFO - PROCESS | 6200 | RSS: Main: 172134400 12:30:53 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | Cycle 1(1): loaded http://localhost:51764/tests/dromaeo/cssquery-yui.html (next: http://localhost:51764/tests/dromaeo/cssquery-dojo.html) 12:33:56 INFO - PROCESS | 6200 | RSS: Main: 259915776 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | __start_tp_report 12:33:56 INFO - PROCESS | 6200 | _x_x_mozilla_page_load 12:33:56 INFO - PROCESS | 6200 | _x_x_mozilla_page_load_details 12:33:56 INFO - PROCESS | 6200 | |i|pagename|runs| 12:33:56 INFO - PROCESS | 6200 | |0;dojo.html;3255.495398213277;3272.509123631455;3276.983615081924;3300.0924745694947;3328.3343331333726;5301.761420736067;5372.9462705372935;5386.218998245257;5393.514583687467;5401.621886467949;5383.057964856154;5383.892322153554;5403.648762830423;5408.161734931092;5432.6468779529305;4886.853394398174;4937.728424936627;4982.377202849644;4993.700377977333;5009.173486374744;4871.951280487186;4876.463589005207;4986;5049.64652474327;5061.392632884041;4898.41219053714;4902.852914412573;4926.753662316888;4985.277134815449;5003.724795136266;5003.549680528752;5009.774560144802;5013.298138260665;5014.774335154927;5040.1179793535985;4818.180909245437;4918.803247870117;4939.382577177853;4944.950550494521;4974.452810190876;5208.088584497736;5276.472352764731;5322.281491998569;5340.652857564246;5414.025475414423;5751.338596061423;5753.137029445575;5756.625819321731;5757;5778.479936805666;5723.914141287884;5757.453041961007;5780.50865676418;5783.739731712083;5784.219130417382;5255.39562950258;5299.1786273127345;5349.491798279235;5386.030514507348;5403.675779453245;5873.882522349529;5891.764329426861;5896.528277737856;5913.201717768132;5935.436133567304;5633.492985631231;5673.744681489343;5682.090865461506;5682.289713785777;5698.886022279531;5573.191887176336;5631.746571404215;5640.830775076754;5744.368119506851;5749.7700091996685;5696.544276457874;5711.543076553866;5751.884962300815;5783.103618939072;5798.072308430631;5748.396418376094;5750.137479378127;5754.251947246831;5759.308882934075;5759.6832174229985;4345.087531618332;4374.256376416017;4480.529544397857;4481.663875209372;4520.706154099973;3957.564667886588;3964.484616999772;3972.4239985201984;4026.275270451347;4058.776767277769;5552.7223638818705;5553.805616803474;5553.972230138824;5554.444555544494;5598.524125449382;5622.381538030813;5670.092785154438;5670.489655930986;5822.854428639318;5824.504917082011;5440.292761941001;5441.945580544144;5474.315710536183;5475.397706252309;5504.972475137599;4900.95099049005;4902.779374928136;4911.607071434277;4918.262260660929;4937.23472861707;5772.65364078165;5809.564282678901;5845.88308233833;5861.736221870026;5917.704114794243;5592.608517403743;5625.831225063254;5661.603687741983;5703.458171473703;5738.282714660668;5839.0949402842625;5839.883202336015;5845.912311315419;5847.883042339215;5849.766009359578;5560.91658625129;5609.943900561106;5613.831585052455;5615.438456154352;5618.69097199658;5662.886742265214;5676.4323567642905;5698.629589076697;5706.885862282814;5792.4497172768515;5568.860778480571;5617.017022021211;5621.409751976147;5621.74702138413;5646.548276137817;5573.442655734556;5585.609007369608;5620.943790562042;5626.718664066862;5628.465295796893;5424.945750542444;5481.150421684645;5587.413321601173;5602.719864006702;5651.43485651448;5658.943410565842;5663.3770285267765;5686.658800471985;5697.601167918206;5701.8859622806485;5559.054960656617;5562.860928476821;5567.582431317748;5567.860803479945;5568.303962004749 12:33:56 INFO - PROCESS | 6200 | |1;ext.html;548.955780167287;582.8571999860035;602.6805792929746;612.6783438694688;612.9824491344368;39681;47698.52301476984;48842.999999999956;48859;53806.19290710633;50972.49027509724;51081.23378149322;51506.484935150635;51519.48480515194;51576.74211628946;8657.95671021644;8890.86663700045;9271.629134834615;9470.337076404654;9471.431714097142;10531.21015923805;10798;10806.51370688317;11128.944355278212;11131.72170695731;11323.32060076394;11422.257553259053;11432.199746017783;11433.5426582937;11442.713932151679;11422.257553259053;11482.138839587064;11485.712857178554;11486.483108260149;11487.081033517341;11152.052075573585;11224.551017959271;11237.3257604544;11238.494267757971;11245.381504017276;47661.52338476606;47922;47976.28035579469;48055.75972120152;48062;4362.411074504965;4499.505054444008;4502.662300327489;4507.661925355612;4705.5764981151515;33026.33947321064;33031;33273.33453330944;33465.83267083673;34407.13982150441;4702.670813043088;4708.387909571768;4724.692894961817;4740.336352910595;4829.6860704054125;380734;385532.9999999972;385868;386351;387425;61220.69389653112;61343.6932815342;61402;61546.92265386713;61557.38442615606;63749.45002199953;63828;63910;63916.36083639197;63992;18996;19125.713114303297;19231;19300.420987370402;19315.710264346046;13166.407511661999;13474.461021559224;13487.325633718276;13904.304784760721;14883.181425021729;19081.141348639343;19454.902725486565;19524.316648917218;19546.67438171514;20210.696839547418;7321.231270716605;7323.231060738653;7432.962835185789;7439.702411903571;7513.549187048795;964.1081999150757;969.1277849935115;975.8192586969705;978.9167920726818;981.9950900245453;33574.66425335715;34210.657893421245;34280.14299642529;34450;34628.82685586556;1115.9188114167182;1176.9172361427507;1182.4206138992004;1194;1205.813098969661;15342.769858452131;16946.66106677884;17878.195481203118;18514.722279165824;18517.90741046286;559244;559989;561827;565215;565306;69109.30890691129;69972;70052.64973675099;70096.64951675209;70270.29729702638;1544.1584336536614;1545.3509525999107;1553.5727674889497;1562.1720488141302;1583.081812548719;34220.82889585536;35504.112397189245;35943.64056359403;36537.63462365342;36549.634503654626;58899;59641;59656.40343596682;59757.40242597518;59786.40213597808;439384;439456;441060;441224;441340;29335;29865.25336866596;30222.54666179965;31227.063188104392;36565;37742.8112859434;42754;47154.292685609056;47841.76079119582;51996.74001629968;40622.59377406306;49746.502534974185;50069;50307.24539131843;54429;48132.51867481421;50270.49729502658;50450;50645.49354506408;51006.23490647718;48520;49251.26123108085;49410;50179;50323.49676503335;47036.52963470458;47239.76380118077;48278.27582586334;48639.756801215764;48935;31959;32468.83765581157;32726;32741.836290819345;32965.67034329722 12:33:56 INFO - PROCESS | 6200 | |2;jquery.html;421.9873403797887;426.4073684787319;435.0633225726346;442.57512787723783;445.3987117391522;20429.387118386454;20841.79158208419;22257.44356391087;22411.551768964633;22448.214312499065;20710.48223794406;23105.768942310573;23149.884250578765;23326.183583574577;23389.532209355846;5980.073088671252;6257.968710156466;6265.874682506347;6266.49868010558;6268.623882567038;6146.600470969395;6347.650879201642;6390.360963903596;6506.54454188207;6508.284088750233;6307.18006659136;6383.457406120462;6492.772752953648;6506.967465162691;6507.251666058417;6474.640325531621;6526.967365163167;6531.7387304507765;6535.509836762262;6545.312742162052;6216.564840461169;6350.491960643138;6394.904076438857;6397.616143031433;6407.455366293824;13615.591532254048;13726.176429414267;14180.290985450687;15472;15663.608409789733;2829.448257589771;3098.3338582204933;3135.843207839599;3139.4505961456653;3201.951970720441;10550.366977981346;10655.733606659818;10694;10913.345199288067;11037.33775973436;2015.6271089848426;2028.7768345481986;2029.3607513633306;2033.4712974626705;2058.9279375221945;95752.52123739406;96489.5175524118;97822.51088744582;98200.50899745456;101059;12081;12093.818592721116;12471.314077725812;12507.687307817378;12619.30593817349;18183.636327273645;18185.181666825025;18189.363372281907;18226.36207732723;18228.270869165084;9177.954110229406;9371.953140234255;9461.290403219786;9488.762780930394;9495.43027418357;8890.777730556658;8896.733098007071;8933.46399216049;9206.493642849708;9223.308251881135;5268.947310526923;5277.208418737144;5341.973290133525;5342.439043900412;5427.267318911896;2141.796529329711;2186.8031877131134;2188.5513469738667;2256.3118248934234;2270.8637481750816;1127.402476687357;1137.4312843578211;1148.2192109365544;1152.9596464123715;1171.5255321594598;21553.030113644923;21821.23625673094;21860.781392185876;21931.67102493464;22169.556608867733;1158.195054437158;1175.508585871097;1186.2052424875353;1187.8455800746021;1203.2599951030054;11481.253718508437;11977.461014254379;12009.399530023464;12049.698757530956;12238.143329966817;664656;669057;678771;692506;742376;110939;111319;111450.44274778574;112894.43552782183;115540.844591553;1088.145805542661;1096.8135416979133;1096.9451527423757;1102.9117670586334;1108.5953626926114;18217.544561386072;18606.906965465085;18741.718874216625;18787.06064696787;18817.52956176052;45256.54743452524;45606;46931;46932.29601555911;47610;62396;62406;62913.68543157255;63526.36473635204;64024.359756403705;8925.73222803317;9050.230730387728;9230.907690923004;9334.439933604006;9628.807423851624;10037.849432258668;13636.86363136356;14270.653776012308;14377.065490743069;14673.119612823264;11956.163068585116;12136.968357689342;12245;12330.383480826102;12886.67783305425;11110.777784444428;11290.435478225892;11383.54465821391;11538;11571.537138514364;11879.524819007143;11908.225965312227;11911.940440297743;11937.28376297425;11980.46087926028;8841.513716745641;9054.502002389932;9080.455172689659;9120.908790912272;9326.880774307127;11577.479013444246;11918.40407979615;11953.402329883646;11973.341466219441;12276.263424194576 12:33:56 INFO - PROCESS | 6200 | |3;mootools.html;1367.0908845617664;1480.385639959417;1511.5012046024813;1512.6898985707924;1514.6743450158217;7392.445566582508;7995;8249.463784853988;8252.174782521744;8451.57742112895;8227.42408031438;8230.341572674186;8259.876101858463;8299.29455996241;8300.377471689633;2054.589082183562;2314.6875171851752;2354.329016230366;2354.5879471092576;2356.8703721295324;2133.1893880325456;2272.125231785766;2341.016772955354;2342.80086192673;2353.14110349722;2285.4172186092524;2291.0950174680993;2297.597920363938;2311.9422014449688;2315.3285547191294;2293.3693234360517;2307.4231442139467;2310.8676748393336;2312.664663623782;2312.6993490846253;2242.248846636379;2360.8701521416315;2364.598018336887;2368.4315764216462;2368.46709490365;8359;8403.621837017348;8406.621702023423;8430.367722420842;8432.198941100585;5177.119889618736;5324.946750532484;5335.013022590833;5337.866553336197;5338.225957236218;3234.2561210921385;3419.1669180517742;3428.5714285714284;3449.292894956553;3498.545189125423;1420.169201017406;1433.8064361311194;1439.6904665496968;1463.6414078550822;1479.2086233864832;10930.344179349264;11077.11383089351;11121.332720036824;11124.276922000045;11130.721731956766;4232.746035237896;4437.489688685778;4529.773511324421;4531.84138555149;4549.522300158502;9788.657396991213;9798.608055677836;9808.21534277256;9814.754631134136;9827.803443931225;5265.815696450606;5275.815346462932;5276.551493123051;5279.234510995884;5280.260763493114;4737.911783358368;4752.667313288037;4757.619390448755;4828.275758636232;4854.757262136879;3974.82113304902;4020.0954785173685;4036.1725846201457;4073.450084238649;4107.240160570304;1286.7941129419248;1288.9548865789652;1295.7214198947272;1299.590628951877;1301.8502872169822;945.6075728572703;973.493783232715;978.7161723100221;983.7884854756262;986.0878687214298;5373.194020896896;5373.462653734673;5417.349918009785;5446.863828404322;5590.105583106765;614.649649699667;615.3077787489075;618.703022549179;624.7906951171409;630.8959021761358;3752.8498860045293;3775.716821238418;3786.280606684721;3811.5807261201244;3850.2299540092095;9132.543372831466;9328.860067098998;9548.427094374221;9680.661176858917;9893.159081478156;9657.661981830603;9833.115019648267;9836.754081147885;9868.851967220497;9882.308238423386;7654.923450765533;7876.17300183484;7880.921190788134;7885.960570197112;7894.526328420313;5806.216160818404;5844.298684157929;5902.881942361215;5956.523478121653;5992.760289588367;9216.677416290398;9220.585073671835;9220.723378298662;9254.537273136451;9325.580348884181;8436.45163064399;9068.274538037072;9467.195288400562;9483.952580237055;9516.429014259167;6898.241193468614;7279.235680253497;7376.704931802882;7475.252474752699;7615.200403957505;7485.513441626277;7738.845223095619;7823.687052517836;7989.960050199712;8064.717734879486;7255.238199988925;7350.154732205865;7372.631368431665;7384.298491643285;7455.217202193691;7001.964990175016;7054.470914681317;7112.537685050455;7125.928740712734;7151.42788576923;6086;6293.590916590407;6558.1802274715665;6605.1083103780375;6618.569792963442;4979.950200497949;5056.064628043824;5121.359830021247;5122.615803814803;5143.665661731976;5168.147255702767;5183.740812959412;5198.74006299676;5247.291615631993;5310.707911064774 12:33:56 INFO - PROCESS | 6200 | |4;prototype.html;390.8026446644444;399.95200575930875;401.2056128864846;410.8459327752093;418.8722439655905;5330.413654498002;5346.866328341794;5362.329708786402;5377.516023557889;5394.597404674783;5032.773525191366;5102.566281866046;5189.72851651345;5243.711595862235;5303.787848486066;4265.083007153461;4269.395668642126;4283.550227226143;4284.400183974246;4298.333758267466;4286.485621725397;4289.849855255066;4292.055747735509;4292.356146578007;4299.634531064863;4023.8532018374767;4089.693273004522;4257.297545904938;4263.765492897889;4284.314509678452;4231.280682284004;4251;4262.381954616594;4271.273883439822;4307;3901.5903330150495;3909.2963266612;3917.1578110706337;3925.960740392588;3928.428628548575;5131.615128865313;5175.576716402981;5195.116830138885;5244;5256.632035757499;4900.313956046157;4900.387451568554;4910.926336104962;4916.459189489154;4935.555799978019;5588.469095435927;5597.356304025048;5605.001324291485;5615.550755939515;5629.4652008059165;4217.768022758747;4234.30134027885;4254.7093356525875;4280.657547396201;4330.826766929319;5739;5742.655440673531;5758.3090029196765;5775.711214439261;5805.187273781632;4397.538258482878;4409.272470042407;4429.55704429561;4432.667549933768;4440.977795111004;4056.1887622475033;4233.666395085538;4248.9787551062045;4454.1982443159895;4462.308342206963;4714.269288260325;4759.119562880878;4765.0231702500905;4774.7135171889795;4797.95202047982;5584.441555844383;5590.413006634326;5595.98544523971;5602.915956260659;5633.718314084279;1354.952576659832;1405.9648508787361;1409.3235247081254;1420.08404579048;1430.1562078373809;926.7997942664266;934.7522906429801;968.6948611187454;984.5913945712449;988.3180605382263;5213.6089793265655;5227.790888364499;5239.47605239473;5324;5326.733663316819;5600.987116530682;5605;5605.831825045255;5610.943890561042;5612.747426365741;5204.9739751301;5250.816221432232;5290.391604965478;5319.909418569184;5350.598705097055;2929.443405752943;2939.3827296268023;2942.3085574889883;2957;2970.069454854362;5434.728263586805;5580.693061881636;5653.434656534396;5705.343885453143;5709.143628455765;5501.779928802803;5524.392316845144;5545.833624991256;5582.8325150245555;5599.972000139973;5609;5702.315722113373;5715.342735585377;5722.828315150552;5739.6556206628575;5417.83746487606;5493.423190564933;5504.697241651747;5725.198472213977;5744.281964754406;5607.719614019365;5609.298837645294;5630.85922851932;5641.19481765831;5648.519875810603;5673.77304907799;5826.184334193132;5829.941700583109;5863.364713877423;5874.882502350015;4090.486519987505;4116.91766164681;4118.8352465901025;4132.40080188377;4144.274751918462;5718.771249149988;5718.798262668819;5723.3418156912485;5746.712664366849;5768.942310577008;5474.479924407175;5529.889402212014;5612.550995920398;5615.326160860723;5627.971860140673;5548.500634942875;5579.804706835242;5582.3859375467855;5587.804426845203;5601.591315734273;5277.147682192098;5439.3200849893765;5538.8061417851795;5570.629768989703;5595.5803314752375;5419.2954915862265;5566.638168519034;5566.914451682045;5572.916406253828;5578.525825304894;5448.4006759257245;5452.291202143696;5457.126859702428;5487.835364939058;5495.670259784426 12:33:56 INFO - PROCESS | 6200 | |5;yui.html;782.8786538086598;791.8733002719566;802.5322134436609;865.7489328094852;867.9305655547557;15584.766228506567;16423;16898;16931.49205523835;17015.82984170158;14903.10581365119;15072.32174552145;15083.698326033473;15447.536573902773;16233.107179105144;719.6725489902082;835.0397043400108;843.4096132707099;846.8094678697274;847.5296210603112;731.1920328037522;821.8685010398337;839.3998291221775;847.902491213509;848.1306660672798;873.4148120759106;879.7009016934242;881.920627143557;884.5665623844302;885.0087901550273;751.8308380614372;883.0771843423638;884.6107712606465;884.6461415433846;886.2511178054533;567.4467394290534;625.4558534075338;636.5798572941836;642.1555654314608;644.1883227133799;16106.114163720991;16545.25546350417;16566;16649.583760406087;16704.164791760362;14548.418063277457;15165.241737913171;15411.61470963235;15462.381504739797;15556.222188890624;14092.577222683336;14229.715405691932;14265.71468570633;14322.713545729028;14444.566663000021;4523.163214805271;4554.658400619934;4595.747233902134;4615.746133962631;4648.302754586839;77428;79256.99999999942;79266;79394.60302698507;79688.60155699242;12041.15711900176;12122.454489547992;12123.211991220542;12209.656937736841;12369.010479161645;23402.414939626644;23498.530029399317;23770.049198031884;23793.405164871016;23793.881030594737;8481.236688698047;8551.786205344792;8585.399022068521;8647.783805404915;8726.69456569017;4771.069641419959;4778.4982576829625;4830.806767729251;4835.081334546425;4916.041371932511;3424.2466657335344;3485.8082805445943;3491.301739652029;3498.317828023562;3505.789652620851;640.5388120553288;645.570695487505;654.594151625995;657.9671016449158;662.7680311890799;706.1279320039747;720.9026781384446;730.9853802924018;739.4380270993976;742.8031571633521;10200.489975501343;10547.314424562532;10941.343519388862;11032.338059716443;11042.558297668164;712.2023333866;726.9028851762703;729.1396152540053;729.6476517572704;747.5141158247075;5043.823466178666;5103.209002604528;5107.489251074937;5109.795608175706;5151.845444636667;77058.6147069261;77090;78533;80480.59759701164;81474.59262703649;66331.66834165895;66553;67069.32930670728;67316.6634166826;69827;56745;56745.14882276769;57001;57401;59958.70020649869;9326.300527460331;9691.612335506501;9780.070893265129;10083.848742268725;10121.746956326151;40220.597794022855;40684.79657601693;41148.35406583703;42005;42605.5739442614;52496;55611.721941391654;56006.719966399905;56018;58576.70711646585;12092.697682558006;12234.204776689487;12245.265284082983;12343.876561234632;12691.492340306284;13595.388207530883;13666.11170273929;13774.793378099135;13881.930590347387;13990.790138147733;12099.697507562381;12107.27356358586;12278.570250041206;12371.484408191125;13811.654708631962;14835.554933352018;14991;15045.924770376078;15146.772798408254;15303.311350989456;14347.497837575635;14670.046446980912;14690.926545367205;14748.115113093249;15133.924330378277;12314.876851231731;12779.552715654907;12805.487780488676;13023.739525209632;13240;11893.643190704293;12148.696282593006;12169.634910952685;12180.390980451119;12267.57063502773 12:33:56 INFO - PROCESS | 6200 | __end_tp_report 12:33:56 INFO - PROCESS | 6200 | __start_cc_report 12:33:56 INFO - PROCESS | 6200 | _x_x_mozilla_cycle_collect,1315 12:33:56 INFO - PROCESS | 6200 | __end_cc_report 12:33:56 INFO - PROCESS | 6200 | __startTimestamp1488746036593__endTimestamp 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | ------- Summary: start ------- 12:33:56 INFO - PROCESS | 6200 | Number of tests: 6 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#0] dojo.html Cycles:165 Average:5350.79 Median:5568.86 stddev:563.46 (10.1%) stddev-sans-first:540.68 12:33:56 INFO - PROCESS | 6200 | Values: 3255.5 3272.5 3277.0 3300.1 3328.3 5301.8 5372.9 5386.2 5393.5 5401.6 5383.1 5383.9 5403.6 5408.2 5432.6 4886.9 4937.7 4982.4 4993.7 5009.2 4872.0 4876.5 4986.0 5049.6 5061.4 4898.4 4902.9 4926.8 4985.3 5003.7 5003.5 5009.8 5013.3 5014.8 5040.1 4818.2 4918.8 4939.4 4945.0 4974.5 5208.1 5276.5 5322.3 5340.7 5414.0 5751.3 5753.1 5756.6 5757.0 5778.5 5723.9 5757.5 5780.5 5783.7 5784.2 5255.4 5299.2 5349.5 5386.0 5403.7 5873.9 5891.8 5896.5 5913.2 5935.4 5633.5 5673.7 5682.1 5682.3 5698.9 5573.2 5631.7 5640.8 5744.4 5749.8 5696.5 5711.5 5751.9 5783.1 5798.1 5748.4 5750.1 5754.3 5759.3 5759.7 4345.1 4374.3 4480.5 4481.7 4520.7 3957.6 3964.5 3972.4 4026.3 4058.8 5552.7 5553.8 5554.0 5554.4 5598.5 5622.4 5670.1 5670.5 5822.9 5824.5 5440.3 5441.9 5474.3 5475.4 5505.0 4901.0 4902.8 4911.6 4918.3 4937.2 5772.7 5809.6 5845.9 5861.7 5917.7 5592.6 5625.8 5661.6 5703.5 5738.3 5839.1 5839.9 5845.9 5847.9 5849.8 5560.9 5609.9 5613.8 5615.4 5618.7 5662.9 5676.4 5698.6 5706.9 5792.4 5568.9 5617.0 5621.4 5621.7 5646.5 5573.4 5585.6 5620.9 5626.7 5628.5 5424.9 5481.2 5587.4 5602.7 5651.4 5658.9 5663.4 5686.7 5697.6 5701.9 5559.1 5562.9 5567.6 5567.9 5568.3 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#1] ext.html Cycles:180 Average:65124.62 Median:4501.08 stddev:123813.43 (2750.7%) stddev-sans-first:124065.83 12:33:56 INFO - PROCESS | 6200 | Values: 549.0 582.9 602.7 612.7 613.0 39681.0 47698.5 48843.0 48859.0 53806.2 50972.5 51081.2 51506.5 51519.5 51576.7 8658.0 8890.9 9271.6 9470.3 9471.4 10531.2 10798.0 10806.5 11128.9 11131.7 11323.3 11422.3 11432.2 11433.5 11442.7 11422.3 11482.1 11485.7 11486.5 11487.1 11152.1 11224.6 11237.3 11238.5 11245.4 47661.5 47922.0 47976.3 48055.8 48062.0 4362.4 4499.5 4502.7 4507.7 4705.6 33026.3 33031.0 33273.3 33465.8 34407.1 4702.7 4708.4 4724.7 4740.3 4829.7 380734.0 385533.0 385868.0 386351.0 387425.0 61220.7 61343.7 61402.0 61546.9 61557.4 63749.5 63828.0 63910.0 63916.4 63992.0 18996.0 19125.7 19231.0 19300.4 19315.7 13166.4 13474.5 13487.3 13904.3 14883.2 19081.1 19454.9 19524.3 19546.7 20210.7 7321.2 7323.2 7433.0 7439.7 7513.5 964.1 969.1 975.8 978.9 982.0 33574.7 34210.7 34280.1 34450.0 34628.8 1115.9 1176.9 1182.4 1194.0 1205.8 15342.8 16946.7 17878.2 18514.7 18517.9 559244.0 559989.0 561827.0 565215.0 565306.0 69109.3 69972.0 70052.6 70096.6 70270.3 1544.2 1545.4 1553.6 1562.2 1583.1 34220.8 35504.1 35943.6 36537.6 36549.6 58899.0 59641.0 59656.4 59757.4 59786.4 439384.0 439456.0 441060.0 441224.0 441340.0 29335.0 29865.3 30222.5 31227.1 36565.0 37742.8 42754.0 47154.3 47841.8 51996.7 40622.6 49746.5 50069.0 50307.2 54429.0 48132.5 50270.5 50450.0 50645.5 51006.2 48520.0 49251.3 49410.0 50179.0 50323.5 47036.5 47239.8 48278.3 48639.8 48935.0 31959.0 32468.8 32726.0 32741.8 32965.7 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#2] jquery.html Cycles:180 Average:36337.05 Median:22050.61 stddev:113489.67 (514.7%) stddev-sans-first:113776.00 12:33:56 INFO - PROCESS | 6200 | Values: 422.0 426.4 435.1 442.6 445.4 20429.4 20841.8 22257.4 22411.6 22448.2 20710.5 23105.8 23149.9 23326.2 23389.5 5980.1 6258.0 6265.9 6266.5 6268.6 6146.6 6347.7 6390.4 6506.5 6508.3 6307.2 6383.5 6492.8 6507.0 6507.3 6474.6 6527.0 6531.7 6535.5 6545.3 6216.6 6350.5 6394.9 6397.6 6407.5 13615.6 13726.2 14180.3 15472.0 15663.6 2829.4 3098.3 3135.8 3139.5 3202.0 10550.4 10655.7 10694.0 10913.3 11037.3 2015.6 2028.8 2029.4 2033.5 2058.9 95752.5 96489.5 97822.5 98200.5 101059.0 12081.0 12093.8 12471.3 12507.7 12619.3 18183.6 18185.2 18189.4 18226.4 18228.3 9178.0 9372.0 9461.3 9488.8 9495.4 8890.8 8896.7 8933.5 9206.5 9223.3 5268.9 5277.2 5342.0 5342.4 5427.3 2141.8 2186.8 2188.6 2256.3 2270.9 1127.4 1137.4 1148.2 1153.0 1171.5 21553.0 21821.2 21860.8 21931.7 22169.6 1158.2 1175.5 1186.2 1187.8 1203.3 11481.3 11977.5 12009.4 12049.7 12238.1 664656.0 669057.0 678771.0 692506.0 742376.0 110939.0 111319.0 111450.4 112894.4 115540.8 1088.1 1096.8 1096.9 1102.9 1108.6 18217.5 18606.9 18741.7 18787.1 18817.5 45256.5 45606.0 46931.0 46932.3 47610.0 62396.0 62406.0 62913.7 63526.4 64024.4 8925.7 9050.2 9230.9 9334.4 9628.8 10037.8 13636.9 14270.7 14377.1 14673.1 11956.2 12137.0 12245.0 12330.4 12886.7 11110.8 11290.4 11383.5 11538.0 11571.5 11879.5 11908.2 11911.9 11937.3 11980.5 8841.5 9054.5 9080.5 9120.9 9326.9 11577.5 11918.4 11953.4 11973.3 12276.3 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#3] mootools.html Cycles:180 Average:5481.09 Median:5373.33 stddev:2959.79 (55.1%) stddev-sans-first:2951.95 12:33:56 INFO - PROCESS | 6200 | Values: 1367.1 1480.4 1511.5 1512.7 1514.7 7392.4 7995.0 8249.5 8252.2 8451.6 8227.4 8230.3 8259.9 8299.3 8300.4 2054.6 2314.7 2354.3 2354.6 2356.9 2133.2 2272.1 2341.0 2342.8 2353.1 2285.4 2291.1 2297.6 2311.9 2315.3 2293.4 2307.4 2310.9 2312.7 2312.7 2242.2 2360.9 2364.6 2368.4 2368.5 8359.0 8403.6 8406.6 8430.4 8432.2 5177.1 5324.9 5335.0 5337.9 5338.2 3234.3 3419.2 3428.6 3449.3 3498.5 1420.2 1433.8 1439.7 1463.6 1479.2 10930.3 11077.1 11121.3 11124.3 11130.7 4232.7 4437.5 4529.8 4531.8 4549.5 9788.7 9798.6 9808.2 9814.8 9827.8 5265.8 5275.8 5276.6 5279.2 5280.3 4737.9 4752.7 4757.6 4828.3 4854.8 3974.8 4020.1 4036.2 4073.5 4107.2 1286.8 1289.0 1295.7 1299.6 1301.9 945.6 973.5 978.7 983.8 986.1 5373.2 5373.5 5417.3 5446.9 5590.1 614.6 615.3 618.7 624.8 630.9 3752.8 3775.7 3786.3 3811.6 3850.2 9132.5 9328.9 9548.4 9680.7 9893.2 9657.7 9833.1 9836.8 9868.9 9882.3 7654.9 7876.2 7880.9 7886.0 7894.5 5806.2 5844.3 5902.9 5956.5 5992.8 9216.7 9220.6 9220.7 9254.5 9325.6 8436.5 9068.3 9467.2 9484.0 9516.4 6898.2 7279.2 7376.7 7475.3 7615.2 7485.5 7738.8 7823.7 7990.0 8064.7 7255.2 7350.2 7372.6 7384.3 7455.2 7002.0 7054.5 7112.5 7125.9 7151.4 6086.0 6293.6 6558.2 6605.1 6618.6 4980.0 5056.1 5121.4 5122.6 5143.7 5168.1 5183.7 5198.7 5247.3 5310.7 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#4] prototype.html Cycles:180 Average:4709.93 Median:5338.64 stddev:1335.28 (25.0%) stddev-sans-first:1299.08 12:33:56 INFO - PROCESS | 6200 | Values: 390.8 400.0 401.2 410.8 418.9 5330.4 5346.9 5362.3 5377.5 5394.6 5032.8 5102.6 5189.7 5243.7 5303.8 4265.1 4269.4 4283.6 4284.4 4298.3 4286.5 4289.8 4292.1 4292.4 4299.6 4023.9 4089.7 4257.3 4263.8 4284.3 4231.3 4251.0 4262.4 4271.3 4307.0 3901.6 3909.3 3917.2 3926.0 3928.4 5131.6 5175.6 5195.1 5244.0 5256.6 4900.3 4900.4 4910.9 4916.5 4935.6 5588.5 5597.4 5605.0 5615.6 5629.5 4217.8 4234.3 4254.7 4280.7 4330.8 5739.0 5742.7 5758.3 5775.7 5805.2 4397.5 4409.3 4429.6 4432.7 4441.0 4056.2 4233.7 4249.0 4454.2 4462.3 4714.3 4759.1 4765.0 4774.7 4798.0 5584.4 5590.4 5596.0 5602.9 5633.7 1355.0 1406.0 1409.3 1420.1 1430.2 926.8 934.8 968.7 984.6 988.3 5213.6 5227.8 5239.5 5324.0 5326.7 5601.0 5605.0 5605.8 5610.9 5612.7 5205.0 5250.8 5290.4 5319.9 5350.6 2929.4 2939.4 2942.3 2957.0 2970.1 5434.7 5580.7 5653.4 5705.3 5709.1 5501.8 5524.4 5545.8 5582.8 5600.0 5609.0 5702.3 5715.3 5722.8 5739.7 5417.8 5493.4 5504.7 5725.2 5744.3 5607.7 5609.3 5630.9 5641.2 5648.5 5673.8 5826.2 5829.9 5863.4 5874.9 4090.5 4116.9 4118.8 4132.4 4144.3 5718.8 5718.8 5723.3 5746.7 5768.9 5474.5 5529.9 5612.6 5615.3 5628.0 5548.5 5579.8 5582.4 5587.8 5601.6 5277.1 5439.3 5538.8 5570.6 5595.6 5419.3 5566.6 5566.9 5572.9 5578.5 5448.4 5452.3 5457.1 5487.8 5495.7 12:33:56 INFO - PROCESS | 6200 | 12:33:56 INFO - PROCESS | 6200 | [#5] yui.html Cycles:180 Average:17811.68 Median:4632.02 stddev:21977.97 (474.5%) stddev-sans-first:22002.42 12:33:56 INFO - PROCESS | 6200 | Values: 782.9 791.9 802.5 865.7 867.9 15584.8 16423.0 16898.0 16931.5 17015.8 14903.1 15072.3 15083.7 15447.5 16233.1 719.7 835.0 843.4 846.8 847.5 731.2 821.9 839.4 847.9 848.1 873.4 879.7 881.9 884.6 885.0 751.8 883.1 884.6 884.6 886.3 567.4 625.5 636.6 642.2 644.2 16106.1 16545.3 16566.0 16649.6 16704.2 14548.4 15165.2 15411.6 15462.4 15556.2 14092.6 14229.7 14265.7 14322.7 14444.6 4523.2 4554.7 4595.7 4615.7 4648.3 77428.0 79257.0 79266.0 79394.6 79688.6 12041.2 12122.5 12123.2 12209.7 12369.0 23402.4 23498.5 23770.0 23793.4 23793.9 8481.2 8551.8 8585.4 8647.8 8726.7 4771.1 4778.5 4830.8 4835.1 4916.0 3424.2 3485.8 3491.3 3498.3 3505.8 640.5 645.6 654.6 658.0 662.8 706.1 720.9 731.0 739.4 742.8 10200.5 10547.3 10941.3 11032.3 11042.6 712.2 726.9 729.1 729.6 747.5 5043.8 5103.2 5107.5 5109.8 5151.8 77058.6 77090.0 78533.0 80480.6 81474.6 66331.7 66553.0 67069.3 67316.7 69827.0 56745.0 56745.1 57001.0 57401.0 59958.7 9326.3 9691.6 9780.1 10083.8 10121.7 40220.6 40684.8 41148.4 42005.0 42605.6 52496.0 55611.7 56006.7 56018.0 58576.7 12092.7 12234.2 12245.3 12343.9 12691.5 13595.4 13666.1 13774.8 13881.9 13990.8 12099.7 12107.3 12278.6 12371.5 13811.7 14835.6 14991.0 15045.9 15146.8 15303.3 14347.5 14670.0 14690.9 14748.1 15133.9 12314.9 12779.6 12805.5 13023.7 13240.0 11893.6 12148.7 12169.6 12180.4 12267.6 12:33:56 INFO - PROCESS | 6200 | -------- Summary: end -------- 12:33:56 INFO - PROCESS | 6200 | 12:33:57 INFO - TEST-INFO | 6200: exit 0 12:33:57 INFO - TEST-OK | dromaeo_css | took 1113426ms 12:33:57 INFO - TEST-START | kraken 12:33:57 INFO - operating with platform_type : linux_ 12:33:57 INFO - Initialising browser for kraken test... 12:33:57 INFO - TEST-INFO | started process 6520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l3slM/profile http://localhost:51764/getInfo.html) 12:34:01 INFO - PROCESS | 6520 | __metrics Screen width/height:1600/1200 12:34:01 INFO - PROCESS | 6520 | colorDepth:24 12:34:01 INFO - PROCESS | 6520 | Browser inner width/height: 1024/697 12:34:01 INFO - PROCESS | 6520 | __metrics 12:34:02 INFO - PROCESS | 6520 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:34:02 INFO - PROCESS | 6520 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:03 INFO - TEST-INFO | 6520: exit 0 12:34:03 INFO - Browser initialized. 12:34:03 INFO - Running cycle 1/1 for kraken test... 12:34:03 INFO - TEST-INFO | started process 6612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l3slM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:15 INFO - PROCESS | 6612 | RSS: Main: 137363456 12:34:15 INFO - PROCESS | 6612 | 12:34:17 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51764/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:18 INFO - PROCESS | 6612 | RSS: Main: 181112832 12:34:18 INFO - PROCESS | 6612 | 12:34:20 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51764/tests/kraken/driver.html?testName=audio-dft) 12:34:21 INFO - PROCESS | 6612 | RSS: Main: 171929600 12:34:21 INFO - PROCESS | 6612 | 12:34:24 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51764/tests/kraken/driver.html?testName=audio-fft) 12:34:24 INFO - PROCESS | 6612 | RSS: Main: 263168000 12:34:24 INFO - PROCESS | 6612 | 12:34:27 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51764/tests/kraken/driver.html?testName=audio-oscillator) 12:34:27 INFO - PROCESS | 6612 | RSS: Main: 170283008 12:34:27 INFO - PROCESS | 6612 | 12:34:29 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:30 INFO - PROCESS | 6612 | RSS: Main: 171421696 12:34:30 INFO - PROCESS | 6612 | 12:34:33 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51764/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:33 INFO - PROCESS | 6612 | RSS: Main: 211333120 12:34:33 INFO - PROCESS | 6612 | 12:34:37 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51764/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:37 INFO - PROCESS | 6612 | RSS: Main: 209616896 12:34:37 INFO - PROCESS | 6612 | 12:34:40 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51764/tests/kraken/driver.html?testName=json-parse-financial) 12:34:41 INFO - PROCESS | 6612 | RSS: Main: 207912960 12:34:41 INFO - PROCESS | 6612 | 12:34:42 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:43 INFO - PROCESS | 6612 | RSS: Main: 170545152 12:34:43 INFO - PROCESS | 6612 | 12:34:44 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:45 INFO - PROCESS | 6612 | RSS: Main: 177340416 12:34:45 INFO - PROCESS | 6612 | 12:34:47 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:48 INFO - PROCESS | 6612 | RSS: Main: 186392576 12:34:48 INFO - PROCESS | 6612 | 12:34:50 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:51 INFO - PROCESS | 6612 | RSS: Main: 196235264 12:34:51 INFO - PROCESS | 6612 | 12:34:54 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:54 INFO - PROCESS | 6612 | RSS: Main: 191991808 12:34:54 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:51764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51764/tests/kraken/driver.html?testName=ai-astar) 12:34:56 INFO - PROCESS | 6612 | RSS: Main: 243929088 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | __start_tp_report 12:34:56 INFO - PROCESS | 6612 | _x_x_mozilla_page_load 12:34:56 INFO - PROCESS | 6612 | _x_x_mozilla_page_load_details 12:34:56 INFO - PROCESS | 6612 | |i|pagename|runs| 12:34:56 INFO - PROCESS | 6612 | |0;ai-astar;109;111;110;111;110;111;110;110;111;111 12:34:56 INFO - PROCESS | 6612 | |1;audio-beat-detection;144;120;118;159;123;118;121;117;136;119 12:34:56 INFO - PROCESS | 6612 | |2;audio-dft;162;162;161;163;159;166;161;160;161;160 12:34:56 INFO - PROCESS | 6612 | |3;audio-fft;75;74;75;121;75;78;74;76;89;76 12:34:56 INFO - PROCESS | 6612 | |4;audio-oscillator;83;82;107;83;82;82;95;83;82;101 12:34:56 INFO - PROCESS | 6612 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;117 12:34:56 INFO - PROCESS | 6612 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;146;147 12:34:56 INFO - PROCESS | 6612 | |7;imaging-desaturate;96;95;95;96;95;96;96;96;97;95 12:34:56 INFO - PROCESS | 6612 | |8;json-parse-financial;52;48;48;46;49;49;50;47;47;47 12:34:56 INFO - PROCESS | 6612 | |9;json-stringify-tinderbox;63;64;64;63;64;63;63;64;64;64 12:34:56 INFO - PROCESS | 6612 | |10;stanford-crypto-aes;76;78;74;75;74;74;87;75;80;75 12:34:56 INFO - PROCESS | 6612 | |11;stanford-crypto-ccm;124;128;119;129;123;120;126;119;158;117 12:34:56 INFO - PROCESS | 6612 | |12;stanford-crypto-pbkdf2;162;157;158;161;167;161;162;156;157;161 12:34:56 INFO - PROCESS | 6612 | |13;stanford-crypto-sha256-iterative;64;61;60;63;60;61;60;61;61;59 12:34:56 INFO - PROCESS | 6612 | __end_tp_report 12:34:56 INFO - PROCESS | 6612 | __start_cc_report 12:34:56 INFO - PROCESS | 6612 | _x_x_mozilla_cycle_collect,1506 12:34:56 INFO - PROCESS | 6612 | __end_cc_report 12:34:56 INFO - PROCESS | 6612 | __startTimestamp1488746096481__endTimestamp 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | ------- Summary: start ------- 12:34:56 INFO - PROCESS | 6612 | Number of tests: 14 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 12:34:56 INFO - PROCESS | 6612 | Values: 109.0 111.0 110.0 111.0 110.0 111.0 110.0 110.0 111.0 111.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:122.00 stddev:14.21 (11.7%) stddev-sans-first:13.77 12:34:56 INFO - PROCESS | 6612 | Values: 144.0 120.0 118.0 159.0 123.0 118.0 121.0 117.0 136.0 119.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.96 (1.2%) stddev-sans-first:2.07 12:34:56 INFO - PROCESS | 6612 | Values: 162.0 162.0 161.0 163.0 159.0 166.0 161.0 160.0 161.0 160.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:14.64 (19.4%) stddev-sans-first:15.35 12:34:56 INFO - PROCESS | 6612 | Values: 75.0 74.0 75.0 121.0 75.0 78.0 74.0 76.0 89.0 76.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.50 stddev:9.42 (11.4%) stddev-sans-first:9.81 12:34:56 INFO - PROCESS | 6612 | Values: 83.0 82.0 107.0 83.0 82.0 82.0 95.0 83.0 82.0 101.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:34:56 INFO - PROCESS | 6612 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:34:56 INFO - PROCESS | 6612 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:34:56 INFO - PROCESS | 6612 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 97.0 95.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.50 stddev:1.77 (3.6%) stddev-sans-first:1.27 12:34:56 INFO - PROCESS | 6612 | Values: 52.0 48.0 48.0 46.0 49.0 49.0 50.0 47.0 47.0 47.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 12:34:56 INFO - PROCESS | 6612 | Values: 63.0 64.0 64.0 63.0 64.0 63.0 63.0 64.0 64.0 64.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:75.50 stddev:4.08 (5.4%) stddev-sans-first:4.31 12:34:56 INFO - PROCESS | 6612 | Values: 76.0 78.0 74.0 75.0 74.0 74.0 87.0 75.0 80.0 75.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:125.00 stddev:11.85 (9.5%) stddev-sans-first:12.54 12:34:56 INFO - PROCESS | 6612 | Values: 124.0 128.0 119.0 129.0 123.0 120.0 126.0 119.0 158.0 117.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:3.29 (2.0%) stddev-sans-first:3.43 12:34:56 INFO - PROCESS | 6612 | Values: 162.0 157.0 158.0 161.0 167.0 161.0 162.0 156.0 157.0 161.0 12:34:56 INFO - PROCESS | 6612 | 12:34:56 INFO - PROCESS | 6612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:1.49 (2.4%) stddev-sans-first:1.12 12:34:56 INFO - PROCESS | 6612 | Values: 64.0 61.0 60.0 63.0 60.0 61.0 60.0 61.0 61.0 59.0 12:34:56 INFO - PROCESS | 6612 | -------- Summary: end -------- 12:34:56 INFO - PROCESS | 6612 | 12:34:57 INFO - TEST-INFO | 6612: exit 0 12:34:57 INFO - TEST-OK | kraken | took 60129ms 12:34:57 INFO - SUITE-END | took 1173s 12:34:57 INFO - Completed test suite (00:19:33) 12:34:57 INFO - javascript benchmark 12:34:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.495398213277, 3272.509123631455, 3276.983615081924, 3300.0924745694947, 3328.3343331333726, 5301.761420736067, 5372.9462705372935, 5386.218998245257, 5393.514583687467, 5401.621886467949, 5383.057964856154, 5383.892322153554, 5403.648762830423, 5408.161734931092, 5432.6468779529305, 4886.853394398174, 4937.728424936627, 4982.377202849644, 4993.700377977333, 5009.173486374744, 4871.951280487186, 4876.463589005207, 4986.0, 5049.64652474327, 5061.392632884041, 4898.41219053714, 4902.852914412573, 4926.753662316888, 4985.277134815449, 5003.724795136266, 5003.549680528752, 5009.774560144802, 5013.298138260665, 5014.774335154927, 5040.1179793535985, 4818.180909245437, 4918.803247870117, 4939.382577177853, 4944.950550494521, 4974.452810190876, 5208.088584497736, 5276.472352764731, 5322.281491998569, 5340.652857564246, 5414.025475414423, 5751.338596061423, 5753.137029445575, 5756.625819321731, 5757.0, 5778.479936805666, 5723.914141287884, 5757.453041961007, 5780.50865676418, 5783.739731712083, 5784.219130417382, 5255.39562950258, 5299.1786273127345, 5349.491798279235, 5386.030514507348, 5403.675779453245, 5873.882522349529, 5891.764329426861, 5896.528277737856, 5913.201717768132, 5935.436133567304, 5633.492985631231, 5673.744681489343, 5682.090865461506, 5682.289713785777, 5698.886022279531, 5573.191887176336, 5631.746571404215, 5640.830775076754, 5744.368119506851, 5749.7700091996685, 5696.544276457874, 5711.543076553866, 5751.884962300815, 5783.103618939072, 5798.072308430631, 5748.396418376094, 5750.137479378127, 5754.251947246831, 5759.308882934075, 5759.6832174229985, 4345.087531618332, 4374.256376416017, 4480.529544397857, 4481.663875209372, 4520.706154099973, 3957.564667886588, 3964.484616999772, 3972.4239985201984, 4026.275270451347, 4058.776767277769, 5552.7223638818705, 5553.805616803474, 5553.972230138824, 5554.444555544494, 5598.524125449382, 5622.381538030813, 5670.092785154438, 5670.489655930986, 5822.854428639318, 5824.504917082011, 5440.292761941001, 5441.945580544144, 5474.315710536183, 5475.397706252309, 5504.972475137599, 4900.95099049005, 4902.779374928136, 4911.607071434277, 4918.262260660929, 4937.23472861707, 5772.65364078165, 5809.564282678901, 5845.88308233833, 5861.736221870026, 5917.704114794243, 5592.608517403743, 5625.831225063254, 5661.603687741983, 5703.458171473703, 5738.282714660668, 5839.0949402842625, 5839.883202336015, 5845.912311315419, 5847.883042339215, 5849.766009359578, 5560.91658625129, 5609.943900561106, 5613.831585052455, 5615.438456154352, 5618.69097199658, 5662.886742265214, 5676.4323567642905, 5698.629589076697, 5706.885862282814, 5792.4497172768515, 5568.860778480571, 5617.017022021211, 5621.409751976147, 5621.74702138413, 5646.548276137817, 5573.442655734556, 5585.609007369608, 5620.943790562042, 5626.718664066862, 5628.465295796893, 5424.945750542444, 5481.150421684645, 5587.413321601173, 5602.719864006702, 5651.43485651448, 5658.943410565842, 5663.3770285267765, 5686.658800471985, 5697.601167918206, 5701.8859622806485, 5559.054960656617, 5562.860928476821, 5567.582431317748, 5567.860803479945, 5568.303962004749], "value": 5315.980152350557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.955780167287, 582.8571999860035, 602.6805792929746, 612.6783438694688, 612.9824491344368, 39681.0, 47698.52301476984, 48842.999999999956, 48859.0, 53806.19290710633, 50972.49027509724, 51081.23378149322, 51506.484935150635, 51519.48480515194, 51576.74211628946, 8657.95671021644, 8890.86663700045, 9271.629134834615, 9470.337076404654, 9471.431714097142, 10531.21015923805, 10798.0, 10806.51370688317, 11128.944355278212, 11131.72170695731, 11323.32060076394, 11422.257553259053, 11432.199746017783, 11433.5426582937, 11442.713932151679, 11422.257553259053, 11482.138839587064, 11485.712857178554, 11486.483108260149, 11487.081033517341, 11152.052075573585, 11224.551017959271, 11237.3257604544, 11238.494267757971, 11245.381504017276, 47661.52338476606, 47922.0, 47976.28035579469, 48055.75972120152, 48062.0, 4362.411074504965, 4499.505054444008, 4502.662300327489, 4507.661925355612, 4705.5764981151515, 33026.33947321064, 33031.0, 33273.33453330944, 33465.83267083673, 34407.13982150441, 4702.670813043088, 4708.387909571768, 4724.692894961817, 4740.336352910595, 4829.6860704054125, 380734.0, 385532.9999999972, 385868.0, 386351.0, 387425.0, 61220.69389653112, 61343.6932815342, 61402.0, 61546.92265386713, 61557.38442615606, 63749.45002199953, 63828.0, 63910.0, 63916.36083639197, 63992.0, 18996.0, 19125.713114303297, 19231.0, 19300.420987370402, 19315.710264346046, 13166.407511661999, 13474.461021559224, 13487.325633718276, 13904.304784760721, 14883.181425021729, 19081.141348639343, 19454.902725486565, 19524.316648917218, 19546.67438171514, 20210.696839547418, 7321.231270716605, 7323.231060738653, 7432.962835185789, 7439.702411903571, 7513.549187048795, 964.1081999150757, 969.1277849935115, 975.8192586969705, 978.9167920726818, 981.9950900245453, 33574.66425335715, 34210.657893421245, 34280.14299642529, 34450.0, 34628.82685586556, 1115.9188114167182, 1176.9172361427507, 1182.4206138992004, 1194.0, 1205.813098969661, 15342.769858452131, 16946.66106677884, 17878.195481203118, 18514.722279165824, 18517.90741046286, 559244.0, 559989.0, 561827.0, 565215.0, 565306.0, 69109.30890691129, 69972.0, 70052.64973675099, 70096.64951675209, 70270.29729702638, 1544.1584336536614, 1545.3509525999107, 1553.5727674889497, 1562.1720488141302, 1583.081812548719, 34220.82889585536, 35504.112397189245, 35943.64056359403, 36537.63462365342, 36549.634503654626, 58899.0, 59641.0, 59656.40343596682, 59757.40242597518, 59786.40213597808, 439384.0, 439456.0, 441060.0, 441224.0, 441340.0, 29335.0, 29865.25336866596, 30222.54666179965, 31227.063188104392, 36565.0, 37742.8112859434, 42754.0, 47154.292685609056, 47841.76079119582, 51996.74001629968, 40622.59377406306, 49746.502534974185, 50069.0, 50307.24539131843, 54429.0, 48132.51867481421, 50270.49729502658, 50450.0, 50645.49354506408, 51006.23490647718, 48520.0, 49251.26123108085, 49410.0, 50179.0, 50323.49676503335, 47036.52963470458, 47239.76380118077, 48278.27582586334, 48639.756801215764, 48935.0, 31959.0, 32468.83765581157, 32726.0, 32741.836290819345, 32965.67034329722], "value": 22467.470695791395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.9873403797887, 426.4073684787319, 435.0633225726346, 442.57512787723783, 445.3987117391522, 20429.387118386454, 20841.79158208419, 22257.44356391087, 22411.551768964633, 22448.214312499065, 20710.48223794406, 23105.768942310573, 23149.884250578765, 23326.183583574577, 23389.532209355846, 5980.073088671252, 6257.968710156466, 6265.874682506347, 6266.49868010558, 6268.623882567038, 6146.600470969395, 6347.650879201642, 6390.360963903596, 6506.54454188207, 6508.284088750233, 6307.18006659136, 6383.457406120462, 6492.772752953648, 6506.967465162691, 6507.251666058417, 6474.640325531621, 6526.967365163167, 6531.7387304507765, 6535.509836762262, 6545.312742162052, 6216.564840461169, 6350.491960643138, 6394.904076438857, 6397.616143031433, 6407.455366293824, 13615.591532254048, 13726.176429414267, 14180.290985450687, 15472.0, 15663.608409789733, 2829.448257589771, 3098.3338582204933, 3135.843207839599, 3139.4505961456653, 3201.951970720441, 10550.366977981346, 10655.733606659818, 10694.0, 10913.345199288067, 11037.33775973436, 2015.6271089848426, 2028.7768345481986, 2029.3607513633306, 2033.4712974626705, 2058.9279375221945, 95752.52123739406, 96489.5175524118, 97822.51088744582, 98200.50899745456, 101059.0, 12081.0, 12093.818592721116, 12471.314077725812, 12507.687307817378, 12619.30593817349, 18183.636327273645, 18185.181666825025, 18189.363372281907, 18226.36207732723, 18228.270869165084, 9177.954110229406, 9371.953140234255, 9461.290403219786, 9488.762780930394, 9495.43027418357, 8890.777730556658, 8896.733098007071, 8933.46399216049, 9206.493642849708, 9223.308251881135, 5268.947310526923, 5277.208418737144, 5341.973290133525, 5342.439043900412, 5427.267318911896, 2141.796529329711, 2186.8031877131134, 2188.5513469738667, 2256.3118248934234, 2270.8637481750816, 1127.402476687357, 1137.4312843578211, 1148.2192109365544, 1152.9596464123715, 1171.5255321594598, 21553.030113644923, 21821.23625673094, 21860.781392185876, 21931.67102493464, 22169.556608867733, 1158.195054437158, 1175.508585871097, 1186.2052424875353, 1187.8455800746021, 1203.2599951030054, 11481.253718508437, 11977.461014254379, 12009.399530023464, 12049.698757530956, 12238.143329966817, 664656.0, 669057.0, 678771.0, 692506.0, 742376.0, 110939.0, 111319.0, 111450.44274778574, 112894.43552782183, 115540.844591553, 1088.145805542661, 1096.8135416979133, 1096.9451527423757, 1102.9117670586334, 1108.5953626926114, 18217.544561386072, 18606.906965465085, 18741.718874216625, 18787.06064696787, 18817.52956176052, 45256.54743452524, 45606.0, 46931.0, 46932.29601555911, 47610.0, 62396.0, 62406.0, 62913.68543157255, 63526.36473635204, 64024.359756403705, 8925.73222803317, 9050.230730387728, 9230.907690923004, 9334.439933604006, 9628.807423851624, 10037.849432258668, 13636.86363136356, 14270.653776012308, 14377.065490743069, 14673.119612823264, 11956.163068585116, 12136.968357689342, 12245.0, 12330.383480826102, 12886.67783305425, 11110.777784444428, 11290.435478225892, 11383.54465821391, 11538.0, 11571.537138514364, 11879.524819007143, 11908.225965312227, 11911.940440297743, 11937.28376297425, 11980.46087926028, 8841.513716745641, 9054.502002389932, 9080.455172689659, 9120.908790912272, 9326.880774307127, 11577.479013444246, 11918.40407979615, 11953.402329883646, 11973.341466219441, 12276.263424194576], "value": 10166.54454668331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.0908845617664, 1480.385639959417, 1511.5012046024813, 1512.6898985707924, 1514.6743450158217, 7392.445566582508, 7995.0, 8249.463784853988, 8252.174782521744, 8451.57742112895, 8227.42408031438, 8230.341572674186, 8259.876101858463, 8299.29455996241, 8300.377471689633, 2054.589082183562, 2314.6875171851752, 2354.329016230366, 2354.5879471092576, 2356.8703721295324, 2133.1893880325456, 2272.125231785766, 2341.016772955354, 2342.80086192673, 2353.14110349722, 2285.4172186092524, 2291.0950174680993, 2297.597920363938, 2311.9422014449688, 2315.3285547191294, 2293.3693234360517, 2307.4231442139467, 2310.8676748393336, 2312.664663623782, 2312.6993490846253, 2242.248846636379, 2360.8701521416315, 2364.598018336887, 2368.4315764216462, 2368.46709490365, 8359.0, 8403.621837017348, 8406.621702023423, 8430.367722420842, 8432.198941100585, 5177.119889618736, 5324.946750532484, 5335.013022590833, 5337.866553336197, 5338.225957236218, 3234.2561210921385, 3419.1669180517742, 3428.5714285714284, 3449.292894956553, 3498.545189125423, 1420.169201017406, 1433.8064361311194, 1439.6904665496968, 1463.6414078550822, 1479.2086233864832, 10930.344179349264, 11077.11383089351, 11121.332720036824, 11124.276922000045, 11130.721731956766, 4232.746035237896, 4437.489688685778, 4529.773511324421, 4531.84138555149, 4549.522300158502, 9788.657396991213, 9798.608055677836, 9808.21534277256, 9814.754631134136, 9827.803443931225, 5265.815696450606, 5275.815346462932, 5276.551493123051, 5279.234510995884, 5280.260763493114, 4737.911783358368, 4752.667313288037, 4757.619390448755, 4828.275758636232, 4854.757262136879, 3974.82113304902, 4020.0954785173685, 4036.1725846201457, 4073.450084238649, 4107.240160570304, 1286.7941129419248, 1288.9548865789652, 1295.7214198947272, 1299.590628951877, 1301.8502872169822, 945.6075728572703, 973.493783232715, 978.7161723100221, 983.7884854756262, 986.0878687214298, 5373.194020896896, 5373.462653734673, 5417.349918009785, 5446.863828404322, 5590.105583106765, 614.649649699667, 615.3077787489075, 618.703022549179, 624.7906951171409, 630.8959021761358, 3752.8498860045293, 3775.716821238418, 3786.280606684721, 3811.5807261201244, 3850.2299540092095, 9132.543372831466, 9328.860067098998, 9548.427094374221, 9680.661176858917, 9893.159081478156, 9657.661981830603, 9833.115019648267, 9836.754081147885, 9868.851967220497, 9882.308238423386, 7654.923450765533, 7876.17300183484, 7880.921190788134, 7885.960570197112, 7894.526328420313, 5806.216160818404, 5844.298684157929, 5902.881942361215, 5956.523478121653, 5992.760289588367, 9216.677416290398, 9220.585073671835, 9220.723378298662, 9254.537273136451, 9325.580348884181, 8436.45163064399, 9068.274538037072, 9467.195288400562, 9483.952580237055, 9516.429014259167, 6898.241193468614, 7279.235680253497, 7376.704931802882, 7475.252474752699, 7615.200403957505, 7485.513441626277, 7738.845223095619, 7823.687052517836, 7989.960050199712, 8064.717734879486, 7255.238199988925, 7350.154732205865, 7372.631368431665, 7384.298491643285, 7455.217202193691, 7001.964990175016, 7054.470914681317, 7112.537685050455, 7125.928740712734, 7151.42788576923, 6086.0, 6293.590916590407, 6558.1802274715665, 6605.1083103780375, 6618.569792963442, 4979.950200497949, 5056.064628043824, 5121.359830021247, 5122.615803814803, 5143.665661731976, 5168.147255702767, 5183.740812959412, 5198.74006299676, 5247.291615631993, 5310.707911064774], "value": 4445.572332535088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.8026446644444, 399.95200575930875, 401.2056128864846, 410.8459327752093, 418.8722439655905, 5330.413654498002, 5346.866328341794, 5362.329708786402, 5377.516023557889, 5394.597404674783, 5032.773525191366, 5102.566281866046, 5189.72851651345, 5243.711595862235, 5303.787848486066, 4265.083007153461, 4269.395668642126, 4283.550227226143, 4284.400183974246, 4298.333758267466, 4286.485621725397, 4289.849855255066, 4292.055747735509, 4292.356146578007, 4299.634531064863, 4023.8532018374767, 4089.693273004522, 4257.297545904938, 4263.765492897889, 4284.314509678452, 4231.280682284004, 4251.0, 4262.381954616594, 4271.273883439822, 4307.0, 3901.5903330150495, 3909.2963266612, 3917.1578110706337, 3925.960740392588, 3928.428628548575, 5131.615128865313, 5175.576716402981, 5195.116830138885, 5244.0, 5256.632035757499, 4900.313956046157, 4900.387451568554, 4910.926336104962, 4916.459189489154, 4935.555799978019, 5588.469095435927, 5597.356304025048, 5605.001324291485, 5615.550755939515, 5629.4652008059165, 4217.768022758747, 4234.30134027885, 4254.7093356525875, 4280.657547396201, 4330.826766929319, 5739.0, 5742.655440673531, 5758.3090029196765, 5775.711214439261, 5805.187273781632, 4397.538258482878, 4409.272470042407, 4429.55704429561, 4432.667549933768, 4440.977795111004, 4056.1887622475033, 4233.666395085538, 4248.9787551062045, 4454.1982443159895, 4462.308342206963, 4714.269288260325, 4759.119562880878, 4765.0231702500905, 4774.7135171889795, 4797.95202047982, 5584.441555844383, 5590.413006634326, 5595.98544523971, 5602.915956260659, 5633.718314084279, 1354.952576659832, 1405.9648508787361, 1409.3235247081254, 1420.08404579048, 1430.1562078373809, 926.7997942664266, 934.7522906429801, 968.6948611187454, 984.5913945712449, 988.3180605382263, 5213.6089793265655, 5227.790888364499, 5239.47605239473, 5324.0, 5326.733663316819, 5600.987116530682, 5605.0, 5605.831825045255, 5610.943890561042, 5612.747426365741, 5204.9739751301, 5250.816221432232, 5290.391604965478, 5319.909418569184, 5350.598705097055, 2929.443405752943, 2939.3827296268023, 2942.3085574889883, 2957.0, 2970.069454854362, 5434.728263586805, 5580.693061881636, 5653.434656534396, 5705.343885453143, 5709.143628455765, 5501.779928802803, 5524.392316845144, 5545.833624991256, 5582.8325150245555, 5599.972000139973, 5609.0, 5702.315722113373, 5715.342735585377, 5722.828315150552, 5739.6556206628575, 5417.83746487606, 5493.423190564933, 5504.697241651747, 5725.198472213977, 5744.281964754406, 5607.719614019365, 5609.298837645294, 5630.85922851932, 5641.19481765831, 5648.519875810603, 5673.77304907799, 5826.184334193132, 5829.941700583109, 5863.364713877423, 5874.882502350015, 4090.486519987505, 4116.91766164681, 4118.8352465901025, 4132.40080188377, 4144.274751918462, 5718.771249149988, 5718.798262668819, 5723.3418156912485, 5746.712664366849, 5768.942310577008, 5474.479924407175, 5529.889402212014, 5612.550995920398, 5615.326160860723, 5627.971860140673, 5548.500634942875, 5579.804706835242, 5582.3859375467855, 5587.804426845203, 5601.591315734273, 5277.147682192098, 5439.3200849893765, 5538.8061417851795, 5570.629768989703, 5595.5803314752375, 5419.2954915862265, 5566.638168519034, 5566.914451682045, 5572.916406253828, 5578.525825304894, 5448.4006759257245, 5452.291202143696, 5457.126859702428, 5487.835364939058, 5495.670259784426], "value": 4298.798637132923, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.8786538086598, 791.8733002719566, 802.5322134436609, 865.7489328094852, 867.9305655547557, 15584.766228506567, 16423.0, 16898.0, 16931.49205523835, 17015.82984170158, 14903.10581365119, 15072.32174552145, 15083.698326033473, 15447.536573902773, 16233.107179105144, 719.6725489902082, 835.0397043400108, 843.4096132707099, 846.8094678697274, 847.5296210603112, 731.1920328037522, 821.8685010398337, 839.3998291221775, 847.902491213509, 848.1306660672798, 873.4148120759106, 879.7009016934242, 881.920627143557, 884.5665623844302, 885.0087901550273, 751.8308380614372, 883.0771843423638, 884.6107712606465, 884.6461415433846, 886.2511178054533, 567.4467394290534, 625.4558534075338, 636.5798572941836, 642.1555654314608, 644.1883227133799, 16106.114163720991, 16545.25546350417, 16566.0, 16649.583760406087, 16704.164791760362, 14548.418063277457, 15165.241737913171, 15411.61470963235, 15462.381504739797, 15556.222188890624, 14092.577222683336, 14229.715405691932, 14265.71468570633, 14322.713545729028, 14444.566663000021, 4523.163214805271, 4554.658400619934, 4595.747233902134, 4615.746133962631, 4648.302754586839, 77428.0, 79256.99999999942, 79266.0, 79394.60302698507, 79688.60155699242, 12041.15711900176, 12122.454489547992, 12123.211991220542, 12209.656937736841, 12369.010479161645, 23402.414939626644, 23498.530029399317, 23770.049198031884, 23793.405164871016, 23793.881030594737, 8481.236688698047, 8551.786205344792, 8585.399022068521, 8647.783805404915, 8726.69456569017, 4771.069641419959, 4778.4982576829625, 4830.806767729251, 4835.081334546425, 4916.041371932511, 3424.2466657335344, 3485.8082805445943, 3491.301739652029, 3498.317828023562, 3505.789652620851, 640.5388120553288, 645.570695487505, 654.594151625995, 657.9671016449158, 662.7680311890799, 706.1279320039747, 720.9026781384446, 730.9853802924018, 739.4380270993976, 742.8031571633521, 10200.489975501343, 10547.314424562532, 10941.343519388862, 11032.338059716443, 11042.558297668164, 712.2023333866, 726.9028851762703, 729.1396152540053, 729.6476517572704, 747.5141158247075, 5043.823466178666, 5103.209002604528, 5107.489251074937, 5109.795608175706, 5151.845444636667, 77058.6147069261, 77090.0, 78533.0, 80480.59759701164, 81474.59262703649, 66331.66834165895, 66553.0, 67069.32930670728, 67316.6634166826, 69827.0, 56745.0, 56745.14882276769, 57001.0, 57401.0, 59958.70020649869, 9326.300527460331, 9691.612335506501, 9780.070893265129, 10083.848742268725, 10121.746956326151, 40220.597794022855, 40684.79657601693, 41148.35406583703, 42005.0, 42605.5739442614, 52496.0, 55611.721941391654, 56006.719966399905, 56018.0, 58576.70711646585, 12092.697682558006, 12234.204776689487, 12245.265284082983, 12343.876561234632, 12691.492340306284, 13595.388207530883, 13666.11170273929, 13774.793378099135, 13881.930590347387, 13990.790138147733, 12099.697507562381, 12107.27356358586, 12278.570250041206, 12371.484408191125, 13811.654708631962, 14835.554933352018, 14991.0, 15045.924770376078, 15146.772798408254, 15303.311350989456, 14347.497837575635, 14670.046446980912, 14690.926545367205, 14748.115113093249, 15133.924330378277, 12314.876851231731, 12779.552715654907, 12805.487780488676, 13023.739525209632, 13240.0, 11893.643190704293, 12148.696282593006, 12169.634910952685, 12180.390980451119, 12267.57063502773], "value": 7518.699481443022, "unit": "score"}], "name": "dromaeo_css", "value": 7475.323758753552, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 118.0, 159.0, 123.0, 118.0, 121.0, 117.0, 136.0, 119.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 159.0, 166.0, 161.0, 160.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 121.0, 75.0, 78.0, 74.0, 76.0, 89.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 83.0, 82.0, 82.0, 95.0, 83.0, 82.0, 101.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 48.0, 48.0, 46.0, 49.0, 49.0, 50.0, 47.0, 47.0, 47.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 74.0, 75.0, 74.0, 74.0, 87.0, 75.0, 80.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 119.0, 129.0, 123.0, 120.0, 126.0, 119.0, 158.0, 117.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 158.0, 161.0, 167.0, 161.0, 162.0, 156.0, 157.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 63.0, 60.0, 61.0, 60.0, 61.0, 61.0, 59.0], "value": 61.0, "unit": "score"}], "name": "kraken", "value": 1464.0, "alertThreshold": 2.0}]} 12:34:57 INFO - Return code: 0 12:34:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:57 ERROR - # TBPL SUCCESS # 12:34:57 INFO - Running post-action listener: _resource_record_post_action 12:34:57 INFO - [mozharness: 2017-03-05 20:34:57.800166Z] Finished run-tests step (success) 12:34:57 INFO - Running post-run listener: _resource_record_post_run 12:34:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 363839488; Read time: 0; Write time: 254952 12:34:57 INFO - TinderboxPrint: CPU usage
13.0% 12:34:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:34:57 INFO - TinderboxPrint: I/O write bytes / time
363,839,488 / 254,952 12:34:57 INFO - TinderboxPrint: CPU idle
8,262.2 (87.0%) 12:34:57 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 12:34:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110276608; Read time: 0; Write time: 112364 12:34:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 253562880; Read time: 0; Write time: 142588 12:34:58 INFO - Running post-run listener: _upload_blobber_files 12:34:58 INFO - Blob upload gear active. 12:34:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:58 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 12:34:58 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-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:34:58 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-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:59 INFO - (blobuploader) - INFO - Done attempting. 12:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:00 INFO - (blobuploader) - INFO - Done attempting. 12:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:01 INFO - (blobuploader) - INFO - Done attempting. 12:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:07 INFO - (blobuploader) - INFO - Done attempting. 12:35:07 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:07 INFO - Return code: 0 12:35:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eb2a6d006a094c893d94871d5eab861ea78bddc7220489edf0b0139ba02d1a25277d109a7bbd0e49e5ec4f19d72d7c50845dda6218ba09e0f6c22bda9f584b33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4687f7670ffcf74d331da966c2ea67c42140565c6bdca8bed039a44a06c2dc5ba88554a24a98f4499bdff8a419deeec0aab5223da75115408cc5a1c97c1bcf55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/26f53362f4132255c5575d6d240dc3135f00385ffe9ea04fbc0c19af268a083dcb6ce3c70526dad93984a0c6a3a977a32439d0ce7957908c674a2377c02d3f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a36c0325714ab06b28b94f775927395be32d9c7a61663c5c67814160025b20fc71d208f517112d215732aab233f87c567329f1a2d90a0ab051dd382a13bd6ce4"} 12:35:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:07 INFO - Contents: 12:35:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eb2a6d006a094c893d94871d5eab861ea78bddc7220489edf0b0139ba02d1a25277d109a7bbd0e49e5ec4f19d72d7c50845dda6218ba09e0f6c22bda9f584b33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4687f7670ffcf74d331da966c2ea67c42140565c6bdca8bed039a44a06c2dc5ba88554a24a98f4499bdff8a419deeec0aab5223da75115408cc5a1c97c1bcf55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/26f53362f4132255c5575d6d240dc3135f00385ffe9ea04fbc0c19af268a083dcb6ce3c70526dad93984a0c6a3a977a32439d0ce7957908c674a2377c02d3f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a36c0325714ab06b28b94f775927395be32d9c7a61663c5c67814160025b20fc71d208f517112d215732aab233f87c567329f1a2d90a0ab051dd382a13bd6ce4"} 12:35:07 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:07 INFO - Copying logs to upload dir... 12:35:07 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.180140 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-03-05 12:35:05.892860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 12:35:05.896578) ========= 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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eb2a6d006a094c893d94871d5eab861ea78bddc7220489edf0b0139ba02d1a25277d109a7bbd0e49e5ec4f19d72d7c50845dda6218ba09e0f6c22bda9f584b33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4687f7670ffcf74d331da966c2ea67c42140565c6bdca8bed039a44a06c2dc5ba88554a24a98f4499bdff8a419deeec0aab5223da75115408cc5a1c97c1bcf55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/26f53362f4132255c5575d6d240dc3135f00385ffe9ea04fbc0c19af268a083dcb6ce3c70526dad93984a0c6a3a977a32439d0ce7957908c674a2377c02d3f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a36c0325714ab06b28b94f775927395be32d9c7a61663c5c67814160025b20fc71d208f517112d215732aab233f87c567329f1a2d90a0ab051dd382a13bd6ce4"} build_url:https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/DFaMYxWESz2KCdI-yvrACQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eb2a6d006a094c893d94871d5eab861ea78bddc7220489edf0b0139ba02d1a25277d109a7bbd0e49e5ec4f19d72d7c50845dda6218ba09e0f6c22bda9f584b33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4687f7670ffcf74d331da966c2ea67c42140565c6bdca8bed039a44a06c2dc5ba88554a24a98f4499bdff8a419deeec0aab5223da75115408cc5a1c97c1bcf55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/26f53362f4132255c5575d6d240dc3135f00385ffe9ea04fbc0c19af268a083dcb6ce3c70526dad93984a0c6a3a977a32439d0ce7957908c674a2377c02d3f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a36c0325714ab06b28b94f775927395be32d9c7a61663c5c67814160025b20fc71d208f517112d215732aab233f87c567329f1a2d90a0ab051dd382a13bd6ce4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 12:35:05.921719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:35:05.922048) ========= 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=2432103b8b3de4003b23cad4000001c2-1488736370.239061-34793078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 12:35:06.007091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 12:35:06.007426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 12:35:06.007720) ========= ========= Total master_lag: 0.15 =========