builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1489191243.26 results: success (0) revision: e5eb0121a580e4b8acf53886861363f669a864ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.259202) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.259743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.260075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.274703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.275074) ========= 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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 16:14:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.7M=0s 2017-03-10 16:14:03 (68.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.416447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.416771) ========= 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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014869 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.465624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:03.465929) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e5eb0121a580e4b8acf53886861363f669a864ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e5eb0121a580e4b8acf53886861363f669a864ad --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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 16:14:04,018 truncating revision to first 12 chars 2017-03-10 16:14:04,018 Setting DEBUG logging. 2017-03-10 16:14:04,018 attempt 1/10 2017-03-10 16:14:04,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e5eb0121a580?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 16:14:04,581 unpacking tar archive at: mozilla-beta-e5eb0121a580/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:04.406227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:04.406540) ========= script_repo_revision: e5eb0121a580e4b8acf53886861363f669a864ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:04.406898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:04.407173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 16:14:04.416324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-03-10 16:14:04.416592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:14:05 INFO - MultiFileLogger online at 20170310 16:14:05 in /builds/slave/test 16:14:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:14:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:14:05 INFO - {'append_to_log': False, 16:14:05 INFO - 'base_work_dir': '/builds/slave/test', 16:14:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:14:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:14:05 INFO - 'branch': 'Mozilla-Beta', 16:14:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:05 INFO - 'config_files': ('talos/linux_config.py',), 16:14:05 INFO - 'default_actions': ('clobber', 16:14:05 INFO - 'read-buildbot-config', 16:14:05 INFO - 'download-and-extract', 16:14:05 INFO - 'populate-webroot', 16:14:05 INFO - 'create-virtualenv', 16:14:05 INFO - 'install', 16:14:05 INFO - 'run-tests'), 16:14:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:05 INFO - 'download_minidump_stackwalk': True, 16:14:05 INFO - 'download_symbols': 'ondemand', 16:14:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:05 INFO - 'installer_path': 'installer.exe', 16:14:05 INFO - 'log_level': 'info', 16:14:05 INFO - 'log_name': 'talos', 16:14:05 INFO - 'log_to_console': True, 16:14:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:14:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:14:05 INFO - 'opt_config_files': (), 16:14:05 INFO - 'pip_index': False, 16:14:05 INFO - 'sps_profile': False, 16:14:05 INFO - 'sps_profile_interval': 0, 16:14:05 INFO - 'suite': 'dromaeojs', 16:14:05 INFO - 'system_bits': '32', 16:14:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:05 INFO - 'title': 'talos-linux64-ix-054', 16:14:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:05 INFO - 'use_talos_json': True, 16:14:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:14:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:05 INFO - 'work_dir': 'build'} 16:14:05 INFO - [mozharness: 2017-03-11 00:14:05.062904Z] Running clobber step. 16:14:05 INFO - Running pre-action listener: _resource_record_pre_action 16:14:05 INFO - Running main action method: clobber 16:14:05 INFO - rmtree: /builds/slave/test/build 16:14:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:14:05 INFO - Running post-action listener: _resource_record_post_action 16:14:05 INFO - [mozharness: 2017-03-11 00:14:05.990793Z] Finished clobber step (success) 16:14:05 INFO - [mozharness: 2017-03-11 00:14:05.990893Z] Running read-buildbot-config step. 16:14:05 INFO - Running pre-action listener: _resource_record_pre_action 16:14:05 INFO - Running main action method: read_buildbot_config 16:14:05 INFO - Using buildbot properties: 16:14:05 INFO - { 16:14:05 INFO - "project": "", 16:14:05 INFO - "product": "firefox", 16:14:05 INFO - "who": "ryanvm@gmail.com", 16:14:05 INFO - "installer_path": "public/build/target.tar.bz2", 16:14:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:14:05 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 16:14:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:14:05 INFO - "stage_platform": "linux64-pgo", 16:14:05 INFO - "basedir": "/builds/slave/test", 16:14:05 INFO - "buildnumber": 165, 16:14:05 INFO - "platform": "ubuntu64_hw", 16:14:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:14:05 INFO - "slavebuilddir": "test", 16:14:05 INFO - "taskId": "UbmZMISoRTym3QbzOIzJvg", 16:14:05 INFO - "branch": "mozilla-beta", 16:14:05 INFO - "script_repo_revision": "production", 16:14:05 INFO - "revision": "e5eb0121a580e4b8acf53886861363f669a864ad", 16:14:05 INFO - "slavename": "talos-linux64-ix-054", 16:14:05 INFO - "repo_path": "releases/mozilla-beta" 16:14:05 INFO - } 16:14:05 INFO - Finding installer, test and symbols from parent task. 16:14:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbmZMISoRTym3QbzOIzJvg'}, attempt #1 16:14:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbmZMISoRTym3QbzOIzJvg'}, attempt #1 16:14:06 INFO - Task dependencies: Zw9qqp3uRa6OAploAAhfuw 16:14:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw'}, attempt #1 16:14:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 16:14:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/test_packages.json 16:14:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.crashreporter-symbols.zip 16:14:07 INFO - Running post-action listener: _resource_record_post_action 16:14:07 INFO - [mozharness: 2017-03-11 00:14:07.373142Z] Finished read-buildbot-config step (success) 16:14:07 INFO - [mozharness: 2017-03-11 00:14:07.373361Z] Running download-and-extract step. 16:14:07 INFO - Running pre-action listener: _resource_record_pre_action 16:14:07 INFO - Running main action method: download_and_extract 16:14:07 INFO - mkdir: /builds/slave/test/build/tests 16:14:07 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')]} 16:14:07 INFO - trying https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.test_packages.json 16:14:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:14:07 INFO - Downloaded 896 bytes. 16:14:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:14:07 INFO - Using the following test package requirements: 16:14:07 INFO - {u'common': [u'target.common.tests.zip'], 16:14:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:14:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:14:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:14:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:14:07 INFO - u'mozbase': [u'target.common.tests.zip'], 16:14:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:14:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:14:07 INFO - u'web-platform': [u'target.common.tests.zip', 16:14:07 INFO - u'target.web-platform.tests.zip'], 16:14:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:14:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:14:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip 16:14:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:14:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip into memory 16:14:08 INFO - Expected file size: 21861924 16:14:08 INFO - Obtained file size: 21861924 16:14:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:14:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip 16:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:14:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.common.tests.zip into memory 16:14:13 INFO - Expected file size: 21861924 16:14:13 INFO - Obtained file size: 21861924 16:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.talos.tests.zip 16:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.talos.tests.zip into memory 16:14:18 INFO - Expected file size: 14403650 16:14:18 INFO - Obtained file size: 14403650 16:14:18 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')]} 16:14:18 INFO - trying https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 16:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:14:20 INFO - Downloaded 58907103 bytes. 16:14:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 16:14:20 INFO - mkdir: /builds/slave/test/properties 16:14:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:20 INFO - Contents: 16:14:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 16:14:20 INFO - Running post-action listener: _resource_record_post_action 16:14:20 INFO - Running post-action listener: set_extra_try_arguments 16:14:20 INFO - [mozharness: 2017-03-11 00:14:20.133646Z] Finished download-and-extract step (success) 16:14:20 INFO - [mozharness: 2017-03-11 00:14:20.133743Z] Running populate-webroot step. 16:14:20 INFO - Running pre-action listener: _resource_record_pre_action 16:14:20 INFO - Running main action method: populate_webroot 16:14:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:20 INFO - '--tppagecycles', 16:14:20 INFO - '7'], 16:14:20 INFO - 'tests': ['tsvgm']}}, 16:14:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['damp', 'tps']}, 16:14:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'tests': ['damp', 'tps']}, 16:14:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['dromaeo_dom']}, 16:14:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['basic_compositor_video']}, 16:14:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['a11yr', 16:14:20 INFO - 'ts_paint', 16:14:20 INFO - 'tpaint', 16:14:20 INFO - 'sessionrestore', 16:14:20 INFO - 'sessionrestore_no_auto_restore', 16:14:20 INFO - 'tabpaint']}, 16:14:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['tsvgx', 16:14:20 INFO - 'tsvgr_opacity', 16:14:20 INFO - 'tart', 16:14:20 INFO - 'tscrollx', 16:14:20 INFO - 'cart', 16:14:20 INFO - 'tsvg_static']}, 16:14:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:20 INFO - 'tsvgr_opacity', 16:14:20 INFO - 'tart', 16:14:20 INFO - 'tscrollx', 16:14:20 INFO - 'cart', 16:14:20 INFO - 'tsvg_static']}, 16:14:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'talos_options': ['--disable-e10s'], 16:14:20 INFO - 'tests': ['tp5o']}, 16:14:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:14:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'talos_options': ['--disable-e10s', 16:14:20 INFO - '--xperf_path', 16:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:20 INFO - 'tests': ['tp5n']}, 16:14:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:14:20 INFO - 'talos_options': ['--xperf_path', 16:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:20 INFO - 'tests': ['tp5n']}}, 16:14:20 INFO - 'talos.zip': {'path': '', 16:14:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:20 INFO - Running post-action listener: _resource_record_post_action 16:14:20 INFO - [mozharness: 2017-03-11 00:14:20.147924Z] Finished populate-webroot step (success) 16:14:20 INFO - [mozharness: 2017-03-11 00:14:20.148017Z] Running create-virtualenv step. 16:14:20 INFO - Running pre-action listener: _resource_record_pre_action 16:14:20 INFO - Running main action method: create_virtualenv 16:14:20 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:20 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 16:14:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:20 INFO - Using real prefix '/usr' 16:14:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:22 INFO - Installing pip.................done. 16:14:22 INFO - Return code: 0 16:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:14:23 INFO - Reading from file tmpfile_stdout 16:14:23 INFO - Output received: 16:14:23 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) 16:14:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:23 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 16:14:23 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 16:14:23 INFO - Using env: {'DISPLAY': ':0', 16:14:23 INFO - 'HOME': '/home/cltbld', 16:14:23 INFO - 'LANG': 'en_US.UTF-8', 16:14:23 INFO - 'LANGUAGE': 'en_US:en', 16:14:23 INFO - 'LOGNAME': 'cltbld', 16:14:23 INFO - 'MAIL': '/var/mail/cltbld', 16:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:23 INFO - 'MOZ_NO_REMOTE': '1', 16:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:23 INFO - 'NO_EM_RESTART': '1', 16:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:23 INFO - 'PWD': '/builds/slave/test', 16:14:23 INFO - 'SHELL': '/bin/bash', 16:14:23 INFO - 'SHLVL': '1', 16:14:23 INFO - 'TERM': 'linux', 16:14:23 INFO - 'TMOUT': '86400', 16:14:23 INFO - 'USER': 'cltbld', 16:14:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:23 INFO - '_': '/tools/buildbot/bin/python'} 16:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:23 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 16:14:23 INFO - Cleaning up... 16:14:23 INFO - Return code: 0 16:14:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:23 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 16:14:23 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 16:14:23 INFO - Using env: {'DISPLAY': ':0', 16:14:23 INFO - 'HOME': '/home/cltbld', 16:14:23 INFO - 'LANG': 'en_US.UTF-8', 16:14:23 INFO - 'LANGUAGE': 'en_US:en', 16:14:23 INFO - 'LOGNAME': 'cltbld', 16:14:23 INFO - 'MAIL': '/var/mail/cltbld', 16:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:23 INFO - 'MOZ_NO_REMOTE': '1', 16:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:23 INFO - 'NO_EM_RESTART': '1', 16:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:23 INFO - 'PWD': '/builds/slave/test', 16:14:23 INFO - 'SHELL': '/bin/bash', 16:14:23 INFO - 'SHLVL': '1', 16:14:23 INFO - 'TERM': 'linux', 16:14:23 INFO - 'TMOUT': '86400', 16:14:23 INFO - 'USER': 'cltbld', 16:14:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:23 INFO - '_': '/tools/buildbot/bin/python'} 16:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:23 INFO - Downloading/unpacking psutil>=3.1.1 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:25 INFO - Installing collected packages: psutil 16:14:25 INFO - Running setup.py install for psutil 16:14:25 INFO - building 'psutil._psutil_linux' extension 16:14:25 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 16:14:25 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 16:14:25 INFO - building 'psutil._psutil_posix' extension 16:14:25 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 16:14:26 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 16:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:26 INFO - Successfully installed psutil 16:14:26 INFO - Cleaning up... 16:14:26 INFO - Return code: 0 16:14:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:26 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')]} 16:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:26 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')]} 16:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:26 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:26 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 16:14:26 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 16:14:26 INFO - Using env: {'DISPLAY': ':0', 16:14:26 INFO - 'HOME': '/home/cltbld', 16:14:26 INFO - 'LANG': 'en_US.UTF-8', 16:14:26 INFO - 'LANGUAGE': 'en_US:en', 16:14:26 INFO - 'LOGNAME': 'cltbld', 16:14:26 INFO - 'MAIL': '/var/mail/cltbld', 16:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:26 INFO - 'MOZ_NO_REMOTE': '1', 16:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:26 INFO - 'NO_EM_RESTART': '1', 16:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:26 INFO - 'PWD': '/builds/slave/test', 16:14:26 INFO - 'SHELL': '/bin/bash', 16:14:26 INFO - 'SHLVL': '1', 16:14:26 INFO - 'TERM': 'linux', 16:14:26 INFO - 'TMOUT': '86400', 16:14:26 INFO - 'USER': 'cltbld', 16:14:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:26 INFO - '_': '/tools/buildbot/bin/python'} 16:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:26 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 16:14:26 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 16:14:26 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 16:14:26 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 16:14:26 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 16:14:26 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 16:14:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:28 INFO - Installing collected packages: mozsystemmonitor 16:14:28 INFO - Running setup.py install for mozsystemmonitor 16:14:28 INFO - Successfully installed mozsystemmonitor 16:14:28 INFO - Cleaning up... 16:14:28 INFO - Return code: 0 16:14:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:28 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')]} 16:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:28 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')]} 16:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:28 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:28 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 16:14:28 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 16:14:28 INFO - Using env: {'DISPLAY': ':0', 16:14:28 INFO - 'HOME': '/home/cltbld', 16:14:28 INFO - 'LANG': 'en_US.UTF-8', 16:14:28 INFO - 'LANGUAGE': 'en_US:en', 16:14:28 INFO - 'LOGNAME': 'cltbld', 16:14:28 INFO - 'MAIL': '/var/mail/cltbld', 16:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:28 INFO - 'MOZ_NO_REMOTE': '1', 16:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:28 INFO - 'NO_EM_RESTART': '1', 16:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:28 INFO - 'PWD': '/builds/slave/test', 16:14:28 INFO - 'SHELL': '/bin/bash', 16:14:28 INFO - 'SHLVL': '1', 16:14:28 INFO - 'TERM': 'linux', 16:14:28 INFO - 'TMOUT': '86400', 16:14:28 INFO - 'USER': 'cltbld', 16:14:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:28 INFO - '_': '/tools/buildbot/bin/python'} 16:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:28 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:28 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 16:14:28 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 16:14:28 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 16:14:28 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 16:14:28 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 16:14:28 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 16:14:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:30 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 16:14:30 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 16:14:30 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 16:14:30 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 16:14:30 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 16:14:30 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 16:14:31 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:31 INFO - warning: no files found matching '*.txt' 16:14:31 INFO - no previously-included directories found matching 'build' 16:14:31 INFO - no previously-included directories found matching 'dist' 16:14:31 INFO - no previously-included directories found matching '.git*' 16:14:31 INFO - Installing collected packages: jsonschema, functools32 16:14:31 INFO - Running setup.py install for functools32 16:14:31 INFO - warning: no files found matching '*.txt' 16:14:31 INFO - no previously-included directories found matching 'build' 16:14:31 INFO - no previously-included directories found matching 'dist' 16:14:31 INFO - no previously-included directories found matching '.git*' 16:14:31 INFO - Successfully installed jsonschema functools32 16:14:31 INFO - Cleaning up... 16:14:31 INFO - Return code: 0 16:14:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14:31 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')]} 16:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 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')]} 16:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:31 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 16:14:31 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 16:14:31 INFO - Using env: {'DISPLAY': ':0', 16:14:31 INFO - 'HOME': '/home/cltbld', 16:14:31 INFO - 'LANG': 'en_US.UTF-8', 16:14:31 INFO - 'LANGUAGE': 'en_US:en', 16:14:31 INFO - 'LOGNAME': 'cltbld', 16:14:31 INFO - 'MAIL': '/var/mail/cltbld', 16:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:31 INFO - 'MOZ_NO_REMOTE': '1', 16:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:31 INFO - 'NO_EM_RESTART': '1', 16:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:31 INFO - 'PWD': '/builds/slave/test', 16:14:31 INFO - 'SHELL': '/bin/bash', 16:14:31 INFO - 'SHLVL': '1', 16:14:31 INFO - 'TERM': 'linux', 16:14:31 INFO - 'TMOUT': '86400', 16:14:31 INFO - 'USER': 'cltbld', 16:14:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:31 INFO - '_': '/tools/buildbot/bin/python'} 16:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:31 INFO - Cleaning up... 16:14:31 INFO - Return code: 0 16:14:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:31 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')]} 16:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 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')]} 16:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:31 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:31 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 16:14:31 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 16:14:31 INFO - Using env: {'DISPLAY': ':0', 16:14:31 INFO - 'HOME': '/home/cltbld', 16:14:31 INFO - 'LANG': 'en_US.UTF-8', 16:14:31 INFO - 'LANGUAGE': 'en_US:en', 16:14:31 INFO - 'LOGNAME': 'cltbld', 16:14:31 INFO - 'MAIL': '/var/mail/cltbld', 16:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:31 INFO - 'MOZ_NO_REMOTE': '1', 16:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:31 INFO - 'NO_EM_RESTART': '1', 16:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:31 INFO - 'PWD': '/builds/slave/test', 16:14:31 INFO - 'SHELL': '/bin/bash', 16:14:31 INFO - 'SHLVL': '1', 16:14:31 INFO - 'TERM': 'linux', 16:14:31 INFO - 'TMOUT': '86400', 16:14:31 INFO - 'USER': 'cltbld', 16:14:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:31 INFO - '_': '/tools/buildbot/bin/python'} 16:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:31 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 16:14:31 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 16:14:31 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 16:14:31 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 16:14:31 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 16:14:31 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 16:14:33 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:33 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 16:14:33 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 16:14:33 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 16:14:33 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 16:14:33 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 16:14:33 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 16:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:34 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 16:14:34 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 16:14:34 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 16:14:34 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 16:14:34 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 16:14:34 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 16:14:34 INFO - Downloading docopt-0.6.1.tar.gz 16:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:34 INFO - Running setup.py install for blobuploader 16:14:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:34 INFO - Running setup.py install for requests 16:14:35 INFO - Running setup.py install for docopt 16:14:35 INFO - Successfully installed blobuploader requests docopt 16:14:35 INFO - Cleaning up... 16:14:35 INFO - Return code: 0 16:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:35 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')]} 16:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:35 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')]} 16:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:35 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:35 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 16:14:35 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 16:14:35 INFO - Using env: {'DISPLAY': ':0', 16:14:35 INFO - 'HOME': '/home/cltbld', 16:14:35 INFO - 'LANG': 'en_US.UTF-8', 16:14:35 INFO - 'LANGUAGE': 'en_US:en', 16:14:35 INFO - 'LOGNAME': 'cltbld', 16:14:35 INFO - 'MAIL': '/var/mail/cltbld', 16:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:35 INFO - 'MOZ_NO_REMOTE': '1', 16:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:35 INFO - 'NO_EM_RESTART': '1', 16:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:35 INFO - 'PWD': '/builds/slave/test', 16:14:35 INFO - 'SHELL': '/bin/bash', 16:14:35 INFO - 'SHLVL': '1', 16:14:35 INFO - 'TERM': 'linux', 16:14:35 INFO - 'TMOUT': '86400', 16:14:35 INFO - 'USER': 'cltbld', 16:14:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:35 INFO - '_': '/tools/buildbot/bin/python'} 16:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:35 INFO - Running setup.py (path:/tmp/pip-45wR2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:35 INFO - Running setup.py (path:/tmp/pip-IiAYFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:35 INFO - Running setup.py (path:/tmp/pip-wo5i0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:35 INFO - Running setup.py (path:/tmp/pip-cuNsen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:35 INFO - Running setup.py (path:/tmp/pip-taDhAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:35 INFO - Running setup.py (path:/tmp/pip-OMkhQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:35 INFO - Running setup.py (path:/tmp/pip-67hSHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:35 INFO - Running setup.py (path:/tmp/pip-1qx4bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:36 INFO - Running setup.py (path:/tmp/pip-Qw3TDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:36 INFO - Running setup.py (path:/tmp/pip-Lx_IRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:36 INFO - Running setup.py (path:/tmp/pip-UOYo7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:36 INFO - Running setup.py (path:/tmp/pip-EEr3jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:36 INFO - Running setup.py (path:/tmp/pip-07ypQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:36 INFO - Running setup.py (path:/tmp/pip-o6DYIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:36 INFO - Running setup.py (path:/tmp/pip-iMJVOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:36 INFO - Running setup.py (path:/tmp/pip-caMcM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:36 INFO - Running setup.py (path:/tmp/pip-MLzdV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:36 INFO - Running setup.py install for manifestparser 16:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:36 INFO - Running setup.py install for mozcrash 16:14:36 INFO - Running setup.py install for mozdebug 16:14:37 INFO - Running setup.py install for mozdevice 16:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for mozfile 16:14:37 INFO - Running setup.py install for mozhttpd 16:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for mozinfo 16:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for mozInstall 16:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for mozleak 16:14:37 INFO - Running setup.py install for mozlog 16:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for moznetwork 16:14:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:37 INFO - Running setup.py install for mozprocess 16:14:37 INFO - Running setup.py install for mozprofile 16:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:38 INFO - Running setup.py install for mozrunner 16:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:38 INFO - Running setup.py install for mozscreenshot 16:14:38 INFO - Running setup.py install for moztest 16:14:38 INFO - Running setup.py install for mozversion 16:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:38 INFO - Cleaning up... 16:14:38 INFO - Return code: 0 16:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:38 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')]} 16:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:38 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')]} 16:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:38 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:38 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 16:14:38 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 16:14:38 INFO - Using env: {'DISPLAY': ':0', 16:14:38 INFO - 'HOME': '/home/cltbld', 16:14:38 INFO - 'LANG': 'en_US.UTF-8', 16:14:38 INFO - 'LANGUAGE': 'en_US:en', 16:14:38 INFO - 'LOGNAME': 'cltbld', 16:14:38 INFO - 'MAIL': '/var/mail/cltbld', 16:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:38 INFO - 'MOZ_NO_REMOTE': '1', 16:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:38 INFO - 'NO_EM_RESTART': '1', 16:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:38 INFO - 'PWD': '/builds/slave/test', 16:14:38 INFO - 'SHELL': '/bin/bash', 16:14:38 INFO - 'SHLVL': '1', 16:14:38 INFO - 'TERM': 'linux', 16:14:38 INFO - 'TMOUT': '86400', 16:14:38 INFO - 'USER': 'cltbld', 16:14:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:38 INFO - '_': '/tools/buildbot/bin/python'} 16:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:38 INFO - Running setup.py (path:/tmp/pip-oIcaTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:38 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)) 16:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:38 INFO - Running setup.py (path:/tmp/pip-4n3ybU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:38 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)) 16:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:38 INFO - Running setup.py (path:/tmp/pip-TIDMvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:38 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)) 16:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:38 INFO - Running setup.py (path:/tmp/pip-ZaBeT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:39 INFO - Running setup.py (path:/tmp/pip-qnuGGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:39 INFO - Running setup.py (path:/tmp/pip-JGanMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:39 INFO - Running setup.py (path:/tmp/pip-87vane-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:39 INFO - Running setup.py (path:/tmp/pip-_nYx28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:39 INFO - Running setup.py (path:/tmp/pip-ZuWirW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:39 INFO - Running setup.py (path:/tmp/pip-q2nVqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:39 INFO - Running setup.py (path:/tmp/pip-Qg7BZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:39 INFO - Running setup.py (path:/tmp/pip-4IXZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:39 INFO - Running setup.py (path:/tmp/pip-xzzhLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:39 INFO - Running setup.py (path:/tmp/pip-G3KraG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:39 INFO - Running setup.py (path:/tmp/pip-vufIs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:39 INFO - Running setup.py (path:/tmp/pip-sGYRJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:39 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)) 16:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:39 INFO - Running setup.py (path:/tmp/pip-KFqtwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:39 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)) 16:14:39 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)) 16:14:39 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)) 16:14:39 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)) 16:14:39 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)) 16:14:39 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)) 16:14:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:39 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 16:14:39 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 16:14:39 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 16:14:39 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 16:14:39 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 16:14:39 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 16:14:41 INFO - Downloading blessings-1.6.tar.gz 16:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:42 INFO - Installing collected packages: blessings 16:14:42 INFO - Running setup.py install for blessings 16:14:42 INFO - Successfully installed blessings 16:14:42 INFO - Cleaning up... 16:14:42 INFO - Return code: 0 16:14:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:42 INFO - Reading from file tmpfile_stdout 16:14:42 INFO - Current package versions: 16:14:42 INFO - argparse == 1.2.1 16:14:42 INFO - blessings == 1.6 16:14:42 INFO - blobuploader == 1.2.4 16:14:42 INFO - docopt == 0.6.1 16:14:42 INFO - functools32 == 3.2.3-2 16:14:42 INFO - jsonschema == 2.5.1 16:14:42 INFO - manifestparser == 1.1 16:14:42 INFO - mozInstall == 1.12 16:14:42 INFO - mozcrash == 1.0 16:14:42 INFO - mozdebug == 0.1 16:14:42 INFO - mozdevice == 0.49 16:14:42 INFO - mozfile == 1.2 16:14:42 INFO - mozhttpd == 0.7 16:14:42 INFO - mozinfo == 0.9 16:14:42 INFO - mozleak == 0.1 16:14:42 INFO - mozlog == 3.4 16:14:42 INFO - moznetwork == 0.27 16:14:42 INFO - mozprocess == 0.24 16:14:42 INFO - mozprofile == 0.28 16:14:42 INFO - mozrunner == 6.13 16:14:42 INFO - mozscreenshot == 0.1 16:14:42 INFO - mozsystemmonitor == 0.3 16:14:42 INFO - moztest == 0.8 16:14:42 INFO - mozversion == 1.4 16:14:42 INFO - psutil == 3.1.1 16:14:42 INFO - requests == 1.2.3 16:14:42 INFO - wsgiref == 0.1.2 16:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:42 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')]} 16:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:42 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')]} 16:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:42 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:42 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 16:14:42 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 16:14:42 INFO - Using env: {'DISPLAY': ':0', 16:14:42 INFO - 'HOME': '/home/cltbld', 16:14:42 INFO - 'LANG': 'en_US.UTF-8', 16:14:42 INFO - 'LANGUAGE': 'en_US:en', 16:14:42 INFO - 'LOGNAME': 'cltbld', 16:14:42 INFO - 'MAIL': '/var/mail/cltbld', 16:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:42 INFO - 'MOZ_NO_REMOTE': '1', 16:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:42 INFO - 'NO_EM_RESTART': '1', 16:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:42 INFO - 'PWD': '/builds/slave/test', 16:14:42 INFO - 'SHELL': '/bin/bash', 16:14:42 INFO - 'SHLVL': '1', 16:14:42 INFO - 'TERM': 'linux', 16:14:42 INFO - 'TMOUT': '86400', 16:14:42 INFO - 'USER': 'cltbld', 16:14:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:42 INFO - '_': '/tools/buildbot/bin/python'} 16:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 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)) 16:14:42 INFO - Cleaning up... 16:14:42 INFO - Return code: 0 16:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14:42 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')]} 16:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:42 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')]} 16:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:42 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 0x25931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2905630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', '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 16:14:42 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 16:14:42 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 16:14:42 INFO - Using env: {'DISPLAY': ':0', 16:14:42 INFO - 'HOME': '/home/cltbld', 16:14:42 INFO - 'LANG': 'en_US.UTF-8', 16:14:42 INFO - 'LANGUAGE': 'en_US:en', 16:14:42 INFO - 'LOGNAME': 'cltbld', 16:14:42 INFO - 'MAIL': '/var/mail/cltbld', 16:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:42 INFO - 'MOZ_NO_REMOTE': '1', 16:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:42 INFO - 'NO_EM_RESTART': '1', 16:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:42 INFO - 'PWD': '/builds/slave/test', 16:14:42 INFO - 'SHELL': '/bin/bash', 16:14:42 INFO - 'SHLVL': '1', 16:14:42 INFO - 'TERM': 'linux', 16:14:42 INFO - 'TMOUT': '86400', 16:14:42 INFO - 'USER': 'cltbld', 16:14:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:42 INFO - '_': '/tools/buildbot/bin/python'} 16:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:14:42 INFO - Cleaning up... 16:14:42 INFO - Return code: 0 16:14:42 INFO - Running post-action listener: _resource_record_post_action 16:14:42 INFO - Running post-action listener: _start_resource_monitoring 16:14:42 INFO - Starting resource monitoring. 16:14:42 INFO - [mozharness: 2017-03-11 00:14:42.963716Z] Finished create-virtualenv step (success) 16:14:42 INFO - [mozharness: 2017-03-11 00:14:42.964222Z] Running install step. 16:14:42 INFO - Running pre-action listener: _resource_record_pre_action 16:14:42 INFO - Running main action method: install 16:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:43 INFO - Reading from file tmpfile_stdout 16:14:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:43 INFO - Reading from file tmpfile_stdout 16:14:43 INFO - Output received: 16:14:43 INFO - Usage: mozinstall [options] installer 16:14:43 INFO - Options: 16:14:43 INFO - -h, --help show this help message and exit 16:14:43 INFO - -d DEST, --destination=DEST 16:14:43 INFO - Directory to install application into. [default: 16:14:43 INFO - "/builds/slave/test"] 16:14:43 INFO - --app=APP Application being installed. [default: firefox] 16:14:43 INFO - mkdir: /builds/slave/test/build/application 16:14:43 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'] 16:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:14:57 INFO - Reading from file tmpfile_stdout 16:14:57 INFO - Output received: 16:14:57 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:57 INFO - Running post-action listener: _resource_record_post_action 16:14:57 INFO - [mozharness: 2017-03-11 00:14:57.202960Z] Finished install step (success) 16:14:57 INFO - [mozharness: 2017-03-11 00:14:57.203236Z] Running run-tests step. 16:14:57 INFO - Running pre-action listener: _resource_record_pre_action 16:14:57 INFO - Running main action method: run_tests 16:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:57 INFO - Python 2.7.3 16:14:57 INFO - Return code: 0 16:14:57 INFO - grabbing minidump binary from tooltool 16:14:57 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')]} 16:14:57 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 0x298e850>, '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 0x29036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2903b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:57 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 16:14:57 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 16:14:57 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 16:14:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:57 INFO - Return code: 0 16:14:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 16:14:57 INFO - Using env: {'DISPLAY': ':0', 16:14:57 INFO - 'HOME': '/home/cltbld', 16:14:57 INFO - 'LANG': 'en_US.UTF-8', 16:14:57 INFO - 'LANGUAGE': 'en_US:en', 16:14:57 INFO - 'LOGNAME': 'cltbld', 16:14:57 INFO - 'MAIL': '/var/mail/cltbld', 16:14:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:57 INFO - 'MOZ_NO_REMOTE': '1', 16:14:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:57 INFO - 'NO_EM_RESTART': '1', 16:14:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:57 INFO - 'PWD': '/builds/slave/test', 16:14:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:57 INFO - 'SHELL': '/bin/bash', 16:14:57 INFO - 'SHLVL': '1', 16:14:57 INFO - 'TERM': 'linux', 16:14:57 INFO - 'TMOUT': '86400', 16:14:57 INFO - 'USER': 'cltbld', 16:14:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450', 16:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:57 INFO - '_': '/tools/buildbot/bin/python'} 16:14:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:14:57 INFO - mozversion application_buildid: 20170310231934 16:14:57 INFO - mozversion application_changeset: e5eb0121a580e4b8acf53886861363f669a864ad 16:14:57 INFO - mozversion application_display_name: Firefox 16:14:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:57 INFO - mozversion application_name: Firefox 16:14:57 INFO - mozversion application_remotingname: firefox 16:14:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:14:57 INFO - mozversion application_vendor: Mozilla 16:14:57 INFO - mozversion application_version: 53.0 16:14:57 INFO - mozversion platform_buildid: 20170310231934 16:14:57 INFO - mozversion platform_changeset: e5eb0121a580e4b8acf53886861363f669a864ad 16:14:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:14:57 INFO - mozversion platform_version: 53.0 16:14:57 INFO - using testdate: 1489191297 16:14:57 INFO - actual date: 1489191297 16:14:57 INFO - starting webserver on 'localhost:42706' 16:14:57 INFO - SUITE-START | Running 2 tests 16:14:57 INFO - TEST-START | dromaeo_css 16:14:57 INFO - operating with platform_type : linux_ 16:14:57 INFO - Initialising browser for dromaeo_css test... 16:14:57 INFO - TEST-INFO | started process 4567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpph0pWj/profile http://localhost:42706/getInfo.html) 16:15:01 INFO - PROCESS | 4567 | __metrics Screen width/height:1600/1200 16:15:01 INFO - PROCESS | 4567 | colorDepth:24 16:15:01 INFO - PROCESS | 4567 | Browser inner width/height: 1024/697 16:15:01 INFO - PROCESS | 4567 | __metrics 16:15:02 INFO - PROCESS | 4567 | 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" 16:15:02 INFO - PROCESS | 4567 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:02 INFO - PROCESS | 4567 | console.error: PushService: 16:15:02 INFO - PROCESS | 4567 | stateChangeProcessEnqueue: Error transitioning state 16:15:02 INFO - PROCESS | 4567 | UnknownError 16:15:03 INFO - TEST-INFO | 4567: exit 0 16:15:03 INFO - Browser initialized. 16:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:03 INFO - TEST-INFO | started process 4660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpph0pWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:15 INFO - PROCESS | 4660 | RSS: Main: 139771904 16:15:15 INFO - PROCESS | 4660 | 16:18:15 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42706/tests/dromaeo/cssquery-ext.html) 16:18:16 INFO - PROCESS | 4660 | RSS: Main: 235143168 16:18:16 INFO - PROCESS | 4660 | 16:21:19 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-ext.html (next: http://localhost:42706/tests/dromaeo/cssquery-jquery.html) 16:21:19 INFO - PROCESS | 4660 | RSS: Main: 227676160 16:21:19 INFO - PROCESS | 4660 | 16:24:21 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42706/tests/dromaeo/cssquery-mootools.html) 16:24:22 INFO - PROCESS | 4660 | RSS: Main: 202731520 16:24:22 INFO - PROCESS | 4660 | 16:27:23 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42706/tests/dromaeo/cssquery-prototype.html) 16:27:24 INFO - PROCESS | 4660 | RSS: Main: 173084672 16:27:24 INFO - PROCESS | 4660 | 16:30:27 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42706/tests/dromaeo/cssquery-yui.html) 16:30:27 INFO - PROCESS | 4660 | RSS: Main: 173395968 16:30:27 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | Cycle 1(1): loaded http://localhost:42706/tests/dromaeo/cssquery-yui.html (next: http://localhost:42706/tests/dromaeo/cssquery-dojo.html) 16:33:30 INFO - PROCESS | 4660 | RSS: Main: 264634368 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | __start_tp_report 16:33:30 INFO - PROCESS | 4660 | _x_x_mozilla_page_load 16:33:30 INFO - PROCESS | 4660 | _x_x_mozilla_page_load_details 16:33:30 INFO - PROCESS | 4660 | |i|pagename|runs| 16:33:30 INFO - PROCESS | 4660 | |0;dojo.html;3320.5351250824883;3348.045806945021;3357.865685372585;3380.864765409384;3399.864005439781;5501.257330260419;5583.4974852263285;5585.720713964301;5609.270794796671;5617.691026993519;5572.888542229153;5629.7185140743;5631.8592035199035;5645.520130788877;5680.005998950178;4973.8259160929465;5000.274960130779;5022.723750193738;5030.899382012358;5072.315237442954;4840.031993601294;4900;5083.618728595352;5089.414717307502;5094.414142373637;4924.852254432372;4942.382202224722;4974.527419895104;5016.899662006757;5053.014662140884;5067.87330316745;5070.797168113271;5075.898482030376;5077.314562534048;5108.64239503235;4786.976065119687;4822.590079843182;4953.306537084811;4959.760059985004;5033.597312215014;5432.266644003049;5485.259489968843;5492.231087647732;5503.229547863302;5575.553955683536;5991.550633702446;5994.2806863176265;5996.640201587918;5997.5501837361935;5998.670073146019;5911.054231322968;6028.939710602882;6035.3059398169335;6046.244219472566;6046.727897244635;5515.283013208257;5529.419410961871;5549.306336707911;5582.804601838916;5643.971780141073;6076.726547305382;6077.513798896078;6078;6079.75680972765;6084.4828189603495;5814.098814683731;5819.912701309484;5870.618409803435;5872.765089396462;5889.587728858939;5858.238429004202;5888.705564721747;5920.378360272195;5942.6731529766275;5958.851028724316;5960.940390596125;5961.463468287875;5969.611975221684;5974.551908606872;5997.730102145414;5974.940250597525;5975.4024597540765;5978.701064946736;5982.970085149546;6014.879702405928;4528.818847246073;4547.977260113678;4557.772111394417;4570.908581828345;4626.074785043005;4105.096878686684;4108.897277568025;4114.033202197481;4134.710570260053;4148.979255103705;5577.832665020056;5611.382747897728;5622.690752008679;5625.774969001194;5654.15187721845;5875.50058245054;5919.496842768327;5988.9101663475085;5990.880182396415;5998;5600.52395546375;5624.29696287964;5656.349519805192;5723.055695810228;5735.627184233012;5127.897442051138;5137.563307118937;5137.717425541631;5138.820141295037;5139.07496650599;6254.593451425642;6256.374362563798;6263.655498947602;6265.091561723524;6268.373162683786;5827.096799996008;5879.617824841372;5903.852403689943;5933.199018132497;5946.286445626552;6164.568480206342;6208.81373558794;6210.968945155245;6222.439980401786;6227;5874.794382196603;5905;5909.261342332208;5914;5916.615419997686;5852.297724273115;5893.499052580579;5896.616719913192;5912.970435147797;6017.488513476228;5852.882942341044;5854.092615644582;5872.706364681834;5881.117832325014;5894.938910996062;5856;5860.38465961085;5864.9413505866105;5869.148973398918;5880.441358070976;5726.398728133486;5749.8275051748515;5796.188533605383;5856.736446859816;5862.091375836752;5866.560007999503;5903.498202652822;5960.403959604005;5972.58191926561;5974.492168165581;5820.417958204146;5820.476157145878;5824.039033559585;5829.125631155361;5830.125481177857 16:33:30 INFO - PROCESS | 4660 | |1;ext.html;564.7769131193179;601.1793901324692;632.4687262699332;636.5067073018411;659.2155335151167;37158.442623360635;50236.24645630318;51033.74483127579;51092.74453627726;51221.743891280494;51698;52058.73970630151;52364.214536781976;52402;52461;8902.910970890272;9118.908810911906;9409.952950235256;9598.376105553152;9599.568019439108;11217.383043932581;11496.712582185428;11509.251898626604;11827;11844.822327665092;11382.772344553105;11469.827952580717;11472.426378681033;11474.942625286862;11475.368854712988;11453.37006464644;11468.655940321803;11522.308661480338;11522.76954460906;11524.481398337053;11286.887131128666;11361.37512436824;11367.4884630191;11369.31784092957;11369.715757106056;48360.27459588109;48381;48498.272525912136;48636.51363486355;48681.75659121717;4361.9127617447475;4432.246518091933;4443.955560444387;4493.595576398107;4637.258038713823;32982.6701732982;33288.16779580506;33299;34267.143321416916;34388;4585.220512512881;4641.814327426899;4715.95284047162;4767.804332187688;4816;388285.99999999715;390502;390951;391598;391867;63611;63921.68039159774;64022;64029;64031.6798416005;66011.33988660148;66198;66284.33715662782;66374.66812665906;66382.33617663762;18936.242550297833;19787.40637780869;19814.108365123317;19815.10832012563;19817.405477835688;13923;14220.85779142216;14960.551183464513;15187.164705941279;15454.536363909101;20012.499687507636;20162.495937601678;20241.291554795513;20281;20293.49266268355;7336.926630733731;7441.776746697499;7595.164531901486;7672.616369181518;7688.269614386624;960.9711708648751;969.7672558585889;972.1979367022235;984.9704508864745;1013.934094283884;32982.5052624206;34636.055935245284;34697.653023469444;35512;35600.10999725028;1129.13056946151;1170.6780635325354;1176.623480486236;1207.849018872641;1225.7486817232223;18438.26246950107;18645.533861653566;18672.81327186738;18712.625747484974;18791.24835006612;546870;552618;553066;555333;556485;71581.64209178921;71970;72191.27808721845;72365;72614.63692681608;1446.7106578684304;1468.5520916120686;1532.4253404973358;1551.8991265567702;1583.1609247099057;31833.36333273275;35447.82276088603;35530.467042993856;35551.64448355483;36743.63256367402;59297.40702592919;60275.39724602698;60498;60510;60556.69721651363;320436;320809;321266;321496;321954;28966.565501517074;29592.556111658774;31084.68915310818;31830.522542161423;31979.520307194944;52966.20550691666;52966.47033529615;53378.4662153389;53703.46296536984;54686.72656636692;44014.339784903896;45219;45354.77322613498;46024.539754603364;47283.29075063808;41234.79382603188;46232.53767462417;46572.06855862796;47486.28770568375;47583.286250705576;40549.1890162201;42757.57242427536;49266;49618.52670313043;50179.49820501748;43845.561544384145;47941.28088078612;48511.27233091436;48756;50029.49970500394;37136.809889104734;37372.439413408276;37696.43455348117;38059.2388152241;38107 16:33:30 INFO - PROCESS | 4660 | |2;jquery.html;442.82951063840414;444.09183220314463;447.1727304486702;448.71506593313234;462.24884562585777;20879.37361879144;22013;22587;22829.97265123069;22941.19705810297;21345.466363340925;21710;21726.565468690616;21858.453538661543;22022.88988555059;5447.891042179164;5468.781248750045;5632;5635.3801081881165;5663.631863928831;4259.10558782656;5552.77788888444;5621.156826476021;5622.465865742748;5628;4444.2222611042935;6013;6254.718537665816;6261.718222679968;6386.968065159691;6165.660888651122;6212.844678883019;6269.122322874801;6361.968190159043;6371.681415929208;6141.631502109888;6145.231846019247;6149.354317796657;6149.877002459926;6152.046432802923;15782.131982740944;19178.712319315222;19461.02694865251;26789.732102678918;26954.460910781872;2846.6157068795656;2882.76937844974;2900.3474218300926;2901.2021694034097;2902.129361191634;11124.721881952935;11139.33164010162;11155.832662509987;11514.76970460586;11538.76922461546;2075.055849588434;2120.5546835164632;2225.6216443204694;2240.0591751464426;2258.198339589455;95551.52224238904;95929.5203523985;97215;98849;99375;12323;12657;12757.489700412065;12810.615681529569;12891.162074465317;18442.723359149622;18450.26198952027;18479.907600461913;18493.075346232636;18520.259189632532;9536.52317384128;9625.71122866315;9695.70912872615;9846.803063938682;9858.605655773832;9318.90681093194;9385.5307234638;9413.952930235442;9440.29197810167;9630.45912653972;5000.424951130593;5440.265564148789;5499.1476321170285;5527.143292789624;5563.471470210324;2003.1186278037908;2040.7246817916737;2252.68462415262;2267.761885002084;2286.9542609148057;456.7624835085803;471.90561887622613;1119.238917536067;1138.743782648914;1197.2577002258656;12649.683757905941;12654.114212005072;13035.15271507349;13239.404226809816;13319.334033298297;483.5140683612946;489.8114226023007;493.948135445773;499.05180157699937;506.8276785892814;6811.693473793691;6956.8956465653055;7075.115610548682;7116;7229.132504099542;697969.7861095937;699703;709397;737410;738594;108410;109504;112070.43964780123;116833;117092;511.9283300337956;518.2097301614992;520.1391696741898;520.4925197932062;520.9010288045259;11596.188266821242;11683.591074312359;11963.581274655346;12163.087768417226;12203.20679155852;43830;44563.77718111389;45422.545774543156;45795.54204458046;46545.76727116343;60713.69643151756;61209.69395152996;61838.38161618506;70331.29668703453;70927.29072709414;9121.817563648558;9186.265098791948;9228.261739060994;9313.068693130634;9454.763630909283;9895.703128905856;13871.79192312096;14115.929420353243;14497.565073047825;14544.781828272797;12117.939410302892;12143.08926830509;12187.207831490925;12419.19275247106;12613.117081804186;12336.198147120409;12363.814542781685;12381.442835072263;12415;12501.24992500453;12135.878641213829;12501.624951251477;12522.436490358137;12590.055745818918;12771.872281277068;9350.579223935076;9450.43297402158;9476.763080923032;9582.712518624452;9655.055208161579;12187.57343493009;12192.329421881881;12338.321392323509;12397.938010310252;12435.75128497443 16:33:30 INFO - PROCESS | 4660 | |3;mootools.html;1472.9189894555795;1532.6934613077387;1540.0374765771394;1545.8531439513247;1549.5583758628793;7783.377329813616;8034.678612855493;8688.739337819869;9208.03315651856;9208.861867071999;8627.309815214783;8898.021217666052;8902.821943561124;9118.042605526407;9125.315601329894;2384.2966324934187;2417.492326611414;2420.3465064432594;2422.6002709552904;2426.7815896569305;2385.7494963028894;2432.428379330856;2442.780149786519;2447.021191523396;2447.559439300925;2396.1254142238045;2418.5767490689145;2439;2460.815438842085;2468.3212116667883;2338.4504641409253;2367.7868991790733;2371.454565449956;2380.571497130516;2399.5560821248037;2304.3778179891337;2342.5666251743482;2380.488195038075;2401.135591187171;2402.783749462539;9030.774230644221;9108.8633670495;9118.179363857285;9122.908770912338;9124.81750364989;5302.655327403745;5436.075867102602;5439.809606663787;5439.864003399907;5442.346918369782;3439.724822014258;3492.5285086513504;3543.94684079739;3560.6973407260416;3590.838412271454;1502.068717395222;1544.536639008293;1546.2887071946918;2204.239537359608;2226.198568515333;12624.305663188521;12664.366781660972;12674.239545627292;12702.999999999907;12718.745625087538;4402.911941761211;4674.205385084544;4751.026039661861;4756.524347565216;4759.547842954914;10086.142677872316;10097.747556311004;10102.09081182697;10105.191584673208;10105.696829095139;5554.444555544414;5555.861103472445;5560.860978475571;5562;5564.33228012641;4543.159515489645;4608.308753686907;4980.178270585386;5058.1654027085115;5187.948120518747;3875.302445559826;3966.484357033567;3990.082281075369;3994.6205110514456;4043.5754245804355;1235.184778046485;1239.863615002349;1241.2490443281865;1249.731307768834;1253.3921048291572;843.9493630382074;855.4054931822324;857.8155696525278;879.5162660536807;883.6862913665685;5948.672822994777;6063.514918806573;6140.508759299335;6251.843703907439;6384.361563843579;1060.7305594980267;1062.5696592879897;1063.6862125672944;1077.3266708307308;1095.5727266366123;4090.427340172378;4143.316352801754;4173.916521669549;4203.642690371292;4244.3209086546;10904.727381815517;11204.607838725606;11224.551017959353;11257.099432045581;11273.661790146309;11012.229143960007;11085.778284434266;11128.777424451466;11129.499172537255;11174.161937854693;8043.276105150565;8363.540005299767;8365.832683346422;8530.573471326408;8592.999999999874;5802.274715660543;5899.292084949833;5920.674362910081;6030.7889223876955;6066.484348830399;9503.239740820856;9584.66453674118;9593.472359020041;9606.471644059644;9656.32405731592;9566.330356874952;9933.205343572641;10083.848742269018;10106.848397274194;10106.898931010595;7323.304286092813;7531.435142364235;7583.848323033619;8053.637586308748;8232.588370581567;8625.69810056645;8809.207171354608;8812.20690137865;8812.735617931472;8816.559172041243;7704.576248306397;7871.212878712083;7876.606169691607;7895.171007044178;7909.446338756232;7760.805979850549;7806.41451891099;7835.255650713173;7851.371890248881;7910.881336780068;7001.859962800817;7009;7082.681279342339;7116.715331386687;7119.466040046914;5479.561635069264;5497.780088796403;5592.217089607377;5610.803621873215;5641.294838145232;5424.83725488236;5425.104857698436;5481.835544933659;5511.090670039559;5562.2490963721 16:33:30 INFO - PROCESS | 4660 | |4;prototype.html;416.5875782974855;420.7013020755265;435.0016711646774;439.33879511335437;439.5560483911249;5234.50272224139;5420.241166236725;5420.292607828531;5426.9185962210595;5463.289772329596;5239.476052394759;5336.199570064492;5340.62615616907;5357.7589008494615;5363.4904684055045;4090.161516889038;4136.172765446922;4147.8963025924295;4200.579942005806;4248.575142485757;4254.680898932593;4255.3829694694405;4270.829166833323;4296.5059018213;4296.892577685568;4260.744355338674;4270.12462445198;4282.721623094489;4294.26997410441;4295.119500502389;4202.348635961431;4231.8518851840345;4256.318988961782;4270.722403043792;4302.655787537005;3823.527941742449;3833.9808300958316;3843.6540711336115;3858.8004837242784;3859.807009649506;5251.317328747238;5264.078786212397;5265.210218467222;5303.628745987782;5306.257124002643;4842.41890973082;4936.5063493650705;4986.850394488171;4988;5020.673656212334;5659.6321239119325;5664.130836823838;5668.858278543028;5671.9716401418145;5677.176809362661;4360.558087471027;4360.716553424049;4389.582989616013;4399.472063352418;4406.383106365111;5506.449355064502;5784.855378615526;5828.766849326022;5851.4441128093185;5894.705264736746;4309.116631090619;4317.805698743564;4335.739855608674;4335.745412385542;4346.739195648272;4358.237308471005;4381.890452738707;4384.693071484965;4386.429764130707;4391.494978077498;4757.762111894392;4821.373221481185;4893.681910675795;4902.828401005948;4929.482404347564;5633.971830140905;5646.971765141148;5648.6893220872425;5649.6327738696855;5674.744636491368;1500.6848561802144;1506.374854435397;1506.8568485993812;1512.2665507228985;1515.8631026729952;992.5533509920565;1048.444324508012;1095.9945200274108;1121.6578943422335;1138.4478527913955;5091.541761241506;5331.360236771535;5446.700431476228;5457.863553411117;5473.233747275384;5677.9211949729415;5712.457316555004;5722.77108915647;5758.667739565482;5763.9135412968835;5250.582491132803;5378.865528361822;5425.050616142159;5484.177373394023;5487.024671118474;2918.591397204393;2924.97075029247;2925.9905332660196;2926.5610158476397;2946.8231906085703;5720.914186287209;5784.21913041734;5791.594588378773;5809.24479817621;5812.505936995402;5429.945700542944;5694.402087780806;5705.429457054344;5716.228309178291;5738.741756620962;5658.886822263532;5672.205891175238;5728.396049106173;5737.483626473638;5743.587693168795;5236.345456817898;5510.3938566758425;5551.9722401387735;5561.610687251854;5604.663720176803;5438.646487978269;5499.560035197094;5508.834734957958;5526.696031718294;5547.2511210986;5730.856728581819;5743.798967036134;5764.913526297193;5775.624584402;5782.5373970081455;4185;4288.078063216423;4306.763128027988;4322.5677432256525;4363.956360436355;5614;5614.466625670555;5615.971920140373;5619.7636519965545;5642.645765016285;5496.258005169251;5496.642718223463;5526.751296191601;5529.22590837275;5532.2254884315425;5052.242163675331;5349.43227250914;5371.952469268612;5401.513863752281;5430.972845135749;5391.75737091824;5398.676079435247;5419.512243898068;5429.344050064768;5437.227014222696;5338.839834804962;5455.645383050089;5482.725863706719;5588.161775733673;5595.104783234663;5456.863578410572;5476.67139971603;5479.424660410599;5484.451554844643;5498.835034948958 16:33:30 INFO - PROCESS | 4660 | |5;yui.html;840.9621567029483;864.6066039951822;866.0213958227203;932.9626814927403;934.1182452135163;16302.592435189126;17180.14099295035;17387.13064346784;17429;17660.47018589441;15908.443204487845;15969.121698306588;16040.278187481563;16078.437254696088;16090.436834710787;696.2619623199399;714.1501613080444;827.7889138269747;839.3495041342977;839.3788596438652;805.8066064144592;823.3331001888489;824.9670013199465;825.8059356051323;829.1335554345693;873.6243415331405;874.5889431966965;875.3522393428849;877.7015814623027;878.44218920985;860.5611138319503;860.5998210831962;860.9483430994161;863.1109956744532;863.1411745313391;633.7750098714982;635.8124353315783;636.0681601453892;636.4399328590856;641.5637366590717;17620.559486012826;17809.19858606366;17883.1952562135;18037.458876233733;18347.633047339114;15064;16876.662466750597;16966.575835604086;16966.57583560421;17011.234494447657;14040.297985100704;14337.42650293987;14350.856491435057;14533.563993080224;14566.635834104127;4824.421069471651;4853.296272040569;4861.513848615145;4911.214205727067;4983.127952608315;79959.6002019992;81588.59205703993;82095.589522052;83463.58268208681;83791;12698;12794.936025319814;12827.358632068359;12870.099093063396;12922.612321630366;23801.523969520513;23949;24052.15817446416;24340.148094816952;24483.265502034967;8748.34387420946;8825.735227943173;8853.867191992125;8872.378933474723;8979.865302020475;4741.838249628863;4771.475137734847;4831.202851529529;4841.806327746921;4865.343178670834;3956.228535435562;4061.756294622332;4063.7968101595393;4064.552899181088;4068.16602596467;685.3009929871503;688.3770187979886;690.3648643248123;702.5538782872912;713.7501874344042;845.6744153500823;852.7166614245521;873.1443185677944;878.2929741558107;884.0805562215224;11071.391073491035;11190.496427660612;11321.773564528663;11410.429478526206;11545.769084618429;835.0897521701374;848.4697064334791;854.5300084953251;863.7495126413395;875.6147295190224;5239.292695486137;5250.894982100413;5296.152615581565;5353.705546194997;5357.571394288448;81755.18244817594;82631.5868420654;82893.58553207196;84103;85556.14443855482;59370.10944835831;59511;60937.39062609317;69626;71882.2811771886;51232;51275;53798.7310063455;59215.70392148098;64048.67975660092;10981.17641176931;11225.66323010311;11338.829917551078;11354.318740875575;11361.43192840338;39089.80455097706;41649.58350416457;42818.78590607027;43417.3487397683;43606.78196608997;51978.74010629923;52858.47141528689;54886.72556637191;55048.72475637596;55476.72261638666;14030;14144.43422263098;14170.433182672577;14232.217228052557;14305.213213272953;14352.210628415538;14577.635559111108;14626.488072917396;14692.632684182981;15546.533603991898;14643.85356146425;14976.251187440803;15017.6996460068;15083.170425626697;15253.08481491114;14858.9003614865;14895.553133406016;15005.624859378166;15159.317830697866;15423.61440963985;14312.642183945485;14479.638009049859;14649.92675036618;14728.189949552449;14774.852251477347;11146.609868654883;11274.661760147208;11327.376994265065;11525.423728813694;11818.40907954616;10977.780444391226;11104.500297486795;11177.608783692533;11199.21605487608;11242.66272011841 16:33:30 INFO - PROCESS | 4660 | __end_tp_report 16:33:30 INFO - PROCESS | 4660 | __start_cc_report 16:33:30 INFO - PROCESS | 4660 | _x_x_mozilla_cycle_collect,897 16:33:30 INFO - PROCESS | 4660 | __end_cc_report 16:33:30 INFO - PROCESS | 4660 | __startTimestamp1489192410342__endTimestamp 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | ------- Summary: start ------- 16:33:30 INFO - PROCESS | 4660 | Number of tests: 6 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#0] dojo.html Cycles:165 Average:5545.17 Median:5824.04 stddev:625.65 (10.7%) stddev-sans-first:602.74 16:33:30 INFO - PROCESS | 4660 | Values: 3320.5 3348.0 3357.9 3380.9 3399.9 5501.3 5583.5 5585.7 5609.3 5617.7 5572.9 5629.7 5631.9 5645.5 5680.0 4973.8 5000.3 5022.7 5030.9 5072.3 4840.0 4900.0 5083.6 5089.4 5094.4 4924.9 4942.4 4974.5 5016.9 5053.0 5067.9 5070.8 5075.9 5077.3 5108.6 4787.0 4822.6 4953.3 4959.8 5033.6 5432.3 5485.3 5492.2 5503.2 5575.6 5991.6 5994.3 5996.6 5997.6 5998.7 5911.1 6028.9 6035.3 6046.2 6046.7 5515.3 5529.4 5549.3 5582.8 5644.0 6076.7 6077.5 6078.0 6079.8 6084.5 5814.1 5819.9 5870.6 5872.8 5889.6 5858.2 5888.7 5920.4 5942.7 5958.9 5960.9 5961.5 5969.6 5974.6 5997.7 5974.9 5975.4 5978.7 5983.0 6014.9 4528.8 4548.0 4557.8 4570.9 4626.1 4105.1 4108.9 4114.0 4134.7 4149.0 5577.8 5611.4 5622.7 5625.8 5654.2 5875.5 5919.5 5988.9 5990.9 5998.0 5600.5 5624.3 5656.3 5723.1 5735.6 5127.9 5137.6 5137.7 5138.8 5139.1 6254.6 6256.4 6263.7 6265.1 6268.4 5827.1 5879.6 5903.9 5933.2 5946.3 6164.6 6208.8 6211.0 6222.4 6227.0 5874.8 5905.0 5909.3 5914.0 5916.6 5852.3 5893.5 5896.6 5913.0 6017.5 5852.9 5854.1 5872.7 5881.1 5894.9 5856.0 5860.4 5864.9 5869.1 5880.4 5726.4 5749.8 5796.2 5856.7 5862.1 5866.6 5903.5 5960.4 5972.6 5974.5 5820.4 5820.5 5824.0 5829.1 5830.1 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#1] ext.html Cycles:180 Average:62125.71 Median:24103.74 stddev:114183.93 (473.7%) stddev-sans-first:114410.70 16:33:30 INFO - PROCESS | 4660 | Values: 564.8 601.2 632.5 636.5 659.2 37158.4 50236.2 51033.7 51092.7 51221.7 51698.0 52058.7 52364.2 52402.0 52461.0 8902.9 9118.9 9410.0 9598.4 9599.6 11217.4 11496.7 11509.3 11827.0 11844.8 11382.8 11469.8 11472.4 11474.9 11475.4 11453.4 11468.7 11522.3 11522.8 11524.5 11286.9 11361.4 11367.5 11369.3 11369.7 48360.3 48381.0 48498.3 48636.5 48681.8 4361.9 4432.2 4444.0 4493.6 4637.3 32982.7 33288.2 33299.0 34267.1 34388.0 4585.2 4641.8 4716.0 4767.8 4816.0 388286.0 390502.0 390951.0 391598.0 391867.0 63611.0 63921.7 64022.0 64029.0 64031.7 66011.3 66198.0 66284.3 66374.7 66382.3 18936.2 19787.4 19814.1 19815.1 19817.4 13923.0 14220.9 14960.6 15187.2 15454.5 20012.5 20162.5 20241.3 20281.0 20293.5 7336.9 7441.8 7595.2 7672.6 7688.3 961.0 969.8 972.2 985.0 1013.9 32982.5 34636.1 34697.7 35512.0 35600.1 1129.1 1170.7 1176.6 1207.8 1225.7 18438.3 18645.5 18672.8 18712.6 18791.2 546870.0 552618.0 553066.0 555333.0 556485.0 71581.6 71970.0 72191.3 72365.0 72614.6 1446.7 1468.6 1532.4 1551.9 1583.2 31833.4 35447.8 35530.5 35551.6 36743.6 59297.4 60275.4 60498.0 60510.0 60556.7 320436.0 320809.0 321266.0 321496.0 321954.0 28966.6 29592.6 31084.7 31830.5 31979.5 52966.2 52966.5 53378.5 53703.5 54686.7 44014.3 45219.0 45354.8 46024.5 47283.3 41234.8 46232.5 46572.1 47486.3 47583.3 40549.2 42757.6 49266.0 49618.5 50179.5 43845.6 47941.3 48511.3 48756.0 50029.5 37136.8 37372.4 37696.4 38059.2 38107.0 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#2] jquery.html Cycles:180 Average:36723.03 Median:2444.16 stddev:117900.89 (4823.8%) stddev-sans-first:118200.15 16:33:30 INFO - PROCESS | 4660 | Values: 442.8 444.1 447.2 448.7 462.2 20879.4 22013.0 22587.0 22830.0 22941.2 21345.5 21710.0 21726.6 21858.5 22022.9 5447.9 5468.8 5632.0 5635.4 5663.6 4259.1 5552.8 5621.2 5622.5 5628.0 4444.2 6013.0 6254.7 6261.7 6387.0 6165.7 6212.8 6269.1 6362.0 6371.7 6141.6 6145.2 6149.4 6149.9 6152.0 15782.1 19178.7 19461.0 26789.7 26954.5 2846.6 2882.8 2900.3 2901.2 2902.1 11124.7 11139.3 11155.8 11514.8 11538.8 2075.1 2120.6 2225.6 2240.1 2258.2 95551.5 95929.5 97215.0 98849.0 99375.0 12323.0 12657.0 12757.5 12810.6 12891.2 18442.7 18450.3 18479.9 18493.1 18520.3 9536.5 9625.7 9695.7 9846.8 9858.6 9318.9 9385.5 9414.0 9440.3 9630.5 5000.4 5440.3 5499.1 5527.1 5563.5 2003.1 2040.7 2252.7 2267.8 2287.0 456.8 471.9 1119.2 1138.7 1197.3 12649.7 12654.1 13035.2 13239.4 13319.3 483.5 489.8 493.9 499.1 506.8 6811.7 6956.9 7075.1 7116.0 7229.1 697969.8 699703.0 709397.0 737410.0 738594.0 108410.0 109504.0 112070.4 116833.0 117092.0 511.9 518.2 520.1 520.5 520.9 11596.2 11683.6 11963.6 12163.1 12203.2 43830.0 44563.8 45422.5 45795.5 46545.8 60713.7 61209.7 61838.4 70331.3 70927.3 9121.8 9186.3 9228.3 9313.1 9454.8 9895.7 13871.8 14115.9 14497.6 14544.8 12117.9 12143.1 12187.2 12419.2 12613.1 12336.2 12363.8 12381.4 12415.0 12501.2 12135.9 12501.6 12522.4 12590.1 12771.9 9350.6 9450.4 9476.8 9582.7 9655.1 12187.6 12192.3 12338.3 12397.9 12435.8 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#3] mootools.html Cycles:180 Average:5909.44 Median:5019.17 stddev:3282.62 (65.4%) stddev-sans-first:3274.90 16:33:30 INFO - PROCESS | 4660 | Values: 1472.9 1532.7 1540.0 1545.9 1549.6 7783.4 8034.7 8688.7 9208.0 9208.9 8627.3 8898.0 8902.8 9118.0 9125.3 2384.3 2417.5 2420.3 2422.6 2426.8 2385.7 2432.4 2442.8 2447.0 2447.6 2396.1 2418.6 2439.0 2460.8 2468.3 2338.5 2367.8 2371.5 2380.6 2399.6 2304.4 2342.6 2380.5 2401.1 2402.8 9030.8 9108.9 9118.2 9122.9 9124.8 5302.7 5436.1 5439.8 5439.9 5442.3 3439.7 3492.5 3543.9 3560.7 3590.8 1502.1 1544.5 1546.3 2204.2 2226.2 12624.3 12664.4 12674.2 12703.0 12718.7 4402.9 4674.2 4751.0 4756.5 4759.5 10086.1 10097.7 10102.1 10105.2 10105.7 5554.4 5555.9 5560.9 5562.0 5564.3 4543.2 4608.3 4980.2 5058.2 5187.9 3875.3 3966.5 3990.1 3994.6 4043.6 1235.2 1239.9 1241.2 1249.7 1253.4 843.9 855.4 857.8 879.5 883.7 5948.7 6063.5 6140.5 6251.8 6384.4 1060.7 1062.6 1063.7 1077.3 1095.6 4090.4 4143.3 4173.9 4203.6 4244.3 10904.7 11204.6 11224.6 11257.1 11273.7 11012.2 11085.8 11128.8 11129.5 11174.2 8043.3 8363.5 8365.8 8530.6 8593.0 5802.3 5899.3 5920.7 6030.8 6066.5 9503.2 9584.7 9593.5 9606.5 9656.3 9566.3 9933.2 10083.8 10106.8 10106.9 7323.3 7531.4 7583.8 8053.6 8232.6 8625.7 8809.2 8812.2 8812.7 8816.6 7704.6 7871.2 7876.6 7895.2 7909.4 7760.8 7806.4 7835.3 7851.4 7910.9 7001.9 7009.0 7082.7 7116.7 7119.5 5479.6 5497.8 5592.2 5610.8 5641.3 5424.8 5425.1 5481.8 5511.1 5562.2 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#4] prototype.html Cycles:180 Average:4730.56 Median:5360.62 stddev:1319.02 (24.6%) stddev-sans-first:1282.36 16:33:30 INFO - PROCESS | 4660 | Values: 416.6 420.7 435.0 439.3 439.6 5234.5 5420.2 5420.3 5426.9 5463.3 5239.5 5336.2 5340.6 5357.8 5363.5 4090.2 4136.2 4147.9 4200.6 4248.6 4254.7 4255.4 4270.8 4296.5 4296.9 4260.7 4270.1 4282.7 4294.3 4295.1 4202.3 4231.9 4256.3 4270.7 4302.7 3823.5 3834.0 3843.7 3858.8 3859.8 5251.3 5264.1 5265.2 5303.6 5306.3 4842.4 4936.5 4986.9 4988.0 5020.7 5659.6 5664.1 5668.9 5672.0 5677.2 4360.6 4360.7 4389.6 4399.5 4406.4 5506.4 5784.9 5828.8 5851.4 5894.7 4309.1 4317.8 4335.7 4335.7 4346.7 4358.2 4381.9 4384.7 4386.4 4391.5 4757.8 4821.4 4893.7 4902.8 4929.5 5634.0 5647.0 5648.7 5649.6 5674.7 1500.7 1506.4 1506.9 1512.3 1515.9 992.6 1048.4 1096.0 1121.7 1138.4 5091.5 5331.4 5446.7 5457.9 5473.2 5677.9 5712.5 5722.8 5758.7 5763.9 5250.6 5378.9 5425.1 5484.2 5487.0 2918.6 2925.0 2926.0 2926.6 2946.8 5720.9 5784.2 5791.6 5809.2 5812.5 5429.9 5694.4 5705.4 5716.2 5738.7 5658.9 5672.2 5728.4 5737.5 5743.6 5236.3 5510.4 5552.0 5561.6 5604.7 5438.6 5499.6 5508.8 5526.7 5547.3 5730.9 5743.8 5764.9 5775.6 5782.5 4185.0 4288.1 4306.8 4322.6 4364.0 5614.0 5614.5 5616.0 5619.8 5642.6 5496.3 5496.6 5526.8 5529.2 5532.2 5052.2 5349.4 5372.0 5401.5 5431.0 5391.8 5398.7 5419.5 5429.3 5437.2 5338.8 5455.6 5482.7 5588.2 5595.1 5456.9 5476.7 5479.4 5484.5 5498.8 16:33:30 INFO - PROCESS | 4660 | 16:33:30 INFO - PROCESS | 4660 | [#5] yui.html Cycles:180 Average:18190.03 Median:4756.66 stddev:22223.18 (467.2%) stddev-sans-first:22247.34 16:33:30 INFO - PROCESS | 4660 | Values: 841.0 864.6 866.0 933.0 934.1 16302.6 17180.1 17387.1 17429.0 17660.5 15908.4 15969.1 16040.3 16078.4 16090.4 696.3 714.2 827.8 839.3 839.4 805.8 823.3 825.0 825.8 829.1 873.6 874.6 875.4 877.7 878.4 860.6 860.6 860.9 863.1 863.1 633.8 635.8 636.1 636.4 641.6 17620.6 17809.2 17883.2 18037.5 18347.6 15064.0 16876.7 16966.6 16966.6 17011.2 14040.3 14337.4 14350.9 14533.6 14566.6 4824.4 4853.3 4861.5 4911.2 4983.1 79959.6 81588.6 82095.6 83463.6 83791.0 12698.0 12794.9 12827.4 12870.1 12922.6 23801.5 23949.0 24052.2 24340.1 24483.3 8748.3 8825.7 8853.9 8872.4 8979.9 4741.8 4771.5 4831.2 4841.8 4865.3 3956.2 4061.8 4063.8 4064.6 4068.2 685.3 688.4 690.4 702.6 713.8 845.7 852.7 873.1 878.3 884.1 11071.4 11190.5 11321.8 11410.4 11545.8 835.1 848.5 854.5 863.7 875.6 5239.3 5250.9 5296.2 5353.7 5357.6 81755.2 82631.6 82893.6 84103.0 85556.1 59370.1 59511.0 60937.4 69626.0 71882.3 51232.0 51275.0 53798.7 59215.7 64048.7 10981.2 11225.7 11338.8 11354.3 11361.4 39089.8 41649.6 42818.8 43417.3 43606.8 51978.7 52858.5 54886.7 55048.7 55476.7 14030.0 14144.4 14170.4 14232.2 14305.2 14352.2 14577.6 14626.5 14692.6 15546.5 14643.9 14976.3 15017.7 15083.2 15253.1 14858.9 14895.6 15005.6 15159.3 15423.6 14312.6 14479.6 14649.9 14728.2 14774.9 11146.6 11274.7 11327.4 11525.4 11818.4 10977.8 11104.5 11177.6 11199.2 11242.7 16:33:30 INFO - PROCESS | 4660 | -------- Summary: end -------- 16:33:30 INFO - PROCESS | 4660 | 16:33:31 INFO - TEST-INFO | 4660: exit 0 16:33:31 INFO - TEST-OK | dromaeo_css | took 1113654ms 16:33:31 INFO - TEST-START | kraken 16:33:31 INFO - operating with platform_type : linux_ 16:33:31 INFO - Initialising browser for kraken test... 16:33:31 INFO - TEST-INFO | started process 4965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeEssX/profile http://localhost:42706/getInfo.html) 16:33:34 INFO - PROCESS | 4965 | __metrics Screen width/height:1600/1200 16:33:35 INFO - PROCESS | 4965 | colorDepth:24 16:33:35 INFO - PROCESS | 4965 | Browser inner width/height: 1024/697 16:33:35 INFO - PROCESS | 4965 | __metrics 16:33:35 INFO - PROCESS | 4965 | 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" 16:33:35 INFO - PROCESS | 4965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:36 INFO - PROCESS | 4965 | console.error: PushService: 16:33:36 INFO - PROCESS | 4965 | stateChangeProcessEnqueue: Error transitioning state 16:33:36 INFO - PROCESS | 4965 | UnknownError 16:33:36 INFO - TEST-INFO | 4965: exit 0 16:33:36 INFO - Browser initialized. 16:33:36 INFO - Running cycle 1/1 for kraken test... 16:33:36 INFO - TEST-INFO | started process 5060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVeEssX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:48 INFO - PROCESS | 5060 | RSS: Main: 139673600 16:33:48 INFO - PROCESS | 5060 | 16:33:51 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42706/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:51 INFO - PROCESS | 5060 | RSS: Main: 181805056 16:33:51 INFO - PROCESS | 5060 | 16:33:54 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42706/tests/kraken/driver.html?testName=audio-dft) 16:33:55 INFO - PROCESS | 5060 | RSS: Main: 172376064 16:33:55 INFO - PROCESS | 5060 | 16:33:57 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42706/tests/kraken/driver.html?testName=audio-fft) 16:33:58 INFO - PROCESS | 5060 | RSS: Main: 263340032 16:33:58 INFO - PROCESS | 5060 | 16:34:00 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42706/tests/kraken/driver.html?testName=audio-oscillator) 16:34:01 INFO - PROCESS | 5060 | RSS: Main: 169340928 16:34:01 INFO - PROCESS | 5060 | 16:34:03 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:03 INFO - PROCESS | 5060 | RSS: Main: 172027904 16:34:03 INFO - PROCESS | 5060 | 16:34:06 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42706/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:07 INFO - PROCESS | 5060 | RSS: Main: 207134720 16:34:07 INFO - PROCESS | 5060 | 16:34:10 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42706/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:11 INFO - PROCESS | 5060 | RSS: Main: 208830464 16:34:11 INFO - PROCESS | 5060 | 16:34:13 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42706/tests/kraken/driver.html?testName=json-parse-financial) 16:34:14 INFO - PROCESS | 5060 | RSS: Main: 207753216 16:34:14 INFO - PROCESS | 5060 | 16:34:16 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:16 INFO - PROCESS | 5060 | RSS: Main: 169078784 16:34:16 INFO - PROCESS | 5060 | 16:34:18 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:18 INFO - PROCESS | 5060 | RSS: Main: 177549312 16:34:18 INFO - PROCESS | 5060 | 16:34:20 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:21 INFO - PROCESS | 5060 | RSS: Main: 187412480 16:34:21 INFO - PROCESS | 5060 | 16:34:24 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:24 INFO - PROCESS | 5060 | RSS: Main: 195792896 16:34:24 INFO - PROCESS | 5060 | 16:34:27 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:27 INFO - PROCESS | 5060 | RSS: Main: 193343488 16:34:27 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | Cycle 1(1): loaded http://localhost:42706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42706/tests/kraken/driver.html?testName=ai-astar) 16:34:29 INFO - PROCESS | 5060 | RSS: Main: 243576832 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | __start_tp_report 16:34:29 INFO - PROCESS | 5060 | _x_x_mozilla_page_load 16:34:29 INFO - PROCESS | 5060 | _x_x_mozilla_page_load_details 16:34:29 INFO - PROCESS | 5060 | |i|pagename|runs| 16:34:29 INFO - PROCESS | 5060 | |0;ai-astar;106;115;112;112;112;115;112;113;112;111 16:34:29 INFO - PROCESS | 5060 | |1;audio-beat-detection;144;122;121;161;123;122;117;118;137;118 16:34:29 INFO - PROCESS | 5060 | |2;audio-dft;160;160;160;160;160;161;161;160;160;161 16:34:29 INFO - PROCESS | 5060 | |3;audio-fft;75;75;76;117;75;75;76;75;91;75 16:34:29 INFO - PROCESS | 5060 | |4;audio-oscillator;82;84;110;82;83;82;94;82;81;107 16:34:29 INFO - PROCESS | 5060 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;116;116;117 16:34:29 INFO - PROCESS | 5060 | |6;imaging-darkroom;146;147;146;145;146;147;145;146;146;147 16:34:29 INFO - PROCESS | 5060 | |7;imaging-desaturate;95;96;96;95;96;95;96;96;97;96 16:34:29 INFO - PROCESS | 5060 | |8;json-parse-financial;53;53;50;52;51;52;52;52;52;51 16:34:29 INFO - PROCESS | 5060 | |9;json-stringify-tinderbox;65;64;64;64;65;65;64;65;64;64 16:34:29 INFO - PROCESS | 5060 | |10;stanford-crypto-aes;75;75;74;93;75;84;77;74;74;77 16:34:29 INFO - PROCESS | 5060 | |11;stanford-crypto-ccm;122;126;127;120;125;126;117;117;161;120 16:34:29 INFO - PROCESS | 5060 | |12;stanford-crypto-pbkdf2;161;159;156;155;162;156;153;155;160;157 16:34:29 INFO - PROCESS | 5060 | |13;stanford-crypto-sha256-iterative;63;62;61;61;62;60;60;62;58;60 16:34:29 INFO - PROCESS | 5060 | __end_tp_report 16:34:29 INFO - PROCESS | 5060 | __start_cc_report 16:34:29 INFO - PROCESS | 5060 | _x_x_mozilla_cycle_collect,1497 16:34:29 INFO - PROCESS | 5060 | __end_cc_report 16:34:29 INFO - PROCESS | 5060 | __startTimestamp1489192469818__endTimestamp 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | ------- Summary: start ------- 16:34:29 INFO - PROCESS | 5060 | Number of tests: 14 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:1.41 16:34:29 INFO - PROCESS | 5060 | Values: 106.0 115.0 112.0 112.0 112.0 115.0 112.0 113.0 112.0 111.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:122.50 stddev:14.50 (11.8%) stddev-sans-first:14.22 16:34:29 INFO - PROCESS | 5060 | Values: 144.0 122.0 121.0 161.0 123.0 122.0 117.0 118.0 137.0 118.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:34:29 INFO - PROCESS | 5060 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 161.0 160.0 160.0 161.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.59 (18.1%) stddev-sans-first:14.24 16:34:29 INFO - PROCESS | 5060 | Values: 75.0 75.0 76.0 117.0 75.0 75.0 76.0 75.0 91.0 75.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:82.00 stddev:11.11 (13.5%) stddev-sans-first:11.51 16:34:29 INFO - PROCESS | 5060 | Values: 82.0 84.0 110.0 82.0 83.0 82.0 94.0 82.0 81.0 107.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:34:29 INFO - PROCESS | 5060 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:34:29 INFO - PROCESS | 5060 | Values: 146.0 147.0 146.0 145.0 146.0 147.0 145.0 146.0 146.0 147.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:34:29 INFO - PROCESS | 5060 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 97.0 96.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.87 16:34:29 INFO - PROCESS | 5060 | Values: 53.0 53.0 50.0 52.0 51.0 52.0 52.0 52.0 52.0 51.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:34:29 INFO - PROCESS | 5060 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 64.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.00 stddev:6.12 (8.1%) stddev-sans-first:6.41 16:34:29 INFO - PROCESS | 5060 | Values: 75.0 75.0 74.0 93.0 75.0 84.0 77.0 74.0 74.0 77.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.50 stddev:12.81 (10.2%) stddev-sans-first:13.50 16:34:29 INFO - PROCESS | 5060 | Values: 122.0 126.0 127.0 120.0 125.0 126.0 117.0 117.0 161.0 120.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.00 stddev:2.95 (1.9%) stddev-sans-first:2.83 16:34:29 INFO - PROCESS | 5060 | Values: 161.0 159.0 156.0 155.0 162.0 156.0 153.0 155.0 160.0 157.0 16:34:29 INFO - PROCESS | 5060 | 16:34:29 INFO - PROCESS | 5060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.50 stddev:1.45 (2.4%) stddev-sans-first:1.32 16:34:29 INFO - PROCESS | 5060 | Values: 63.0 62.0 61.0 61.0 62.0 60.0 60.0 62.0 58.0 60.0 16:34:29 INFO - PROCESS | 5060 | -------- Summary: end -------- 16:34:29 INFO - PROCESS | 5060 | 16:34:31 INFO - TEST-INFO | 5060: exit 0 16:34:31 INFO - TEST-OK | kraken | took 59942ms 16:34:31 INFO - SUITE-END | took 1173s 16:34:31 INFO - Completed test suite (00:19:34) 16:34:31 INFO - javascript benchmark 16:34:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.5351250824883, 3348.045806945021, 3357.865685372585, 3380.864765409384, 3399.864005439781, 5501.257330260419, 5583.4974852263285, 5585.720713964301, 5609.270794796671, 5617.691026993519, 5572.888542229153, 5629.7185140743, 5631.8592035199035, 5645.520130788877, 5680.005998950178, 4973.8259160929465, 5000.274960130779, 5022.723750193738, 5030.899382012358, 5072.315237442954, 4840.031993601294, 4900.0, 5083.618728595352, 5089.414717307502, 5094.414142373637, 4924.852254432372, 4942.382202224722, 4974.527419895104, 5016.899662006757, 5053.014662140884, 5067.87330316745, 5070.797168113271, 5075.898482030376, 5077.314562534048, 5108.64239503235, 4786.976065119687, 4822.590079843182, 4953.306537084811, 4959.760059985004, 5033.597312215014, 5432.266644003049, 5485.259489968843, 5492.231087647732, 5503.229547863302, 5575.553955683536, 5991.550633702446, 5994.2806863176265, 5996.640201587918, 5997.5501837361935, 5998.670073146019, 5911.054231322968, 6028.939710602882, 6035.3059398169335, 6046.244219472566, 6046.727897244635, 5515.283013208257, 5529.419410961871, 5549.306336707911, 5582.804601838916, 5643.971780141073, 6076.726547305382, 6077.513798896078, 6078.0, 6079.75680972765, 6084.4828189603495, 5814.098814683731, 5819.912701309484, 5870.618409803435, 5872.765089396462, 5889.587728858939, 5858.238429004202, 5888.705564721747, 5920.378360272195, 5942.6731529766275, 5958.851028724316, 5960.940390596125, 5961.463468287875, 5969.611975221684, 5974.551908606872, 5997.730102145414, 5974.940250597525, 5975.4024597540765, 5978.701064946736, 5982.970085149546, 6014.879702405928, 4528.818847246073, 4547.977260113678, 4557.772111394417, 4570.908581828345, 4626.074785043005, 4105.096878686684, 4108.897277568025, 4114.033202197481, 4134.710570260053, 4148.979255103705, 5577.832665020056, 5611.382747897728, 5622.690752008679, 5625.774969001194, 5654.15187721845, 5875.50058245054, 5919.496842768327, 5988.9101663475085, 5990.880182396415, 5998.0, 5600.52395546375, 5624.29696287964, 5656.349519805192, 5723.055695810228, 5735.627184233012, 5127.897442051138, 5137.563307118937, 5137.717425541631, 5138.820141295037, 5139.07496650599, 6254.593451425642, 6256.374362563798, 6263.655498947602, 6265.091561723524, 6268.373162683786, 5827.096799996008, 5879.617824841372, 5903.852403689943, 5933.199018132497, 5946.286445626552, 6164.568480206342, 6208.81373558794, 6210.968945155245, 6222.439980401786, 6227.0, 5874.794382196603, 5905.0, 5909.261342332208, 5914.0, 5916.615419997686, 5852.297724273115, 5893.499052580579, 5896.616719913192, 5912.970435147797, 6017.488513476228, 5852.882942341044, 5854.092615644582, 5872.706364681834, 5881.117832325014, 5894.938910996062, 5856.0, 5860.38465961085, 5864.9413505866105, 5869.148973398918, 5880.441358070976, 5726.398728133486, 5749.8275051748515, 5796.188533605383, 5856.736446859816, 5862.091375836752, 5866.560007999503, 5903.498202652822, 5960.403959604005, 5972.58191926561, 5974.492168165581, 5820.417958204146, 5820.476157145878, 5824.039033559585, 5829.125631155361, 5830.125481177857], "value": 5504.1379171427125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7769131193179, 601.1793901324692, 632.4687262699332, 636.5067073018411, 659.2155335151167, 37158.442623360635, 50236.24645630318, 51033.74483127579, 51092.74453627726, 51221.743891280494, 51698.0, 52058.73970630151, 52364.214536781976, 52402.0, 52461.0, 8902.910970890272, 9118.908810911906, 9409.952950235256, 9598.376105553152, 9599.568019439108, 11217.383043932581, 11496.712582185428, 11509.251898626604, 11827.0, 11844.822327665092, 11382.772344553105, 11469.827952580717, 11472.426378681033, 11474.942625286862, 11475.368854712988, 11453.37006464644, 11468.655940321803, 11522.308661480338, 11522.76954460906, 11524.481398337053, 11286.887131128666, 11361.37512436824, 11367.4884630191, 11369.31784092957, 11369.715757106056, 48360.27459588109, 48381.0, 48498.272525912136, 48636.51363486355, 48681.75659121717, 4361.9127617447475, 4432.246518091933, 4443.955560444387, 4493.595576398107, 4637.258038713823, 32982.6701732982, 33288.16779580506, 33299.0, 34267.143321416916, 34388.0, 4585.220512512881, 4641.814327426899, 4715.95284047162, 4767.804332187688, 4816.0, 388285.99999999715, 390502.0, 390951.0, 391598.0, 391867.0, 63611.0, 63921.68039159774, 64022.0, 64029.0, 64031.6798416005, 66011.33988660148, 66198.0, 66284.33715662782, 66374.66812665906, 66382.33617663762, 18936.242550297833, 19787.40637780869, 19814.108365123317, 19815.10832012563, 19817.405477835688, 13923.0, 14220.85779142216, 14960.551183464513, 15187.164705941279, 15454.536363909101, 20012.499687507636, 20162.495937601678, 20241.291554795513, 20281.0, 20293.49266268355, 7336.926630733731, 7441.776746697499, 7595.164531901486, 7672.616369181518, 7688.269614386624, 960.9711708648751, 969.7672558585889, 972.1979367022235, 984.9704508864745, 1013.934094283884, 32982.5052624206, 34636.055935245284, 34697.653023469444, 35512.0, 35600.10999725028, 1129.13056946151, 1170.6780635325354, 1176.623480486236, 1207.849018872641, 1225.7486817232223, 18438.26246950107, 18645.533861653566, 18672.81327186738, 18712.625747484974, 18791.24835006612, 546870.0, 552618.0, 553066.0, 555333.0, 556485.0, 71581.64209178921, 71970.0, 72191.27808721845, 72365.0, 72614.63692681608, 1446.7106578684304, 1468.5520916120686, 1532.4253404973358, 1551.8991265567702, 1583.1609247099057, 31833.36333273275, 35447.82276088603, 35530.467042993856, 35551.64448355483, 36743.63256367402, 59297.40702592919, 60275.39724602698, 60498.0, 60510.0, 60556.69721651363, 320436.0, 320809.0, 321266.0, 321496.0, 321954.0, 28966.565501517074, 29592.556111658774, 31084.68915310818, 31830.522542161423, 31979.520307194944, 52966.20550691666, 52966.47033529615, 53378.4662153389, 53703.46296536984, 54686.72656636692, 44014.339784903896, 45219.0, 45354.77322613498, 46024.539754603364, 47283.29075063808, 41234.79382603188, 46232.53767462417, 46572.06855862796, 47486.28770568375, 47583.286250705576, 40549.1890162201, 42757.57242427536, 49266.0, 49618.52670313043, 50179.49820501748, 43845.561544384145, 47941.28088078612, 48511.27233091436, 48756.0, 50029.49970500394, 37136.809889104734, 37372.439413408276, 37696.43455348117, 38059.2388152241, 38107.0], "value": 22598.678191849704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.82951063840414, 444.09183220314463, 447.1727304486702, 448.71506593313234, 462.24884562585777, 20879.37361879144, 22013.0, 22587.0, 22829.97265123069, 22941.19705810297, 21345.466363340925, 21710.0, 21726.565468690616, 21858.453538661543, 22022.88988555059, 5447.891042179164, 5468.781248750045, 5632.0, 5635.3801081881165, 5663.631863928831, 4259.10558782656, 5552.77788888444, 5621.156826476021, 5622.465865742748, 5628.0, 4444.2222611042935, 6013.0, 6254.718537665816, 6261.718222679968, 6386.968065159691, 6165.660888651122, 6212.844678883019, 6269.122322874801, 6361.968190159043, 6371.681415929208, 6141.631502109888, 6145.231846019247, 6149.354317796657, 6149.877002459926, 6152.046432802923, 15782.131982740944, 19178.712319315222, 19461.02694865251, 26789.732102678918, 26954.460910781872, 2846.6157068795656, 2882.76937844974, 2900.3474218300926, 2901.2021694034097, 2902.129361191634, 11124.721881952935, 11139.33164010162, 11155.832662509987, 11514.76970460586, 11538.76922461546, 2075.055849588434, 2120.5546835164632, 2225.6216443204694, 2240.0591751464426, 2258.198339589455, 95551.52224238904, 95929.5203523985, 97215.0, 98849.0, 99375.0, 12323.0, 12657.0, 12757.489700412065, 12810.615681529569, 12891.162074465317, 18442.723359149622, 18450.26198952027, 18479.907600461913, 18493.075346232636, 18520.259189632532, 9536.52317384128, 9625.71122866315, 9695.70912872615, 9846.803063938682, 9858.605655773832, 9318.90681093194, 9385.5307234638, 9413.952930235442, 9440.29197810167, 9630.45912653972, 5000.424951130593, 5440.265564148789, 5499.1476321170285, 5527.143292789624, 5563.471470210324, 2003.1186278037908, 2040.7246817916737, 2252.68462415262, 2267.761885002084, 2286.9542609148057, 456.7624835085803, 471.90561887622613, 1119.238917536067, 1138.743782648914, 1197.2577002258656, 12649.683757905941, 12654.114212005072, 13035.15271507349, 13239.404226809816, 13319.334033298297, 483.5140683612946, 489.8114226023007, 493.948135445773, 499.05180157699937, 506.8276785892814, 6811.693473793691, 6956.8956465653055, 7075.115610548682, 7116.0, 7229.132504099542, 697969.7861095937, 699703.0, 709397.0, 737410.0, 738594.0, 108410.0, 109504.0, 112070.43964780123, 116833.0, 117092.0, 511.9283300337956, 518.2097301614992, 520.1391696741898, 520.4925197932062, 520.9010288045259, 11596.188266821242, 11683.591074312359, 11963.581274655346, 12163.087768417226, 12203.20679155852, 43830.0, 44563.77718111389, 45422.545774543156, 45795.54204458046, 46545.76727116343, 60713.69643151756, 61209.69395152996, 61838.38161618506, 70331.29668703453, 70927.29072709414, 9121.817563648558, 9186.265098791948, 9228.261739060994, 9313.068693130634, 9454.763630909283, 9895.703128905856, 13871.79192312096, 14115.929420353243, 14497.565073047825, 14544.781828272797, 12117.939410302892, 12143.08926830509, 12187.207831490925, 12419.19275247106, 12613.117081804186, 12336.198147120409, 12363.814542781685, 12381.442835072263, 12415.0, 12501.24992500453, 12135.878641213829, 12501.624951251477, 12522.436490358137, 12590.055745818918, 12771.872281277068, 9350.579223935076, 9450.43297402158, 9476.763080923032, 9582.712518624452, 9655.055208161579, 12187.57343493009, 12192.329421881881, 12338.321392323509, 12397.938010310252, 12435.75128497443], "value": 9351.83261372437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.9189894555795, 1532.6934613077387, 1540.0374765771394, 1545.8531439513247, 1549.5583758628793, 7783.377329813616, 8034.678612855493, 8688.739337819869, 9208.03315651856, 9208.861867071999, 8627.309815214783, 8898.021217666052, 8902.821943561124, 9118.042605526407, 9125.315601329894, 2384.2966324934187, 2417.492326611414, 2420.3465064432594, 2422.6002709552904, 2426.7815896569305, 2385.7494963028894, 2432.428379330856, 2442.780149786519, 2447.021191523396, 2447.559439300925, 2396.1254142238045, 2418.5767490689145, 2439.0, 2460.815438842085, 2468.3212116667883, 2338.4504641409253, 2367.7868991790733, 2371.454565449956, 2380.571497130516, 2399.5560821248037, 2304.3778179891337, 2342.5666251743482, 2380.488195038075, 2401.135591187171, 2402.783749462539, 9030.774230644221, 9108.8633670495, 9118.179363857285, 9122.908770912338, 9124.81750364989, 5302.655327403745, 5436.075867102602, 5439.809606663787, 5439.864003399907, 5442.346918369782, 3439.724822014258, 3492.5285086513504, 3543.94684079739, 3560.6973407260416, 3590.838412271454, 1502.068717395222, 1544.536639008293, 1546.2887071946918, 2204.239537359608, 2226.198568515333, 12624.305663188521, 12664.366781660972, 12674.239545627292, 12702.999999999907, 12718.745625087538, 4402.911941761211, 4674.205385084544, 4751.026039661861, 4756.524347565216, 4759.547842954914, 10086.142677872316, 10097.747556311004, 10102.09081182697, 10105.191584673208, 10105.696829095139, 5554.444555544414, 5555.861103472445, 5560.860978475571, 5562.0, 5564.33228012641, 4543.159515489645, 4608.308753686907, 4980.178270585386, 5058.1654027085115, 5187.948120518747, 3875.302445559826, 3966.484357033567, 3990.082281075369, 3994.6205110514456, 4043.5754245804355, 1235.184778046485, 1239.863615002349, 1241.2490443281865, 1249.731307768834, 1253.3921048291572, 843.9493630382074, 855.4054931822324, 857.8155696525278, 879.5162660536807, 883.6862913665685, 5948.672822994777, 6063.514918806573, 6140.508759299335, 6251.843703907439, 6384.361563843579, 1060.7305594980267, 1062.5696592879897, 1063.6862125672944, 1077.3266708307308, 1095.5727266366123, 4090.427340172378, 4143.316352801754, 4173.916521669549, 4203.642690371292, 4244.3209086546, 10904.727381815517, 11204.607838725606, 11224.551017959353, 11257.099432045581, 11273.661790146309, 11012.229143960007, 11085.778284434266, 11128.777424451466, 11129.499172537255, 11174.161937854693, 8043.276105150565, 8363.540005299767, 8365.832683346422, 8530.573471326408, 8592.999999999874, 5802.274715660543, 5899.292084949833, 5920.674362910081, 6030.7889223876955, 6066.484348830399, 9503.239740820856, 9584.66453674118, 9593.472359020041, 9606.471644059644, 9656.32405731592, 9566.330356874952, 9933.205343572641, 10083.848742269018, 10106.848397274194, 10106.898931010595, 7323.304286092813, 7531.435142364235, 7583.848323033619, 8053.637586308748, 8232.588370581567, 8625.69810056645, 8809.207171354608, 8812.20690137865, 8812.735617931472, 8816.559172041243, 7704.576248306397, 7871.212878712083, 7876.606169691607, 7895.171007044178, 7909.446338756232, 7760.805979850549, 7806.41451891099, 7835.255650713173, 7851.371890248881, 7910.881336780068, 7001.859962800817, 7009.0, 7082.681279342339, 7116.715331386687, 7119.466040046914, 5479.561635069264, 5497.780088796403, 5592.217089607377, 5610.803621873215, 5641.294838145232, 5424.83725488236, 5425.104857698436, 5481.835544933659, 5511.090670039559, 5562.2490963721], "value": 4785.153584599606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.5875782974855, 420.7013020755265, 435.0016711646774, 439.33879511335437, 439.5560483911249, 5234.50272224139, 5420.241166236725, 5420.292607828531, 5426.9185962210595, 5463.289772329596, 5239.476052394759, 5336.199570064492, 5340.62615616907, 5357.7589008494615, 5363.4904684055045, 4090.161516889038, 4136.172765446922, 4147.8963025924295, 4200.579942005806, 4248.575142485757, 4254.680898932593, 4255.3829694694405, 4270.829166833323, 4296.5059018213, 4296.892577685568, 4260.744355338674, 4270.12462445198, 4282.721623094489, 4294.26997410441, 4295.119500502389, 4202.348635961431, 4231.8518851840345, 4256.318988961782, 4270.722403043792, 4302.655787537005, 3823.527941742449, 3833.9808300958316, 3843.6540711336115, 3858.8004837242784, 3859.807009649506, 5251.317328747238, 5264.078786212397, 5265.210218467222, 5303.628745987782, 5306.257124002643, 4842.41890973082, 4936.5063493650705, 4986.850394488171, 4988.0, 5020.673656212334, 5659.6321239119325, 5664.130836823838, 5668.858278543028, 5671.9716401418145, 5677.176809362661, 4360.558087471027, 4360.716553424049, 4389.582989616013, 4399.472063352418, 4406.383106365111, 5506.449355064502, 5784.855378615526, 5828.766849326022, 5851.4441128093185, 5894.705264736746, 4309.116631090619, 4317.805698743564, 4335.739855608674, 4335.745412385542, 4346.739195648272, 4358.237308471005, 4381.890452738707, 4384.693071484965, 4386.429764130707, 4391.494978077498, 4757.762111894392, 4821.373221481185, 4893.681910675795, 4902.828401005948, 4929.482404347564, 5633.971830140905, 5646.971765141148, 5648.6893220872425, 5649.6327738696855, 5674.744636491368, 1500.6848561802144, 1506.374854435397, 1506.8568485993812, 1512.2665507228985, 1515.8631026729952, 992.5533509920565, 1048.444324508012, 1095.9945200274108, 1121.6578943422335, 1138.4478527913955, 5091.541761241506, 5331.360236771535, 5446.700431476228, 5457.863553411117, 5473.233747275384, 5677.9211949729415, 5712.457316555004, 5722.77108915647, 5758.667739565482, 5763.9135412968835, 5250.582491132803, 5378.865528361822, 5425.050616142159, 5484.177373394023, 5487.024671118474, 2918.591397204393, 2924.97075029247, 2925.9905332660196, 2926.5610158476397, 2946.8231906085703, 5720.914186287209, 5784.21913041734, 5791.594588378773, 5809.24479817621, 5812.505936995402, 5429.945700542944, 5694.402087780806, 5705.429457054344, 5716.228309178291, 5738.741756620962, 5658.886822263532, 5672.205891175238, 5728.396049106173, 5737.483626473638, 5743.587693168795, 5236.345456817898, 5510.3938566758425, 5551.9722401387735, 5561.610687251854, 5604.663720176803, 5438.646487978269, 5499.560035197094, 5508.834734957958, 5526.696031718294, 5547.2511210986, 5730.856728581819, 5743.798967036134, 5764.913526297193, 5775.624584402, 5782.5373970081455, 4185.0, 4288.078063216423, 4306.763128027988, 4322.5677432256525, 4363.956360436355, 5614.0, 5614.466625670555, 5615.971920140373, 5619.7636519965545, 5642.645765016285, 5496.258005169251, 5496.642718223463, 5526.751296191601, 5529.22590837275, 5532.2254884315425, 5052.242163675331, 5349.43227250914, 5371.952469268612, 5401.513863752281, 5430.972845135749, 5391.75737091824, 5398.676079435247, 5419.512243898068, 5429.344050064768, 5437.227014222696, 5338.839834804962, 5455.645383050089, 5482.725863706719, 5588.161775733673, 5595.104783234663, 5456.863578410572, 5476.67139971603, 5479.424660410599, 5484.451554844643, 5498.835034948958], "value": 4340.739466334577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.9621567029483, 864.6066039951822, 866.0213958227203, 932.9626814927403, 934.1182452135163, 16302.592435189126, 17180.14099295035, 17387.13064346784, 17429.0, 17660.47018589441, 15908.443204487845, 15969.121698306588, 16040.278187481563, 16078.437254696088, 16090.436834710787, 696.2619623199399, 714.1501613080444, 827.7889138269747, 839.3495041342977, 839.3788596438652, 805.8066064144592, 823.3331001888489, 824.9670013199465, 825.8059356051323, 829.1335554345693, 873.6243415331405, 874.5889431966965, 875.3522393428849, 877.7015814623027, 878.44218920985, 860.5611138319503, 860.5998210831962, 860.9483430994161, 863.1109956744532, 863.1411745313391, 633.7750098714982, 635.8124353315783, 636.0681601453892, 636.4399328590856, 641.5637366590717, 17620.559486012826, 17809.19858606366, 17883.1952562135, 18037.458876233733, 18347.633047339114, 15064.0, 16876.662466750597, 16966.575835604086, 16966.57583560421, 17011.234494447657, 14040.297985100704, 14337.42650293987, 14350.856491435057, 14533.563993080224, 14566.635834104127, 4824.421069471651, 4853.296272040569, 4861.513848615145, 4911.214205727067, 4983.127952608315, 79959.6002019992, 81588.59205703993, 82095.589522052, 83463.58268208681, 83791.0, 12698.0, 12794.936025319814, 12827.358632068359, 12870.099093063396, 12922.612321630366, 23801.523969520513, 23949.0, 24052.15817446416, 24340.148094816952, 24483.265502034967, 8748.34387420946, 8825.735227943173, 8853.867191992125, 8872.378933474723, 8979.865302020475, 4741.838249628863, 4771.475137734847, 4831.202851529529, 4841.806327746921, 4865.343178670834, 3956.228535435562, 4061.756294622332, 4063.7968101595393, 4064.552899181088, 4068.16602596467, 685.3009929871503, 688.3770187979886, 690.3648643248123, 702.5538782872912, 713.7501874344042, 845.6744153500823, 852.7166614245521, 873.1443185677944, 878.2929741558107, 884.0805562215224, 11071.391073491035, 11190.496427660612, 11321.773564528663, 11410.429478526206, 11545.769084618429, 835.0897521701374, 848.4697064334791, 854.5300084953251, 863.7495126413395, 875.6147295190224, 5239.292695486137, 5250.894982100413, 5296.152615581565, 5353.705546194997, 5357.571394288448, 81755.18244817594, 82631.5868420654, 82893.58553207196, 84103.0, 85556.14443855482, 59370.10944835831, 59511.0, 60937.39062609317, 69626.0, 71882.2811771886, 51232.0, 51275.0, 53798.7310063455, 59215.70392148098, 64048.67975660092, 10981.17641176931, 11225.66323010311, 11338.829917551078, 11354.318740875575, 11361.43192840338, 39089.80455097706, 41649.58350416457, 42818.78590607027, 43417.3487397683, 43606.78196608997, 51978.74010629923, 52858.47141528689, 54886.72556637191, 55048.72475637596, 55476.72261638666, 14030.0, 14144.43422263098, 14170.433182672577, 14232.217228052557, 14305.213213272953, 14352.210628415538, 14577.635559111108, 14626.488072917396, 14692.632684182981, 15546.533603991898, 14643.85356146425, 14976.251187440803, 15017.6996460068, 15083.170425626697, 15253.08481491114, 14858.9003614865, 14895.553133406016, 15005.624859378166, 15159.317830697866, 15423.61440963985, 14312.642183945485, 14479.638009049859, 14649.92675036618, 14728.189949552449, 14774.852251477347, 11146.609868654883, 11274.661760147208, 11327.376994265065, 11525.423728813694, 11818.40907954616, 10977.780444391226, 11104.500297486795, 11177.608783692533, 11199.21605487608, 11242.66272011841], "value": 7823.379114080339, "unit": "score"}], "name": "dromaeo_css", "value": 7575.796958788276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 112.0, 112.0, 112.0, 115.0, 112.0, 113.0, 112.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 121.0, 161.0, 123.0, 122.0, 117.0, 118.0, 137.0, 118.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 117.0, 75.0, 75.0, 76.0, 75.0, 91.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 110.0, 82.0, 83.0, 82.0, 94.0, 82.0, 81.0, 107.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 50.0, 52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 93.0, 75.0, 84.0, 77.0, 74.0, 74.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 127.0, 120.0, 125.0, 126.0, 117.0, 117.0, 161.0, 120.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 156.0, 155.0, 162.0, 156.0, 153.0, 155.0, 160.0, 157.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 62.0, 60.0, 60.0, 62.0, 58.0, 60.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1467.0, "alertThreshold": 2.0}]} 16:34:31 INFO - Return code: 0 16:34:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:34:31 INFO - # TBPL SUCCESS # 16:34:31 INFO - Running post-action listener: _resource_record_post_action 16:34:31 INFO - [mozharness: 2017-03-11 00:34:31.642255Z] Finished run-tests step (success) 16:34:31 INFO - Running post-run listener: _resource_record_post_run 16:34:31 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328335360; Read time: 24; Write time: 209544 16:34:31 INFO - TinderboxPrint: CPU usage
13.0% 16:34:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 16:34:31 INFO - TinderboxPrint: I/O write bytes / time
328,335,360 / 209,544 16:34:31 INFO - TinderboxPrint: CPU idle
8,248.6 (87.0%) 16:34:31 INFO - TinderboxPrint: CPU user
1,190.0 (12.5%) 16:34:31 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:31 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 105672704; Read time: 0; Write time: 69348 16:34:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 222109696; Read time: 0; Write time: 140188 16:34:32 INFO - Running post-run listener: _upload_blobber_files 16:34:32 INFO - Blob upload gear active. 16:34:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:32 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 16:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:34:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:33 INFO - (blobuploader) - INFO - Done attempting. 16:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:36 INFO - (blobuploader) - INFO - Done attempting. 16:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:37 INFO - (blobuploader) - INFO - Done attempting. 16:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:38 INFO - (blobuploader) - INFO - Done attempting. 16:34:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:38 INFO - Return code: 0 16:34:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1919ee87730b456148e99906484d79748553c558594c0a5bb4d73b5043db3c64a1c12b4504865ef91c24958d0876e6253f588aae9374f2ccaa0f1930a81787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba2893850b3fcc529cd63fc646f423a682e51a372cc3c6fbe1a4402fde8f8ae6dc237368da900bfbdcdd9ec1c21a0c55e913512fc4374f6f373ffb971af279f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bb4f45f20757a933311bacbd552b6e4c8abfcfe4c1ac0d6d6bc0b2f6c70ef47062e4abfb2c7ab9f677dfcf1e8a0b95aa6b0924d0a8a4773a00f76bf1f6f41d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b7bd05720651d5ec0f8da7bcb3fa0dc7700b8817d6c8f24ca78108f086c4f080290621146a5c65f10d042b738377c91e4e03292322ccc3866a7fa24c81dc267"} 16:34:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:38 INFO - Contents: 16:34:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1919ee87730b456148e99906484d79748553c558594c0a5bb4d73b5043db3c64a1c12b4504865ef91c24958d0876e6253f588aae9374f2ccaa0f1930a81787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba2893850b3fcc529cd63fc646f423a682e51a372cc3c6fbe1a4402fde8f8ae6dc237368da900bfbdcdd9ec1c21a0c55e913512fc4374f6f373ffb971af279f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bb4f45f20757a933311bacbd552b6e4c8abfcfe4c1ac0d6d6bc0b2f6c70ef47062e4abfb2c7ab9f677dfcf1e8a0b95aa6b0924d0a8a4773a00f76bf1f6f41d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b7bd05720651d5ec0f8da7bcb3fa0dc7700b8817d6c8f24ca78108f086c4f080290621146a5c65f10d042b738377c91e4e03292322ccc3866a7fa24c81dc267"} 16:34:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:38 INFO - Copying logs to upload dir... 16:34:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.694771 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-03-10 16:34:38.119251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 16:34:38.122474) ========= 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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 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-Beta/sha512/5d1919ee87730b456148e99906484d79748553c558594c0a5bb4d73b5043db3c64a1c12b4504865ef91c24958d0876e6253f588aae9374f2ccaa0f1930a81787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba2893850b3fcc529cd63fc646f423a682e51a372cc3c6fbe1a4402fde8f8ae6dc237368da900bfbdcdd9ec1c21a0c55e913512fc4374f6f373ffb971af279f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bb4f45f20757a933311bacbd552b6e4c8abfcfe4c1ac0d6d6bc0b2f6c70ef47062e4abfb2c7ab9f677dfcf1e8a0b95aa6b0924d0a8a4773a00f76bf1f6f41d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b7bd05720651d5ec0f8da7bcb3fa0dc7700b8817d6c8f24ca78108f086c4f080290621146a5c65f10d042b738377c91e4e03292322ccc3866a7fa24c81dc267"} build_url:https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/Zw9qqp3uRa6OAploAAhfuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1919ee87730b456148e99906484d79748553c558594c0a5bb4d73b5043db3c64a1c12b4504865ef91c24958d0876e6253f588aae9374f2ccaa0f1930a81787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba2893850b3fcc529cd63fc646f423a682e51a372cc3c6fbe1a4402fde8f8ae6dc237368da900bfbdcdd9ec1c21a0c55e913512fc4374f6f373ffb971af279f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bb4f45f20757a933311bacbd552b6e4c8abfcfe4c1ac0d6d6bc0b2f6c70ef47062e4abfb2c7ab9f677dfcf1e8a0b95aa6b0924d0a8a4773a00f76bf1f6f41d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b7bd05720651d5ec0f8da7bcb3fa0dc7700b8817d6c8f24ca78108f086c4f080290621146a5c65f10d042b738377c91e4e03292322ccc3866a7fa24c81dc267"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 16:34:38.147189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:34:38.147501) ========= 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=cbe409c6de289db6ac707de3000001d4-1489191243.107160-303313450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 16:34:38.231870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 16:34:38.232197) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 16:34:38.232499) ========= ========= Total master_lag: 0.16 =========