builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1472154026.5 results: success (0) buildid: 20160825083014 builduid: d62bef4cc7d048efbbcd3392e54eb311 revision: c0c2f6077694008794c06900943654db0143c2b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.496681) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.497353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.497674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.541769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.542038) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 12:40:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-08-25 12:40:26 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147432 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.736260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.736546) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019426 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.771927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:26.772298) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0c2f6077694008794c06900943654db0143c2b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c0c2f6077694008794c06900943654db0143c2b9 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 12:40:26,921 truncating revision to first 12 chars 2016-08-25 12:40:26,921 Setting DEBUG logging. 2016-08-25 12:40:26,921 attempt 1/10 2016-08-25 12:40:26,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0c2f6077694?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 12:40:27,242 unpacking tar archive at: fx-team-c0c2f6077694/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:27.394398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:27.394805) ========= script_repo_revision: c0c2f6077694008794c06900943654db0143c2b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:27.395312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:27.395596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 12:40:27.405491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 12:40:27.405820) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:40:27 INFO - MultiFileLogger online at 20160825 12:40:27 in /builds/slave/test 12:40:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:40:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:40:27 INFO - {'append_to_log': False, 12:40:27 INFO - 'base_work_dir': '/builds/slave/test', 12:40:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:40:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:40:27 INFO - 'branch': 'Fx-Team', 12:40:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:40:27 INFO - 'config_files': ('talos/linux_config.py',), 12:40:27 INFO - 'default_actions': ('clobber', 12:40:27 INFO - 'read-buildbot-config', 12:40:27 INFO - 'download-and-extract', 12:40:27 INFO - 'populate-webroot', 12:40:27 INFO - 'create-virtualenv', 12:40:27 INFO - 'install', 12:40:27 INFO - 'run-tests'), 12:40:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:40:27 INFO - 'download_minidump_stackwalk': True, 12:40:27 INFO - 'download_symbols': 'ondemand', 12:40:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:40:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:40:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:40:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:40:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:40:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:40:27 INFO - 'installer_path': 'installer.exe', 12:40:27 INFO - 'log_level': 'info', 12:40:27 INFO - 'log_name': 'talos', 12:40:27 INFO - 'log_to_console': True, 12:40:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:40:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:40:27 INFO - 'opt_config_files': (), 12:40:27 INFO - 'pip_index': False, 12:40:27 INFO - 'sps_profile': False, 12:40:27 INFO - 'sps_profile_interval': 0, 12:40:27 INFO - 'suite': 'dromaeojs-e10s', 12:40:27 INFO - 'system_bits': '32', 12:40:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:40:27 INFO - 'title': 'talos-linux64-ix-041', 12:40:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:40:27 INFO - 'use_talos_json': True, 12:40:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:40:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:40:27 INFO - 'work_dir': 'build'} 12:40:27 INFO - [mozharness: 2016-08-25 19:40:27.645518Z] Running clobber step. 12:40:27 INFO - Running pre-action listener: _resource_record_pre_action 12:40:27 INFO - Running main action method: clobber 12:40:27 INFO - rmtree: /builds/slave/test/build 12:40:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:40:28 INFO - Running post-action listener: _resource_record_post_action 12:40:28 INFO - [mozharness: 2016-08-25 19:40:28.109281Z] Finished clobber step (success) 12:40:28 INFO - [mozharness: 2016-08-25 19:40:28.109381Z] Running read-buildbot-config step. 12:40:28 INFO - Running pre-action listener: _resource_record_pre_action 12:40:28 INFO - Running main action method: read_buildbot_config 12:40:28 INFO - Using buildbot properties: 12:40:28 INFO - { 12:40:28 INFO - "project": "", 12:40:28 INFO - "product": "firefox", 12:40:28 INFO - "script_repo_revision": "production", 12:40:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:40:28 INFO - "repository": "", 12:40:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:40:28 INFO - "buildid": "20160825083014", 12:40:28 INFO - "pgo_build": "True", 12:40:28 INFO - "basedir": "/builds/slave/test", 12:40:28 INFO - "buildnumber": 708, 12:40:28 INFO - "slavename": "talos-linux64-ix-041", 12:40:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:40:28 INFO - "platform": "ubuntu64_hw", 12:40:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:40:28 INFO - "branch": "fx-team", 12:40:28 INFO - "repo_path": "integration/fx-team", 12:40:28 INFO - "revision": "c0c2f6077694008794c06900943654db0143c2b9", 12:40:28 INFO - "stage_platform": "linux64-pgo", 12:40:28 INFO - "builduid": "d62bef4cc7d048efbbcd3392e54eb311", 12:40:28 INFO - "slavebuilddir": "test" 12:40:28 INFO - } 12:40:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:40:28 INFO - Running post-action listener: _resource_record_post_action 12:40:28 INFO - [mozharness: 2016-08-25 19:40:28.111859Z] Finished read-buildbot-config step (success) 12:40:28 INFO - [mozharness: 2016-08-25 19:40:28.111947Z] Running download-and-extract step. 12:40:28 INFO - Running pre-action listener: _resource_record_pre_action 12:40:28 INFO - Running main action method: download_and_extract 12:40:28 INFO - mkdir: /builds/slave/test/build/tests 12:40: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')]} 12:40:28 INFO - trying https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:40:28 INFO - Downloading https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:40:28 INFO - Downloaded 1361 bytes. 12:40:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:40:28 INFO - Using the following test package requirements: 12:40:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:40:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:40:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:40:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'jsshell-linux-x86_64.zip'], 12:40:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:40:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:40:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:40:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:40:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:40:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:40:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:40:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:40: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')]} 12:40:28 INFO - trying https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:40:28 INFO - Downloading https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:40:29 INFO - Downloaded 21914607 bytes. 12:40:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:40:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:33 INFO - trying https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:40:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:40:34 INFO - Downloaded 21914607 bytes. 12:40:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:39 INFO - trying https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:40:39 INFO - Downloading https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:40:39 INFO - Downloaded 14413981 bytes. 12:40:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 12:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:40 INFO - trying https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:40:40 INFO - Downloading https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:40:41 INFO - Downloaded 59737740 bytes. 12:40:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:40:41 INFO - mkdir: /builds/slave/test/properties 12:40:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:40:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:40:41 INFO - Contents: 12:40:41 INFO - build_url:https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:40:41 INFO - Running post-action listener: _resource_record_post_action 12:40:41 INFO - Running post-action listener: set_extra_try_arguments 12:40:41 INFO - [mozharness: 2016-08-25 19:40:41.969623Z] Finished download-and-extract step (success) 12:40:41 INFO - [mozharness: 2016-08-25 19:40:41.970035Z] Running populate-webroot step. 12:40:41 INFO - Running pre-action listener: _resource_record_pre_action 12:40:41 INFO - Running main action method: populate_webroot 12:40:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:40:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:40:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:40:41 INFO - '--tppagecycles', 12:40:41 INFO - '7'], 12:40:41 INFO - 'tests': ['tsvgm']}}, 12:40:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:40:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:40:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:40:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:40:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['damp', 'tps']}, 12:40:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'tests': ['damp', 'tps']}, 12:40:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['dromaeo_dom']}, 12:40:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:40:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['basic_compositor_video']}, 12:40:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:40:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['a11yr', 12:40:41 INFO - 'ts_paint', 12:40:41 INFO - 'tpaint', 12:40:41 INFO - 'sessionrestore', 12:40:41 INFO - 'sessionrestore_no_auto_restore', 12:40:41 INFO - 'tabpaint']}, 12:40:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['tsvgx', 12:40:41 INFO - 'tsvgr_opacity', 12:40:41 INFO - 'tart', 12:40:41 INFO - 'tscrollx', 12:40:41 INFO - 'cart']}, 12:40:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:40:41 INFO - 'tsvgr_opacity', 12:40:41 INFO - 'tart', 12:40:41 INFO - 'tscrollx', 12:40:41 INFO - 'cart']}, 12:40:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'talos_options': ['--disable-e10s'], 12:40:41 INFO - 'tests': ['tp5o']}, 12:40:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'tests': ['tp5o']}, 12:40:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'talos_options': ['--disable-e10s', 12:40:41 INFO - '--xperf_path', 12:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:41 INFO - 'tests': ['tp5n']}, 12:40:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:41 INFO - 'talos_options': ['--xperf_path', 12:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:41 INFO - 'tests': ['tp5n']}}, 12:40:41 INFO - 'talos.zip': {'path': '', 12:40:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:40:41 INFO - Running post-action listener: _resource_record_post_action 12:40:41 INFO - [mozharness: 2016-08-25 19:40:41.993086Z] Finished populate-webroot step (success) 12:40:41 INFO - [mozharness: 2016-08-25 19:40:41.993178Z] Running create-virtualenv step. 12:40:41 INFO - Running pre-action listener: _resource_record_pre_action 12:40:41 INFO - Running main action method: create_virtualenv 12:40:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:40:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:40:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:40:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:40:42 INFO - Using real prefix '/usr' 12:40:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:40:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:40:44 INFO - Installing pip.................done. 12:40:44 INFO - Return code: 0 12:40:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:44 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:40:44 INFO - Using env: {'DISPLAY': ':0', 12:40:44 INFO - 'HOME': '/home/cltbld', 12:40:44 INFO - 'LANG': 'en_US.UTF-8', 12:40:44 INFO - 'LANGUAGE': 'en_US:en', 12:40:44 INFO - 'LOGNAME': 'cltbld', 12:40:44 INFO - 'MAIL': '/var/mail/cltbld', 12:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:44 INFO - 'MOZ_NO_REMOTE': '1', 12:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:44 INFO - 'NO_EM_RESTART': '1', 12:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:44 INFO - 'PWD': '/builds/slave/test', 12:40:44 INFO - 'SHELL': '/bin/bash', 12:40:44 INFO - 'SHLVL': '1', 12:40:44 INFO - 'TERM': 'linux', 12:40:44 INFO - 'TMOUT': '86400', 12:40:44 INFO - 'USER': 'cltbld', 12:40:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:44 INFO - '_': '/tools/buildbot/bin/python'} 12:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:40:44 INFO - Cleaning up... 12:40:44 INFO - Return code: 0 12:40:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:44 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:40:44 INFO - Using env: {'DISPLAY': ':0', 12:40:44 INFO - 'HOME': '/home/cltbld', 12:40:44 INFO - 'LANG': 'en_US.UTF-8', 12:40:44 INFO - 'LANGUAGE': 'en_US:en', 12:40:44 INFO - 'LOGNAME': 'cltbld', 12:40:44 INFO - 'MAIL': '/var/mail/cltbld', 12:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:44 INFO - 'MOZ_NO_REMOTE': '1', 12:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:44 INFO - 'NO_EM_RESTART': '1', 12:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:44 INFO - 'PWD': '/builds/slave/test', 12:40:44 INFO - 'SHELL': '/bin/bash', 12:40:44 INFO - 'SHLVL': '1', 12:40:44 INFO - 'TERM': 'linux', 12:40:44 INFO - 'TMOUT': '86400', 12:40:44 INFO - 'USER': 'cltbld', 12:40:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:44 INFO - '_': '/tools/buildbot/bin/python'} 12:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:44 INFO - Downloading/unpacking psutil>=3.1.1 12:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:47 INFO - Installing collected packages: psutil 12:40:47 INFO - Running setup.py install for psutil 12:40:47 INFO - building 'psutil._psutil_linux' extension 12:40:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:40:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:40:47 INFO - building 'psutil._psutil_posix' extension 12:40:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:40:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:47 INFO - Successfully installed psutil 12:40:47 INFO - Cleaning up... 12:40:47 INFO - Return code: 0 12:40:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:47 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:40:47 INFO - Using env: {'DISPLAY': ':0', 12:40:47 INFO - 'HOME': '/home/cltbld', 12:40:47 INFO - 'LANG': 'en_US.UTF-8', 12:40:47 INFO - 'LANGUAGE': 'en_US:en', 12:40:47 INFO - 'LOGNAME': 'cltbld', 12:40:47 INFO - 'MAIL': '/var/mail/cltbld', 12:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:47 INFO - 'MOZ_NO_REMOTE': '1', 12:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:47 INFO - 'NO_EM_RESTART': '1', 12:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:47 INFO - 'PWD': '/builds/slave/test', 12:40:47 INFO - 'SHELL': '/bin/bash', 12:40:47 INFO - 'SHLVL': '1', 12:40:47 INFO - 'TERM': 'linux', 12:40:47 INFO - 'TMOUT': '86400', 12:40:47 INFO - 'USER': 'cltbld', 12:40:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:47 INFO - '_': '/tools/buildbot/bin/python'} 12:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:49 INFO - Installing collected packages: mozsystemmonitor 12:40:49 INFO - Running setup.py install for mozsystemmonitor 12:40:49 INFO - Successfully installed mozsystemmonitor 12:40:49 INFO - Cleaning up... 12:40:49 INFO - Return code: 0 12:40:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:40:49 INFO - Using env: {'DISPLAY': ':0', 12:40:49 INFO - 'HOME': '/home/cltbld', 12:40:49 INFO - 'LANG': 'en_US.UTF-8', 12:40:49 INFO - 'LANGUAGE': 'en_US:en', 12:40:49 INFO - 'LOGNAME': 'cltbld', 12:40:49 INFO - 'MAIL': '/var/mail/cltbld', 12:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:49 INFO - 'MOZ_NO_REMOTE': '1', 12:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:49 INFO - 'NO_EM_RESTART': '1', 12:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:49 INFO - 'PWD': '/builds/slave/test', 12:40:49 INFO - 'SHELL': '/bin/bash', 12:40:49 INFO - 'SHLVL': '1', 12:40:49 INFO - 'TERM': 'linux', 12:40:49 INFO - 'TMOUT': '86400', 12:40:49 INFO - 'USER': 'cltbld', 12:40:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:49 INFO - '_': '/tools/buildbot/bin/python'} 12:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:52 INFO - warning: no files found matching '*.txt' 12:40:52 INFO - no previously-included directories found matching 'build' 12:40:52 INFO - no previously-included directories found matching 'dist' 12:40:52 INFO - no previously-included directories found matching '.git*' 12:40:52 INFO - Installing collected packages: jsonschema, functools32 12:40:52 INFO - Running setup.py install for functools32 12:40:52 INFO - warning: no files found matching '*.txt' 12:40:52 INFO - no previously-included directories found matching 'build' 12:40:52 INFO - no previously-included directories found matching 'dist' 12:40:52 INFO - no previously-included directories found matching '.git*' 12:40:52 INFO - Successfully installed jsonschema functools32 12:40:52 INFO - Cleaning up... 12:40:52 INFO - Return code: 0 12:40:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:52 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:40:52 INFO - Using env: {'DISPLAY': ':0', 12:40:52 INFO - 'HOME': '/home/cltbld', 12:40:52 INFO - 'LANG': 'en_US.UTF-8', 12:40:52 INFO - 'LANGUAGE': 'en_US:en', 12:40:52 INFO - 'LOGNAME': 'cltbld', 12:40:52 INFO - 'MAIL': '/var/mail/cltbld', 12:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:52 INFO - 'MOZ_NO_REMOTE': '1', 12:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:52 INFO - 'NO_EM_RESTART': '1', 12:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:52 INFO - 'PWD': '/builds/slave/test', 12:40:52 INFO - 'SHELL': '/bin/bash', 12:40:52 INFO - 'SHLVL': '1', 12:40:52 INFO - 'TERM': 'linux', 12:40:52 INFO - 'TMOUT': '86400', 12:40:52 INFO - 'USER': 'cltbld', 12:40:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:52 INFO - '_': '/tools/buildbot/bin/python'} 12:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:40:52 INFO - Cleaning up... 12:40:52 INFO - Return code: 0 12:40:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:52 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:40:52 INFO - Using env: {'DISPLAY': ':0', 12:40:52 INFO - 'HOME': '/home/cltbld', 12:40:52 INFO - 'LANG': 'en_US.UTF-8', 12:40:52 INFO - 'LANGUAGE': 'en_US:en', 12:40:52 INFO - 'LOGNAME': 'cltbld', 12:40:52 INFO - 'MAIL': '/var/mail/cltbld', 12:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:52 INFO - 'MOZ_NO_REMOTE': '1', 12:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:52 INFO - 'NO_EM_RESTART': '1', 12:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:52 INFO - 'PWD': '/builds/slave/test', 12:40:52 INFO - 'SHELL': '/bin/bash', 12:40:52 INFO - 'SHLVL': '1', 12:40:52 INFO - 'TERM': 'linux', 12:40:52 INFO - 'TMOUT': '86400', 12:40:52 INFO - 'USER': 'cltbld', 12:40:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:52 INFO - '_': '/tools/buildbot/bin/python'} 12:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:55 INFO - Downloading docopt-0.6.1.tar.gz 12:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:55 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:55 INFO - Running setup.py install for blobuploader 12:40:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:55 INFO - Running setup.py install for requests 12:40:55 INFO - Running setup.py install for docopt 12:40:56 INFO - Successfully installed blobuploader requests docopt 12:40:56 INFO - Cleaning up... 12:40:56 INFO - Return code: 0 12:40:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:56 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:40:56 INFO - Using env: {'DISPLAY': ':0', 12:40:56 INFO - 'HOME': '/home/cltbld', 12:40:56 INFO - 'LANG': 'en_US.UTF-8', 12:40:56 INFO - 'LANGUAGE': 'en_US:en', 12:40:56 INFO - 'LOGNAME': 'cltbld', 12:40:56 INFO - 'MAIL': '/var/mail/cltbld', 12:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:56 INFO - 'MOZ_NO_REMOTE': '1', 12:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:56 INFO - 'NO_EM_RESTART': '1', 12:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:56 INFO - 'PWD': '/builds/slave/test', 12:40:56 INFO - 'SHELL': '/bin/bash', 12:40:56 INFO - 'SHLVL': '1', 12:40:56 INFO - 'TERM': 'linux', 12:40:56 INFO - 'TMOUT': '86400', 12:40:56 INFO - 'USER': 'cltbld', 12:40:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:56 INFO - '_': '/tools/buildbot/bin/python'} 12:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:56 INFO - Running setup.py (path:/tmp/pip-Aj6oKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:56 INFO - Running setup.py (path:/tmp/pip-6_Jngm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:56 INFO - Running setup.py (path:/tmp/pip-iHhJBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:56 INFO - Running setup.py (path:/tmp/pip-UjuKiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:56 INFO - Running setup.py (path:/tmp/pip-_vnv52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:56 INFO - Running setup.py (path:/tmp/pip-L00lrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:56 INFO - Running setup.py (path:/tmp/pip-2i2wGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:56 INFO - Running setup.py (path:/tmp/pip-S_Nqz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:56 INFO - Running setup.py (path:/tmp/pip-qaHiaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:56 INFO - Running setup.py (path:/tmp/pip-vatqKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:57 INFO - Running setup.py (path:/tmp/pip-beYSzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:57 INFO - Running setup.py (path:/tmp/pip-Mq_rFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:57 INFO - Running setup.py (path:/tmp/pip-pNh5il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:57 INFO - Running setup.py (path:/tmp/pip-0kWSx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:57 INFO - Running setup.py (path:/tmp/pip-3TqHWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:57 INFO - Running setup.py (path:/tmp/pip-zRr1Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:57 INFO - Running setup.py (path:/tmp/pip-G6vqlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:57 INFO - Running setup.py install for manifestparser 12:40:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:57 INFO - Running setup.py install for mozcrash 12:40:57 INFO - Running setup.py install for mozdebug 12:40:57 INFO - Running setup.py install for mozdevice 12:40:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozfile 12:40:58 INFO - Running setup.py install for mozhttpd 12:40:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozinfo 12:40:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozInstall 12:40:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozleak 12:40:58 INFO - Running setup.py install for mozlog 12:40:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for moznetwork 12:40:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozprocess 12:40:58 INFO - Running setup.py install for mozprofile 12:40:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:58 INFO - Running setup.py install for mozrunner 12:40:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:59 INFO - Running setup.py install for mozscreenshot 12:40:59 INFO - Running setup.py install for moztest 12:40:59 INFO - Running setup.py install for mozversion 12:40:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:59 INFO - Cleaning up... 12:40:59 INFO - Return code: 0 12:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:59 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:40:59 INFO - Using env: {'DISPLAY': ':0', 12:40:59 INFO - 'HOME': '/home/cltbld', 12:40:59 INFO - 'LANG': 'en_US.UTF-8', 12:40:59 INFO - 'LANGUAGE': 'en_US:en', 12:40:59 INFO - 'LOGNAME': 'cltbld', 12:40:59 INFO - 'MAIL': '/var/mail/cltbld', 12:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:59 INFO - 'MOZ_NO_REMOTE': '1', 12:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:59 INFO - 'NO_EM_RESTART': '1', 12:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:59 INFO - 'PWD': '/builds/slave/test', 12:40:59 INFO - 'SHELL': '/bin/bash', 12:40:59 INFO - 'SHLVL': '1', 12:40:59 INFO - 'TERM': 'linux', 12:40:59 INFO - 'TMOUT': '86400', 12:40:59 INFO - 'USER': 'cltbld', 12:40:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:59 INFO - '_': '/tools/buildbot/bin/python'} 12:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:59 INFO - Running setup.py (path:/tmp/pip-kutFcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:59 INFO - Running setup.py (path:/tmp/pip-Lyn0dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:59 INFO - Running setup.py (path:/tmp/pip-seaTSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:59 INFO - Running setup.py (path:/tmp/pip-379Eln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:59 INFO - Running setup.py (path:/tmp/pip-wZnYWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:59 INFO - Running setup.py (path:/tmp/pip-0UJvAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:00 INFO - Running setup.py (path:/tmp/pip-0HLQHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:00 INFO - Running setup.py (path:/tmp/pip-f92uq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:00 INFO - Running setup.py (path:/tmp/pip-8Zfn77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:00 INFO - Running setup.py (path:/tmp/pip-1cGVkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:00 INFO - Running setup.py (path:/tmp/pip-INgILy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:00 INFO - Running setup.py (path:/tmp/pip-7rlKvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:00 INFO - Running setup.py (path:/tmp/pip-jMZOmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:00 INFO - Running setup.py (path:/tmp/pip-Z1aIzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:00 INFO - Running setup.py (path:/tmp/pip-7PDG15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:00 INFO - Running setup.py (path:/tmp/pip-J0slbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:00 INFO - Running setup.py (path:/tmp/pip-A2NAJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:41:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:41:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:41:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:02 INFO - Downloading blessings-1.6.tar.gz 12:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:41:02 INFO - Installing collected packages: blessings 12:41:02 INFO - Running setup.py install for blessings 12:41:02 INFO - Successfully installed blessings 12:41:02 INFO - Cleaning up... 12:41:03 INFO - Return code: 0 12:41:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:03 INFO - Reading from file tmpfile_stdout 12:41:03 INFO - Current package versions: 12:41:03 INFO - argparse == 1.2.1 12:41:03 INFO - blessings == 1.6 12:41:03 INFO - blobuploader == 1.2.4 12:41:03 INFO - docopt == 0.6.1 12:41:03 INFO - functools32 == 3.2.3-2 12:41:03 INFO - jsonschema == 2.5.1 12:41:03 INFO - manifestparser == 1.1 12:41:03 INFO - mozInstall == 1.12 12:41:03 INFO - mozcrash == 0.17 12:41:03 INFO - mozdebug == 0.1 12:41:03 INFO - mozdevice == 0.48 12:41:03 INFO - mozfile == 1.2 12:41:03 INFO - mozhttpd == 0.7 12:41:03 INFO - mozinfo == 0.9 12:41:03 INFO - mozleak == 0.1 12:41:03 INFO - mozlog == 3.3 12:41:03 INFO - moznetwork == 0.27 12:41:03 INFO - mozprocess == 0.23 12:41:03 INFO - mozprofile == 0.28 12:41:03 INFO - mozrunner == 6.12 12:41:03 INFO - mozscreenshot == 0.1 12:41:03 INFO - mozsystemmonitor == 0.3 12:41:03 INFO - moztest == 0.7 12:41:03 INFO - mozversion == 1.4 12:41:03 INFO - psutil == 3.1.1 12:41:03 INFO - requests == 1.2.3 12:41:03 INFO - wsgiref == 0.1.2 12:41:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:41:03 INFO - Using env: {'DISPLAY': ':0', 12:41:03 INFO - 'HOME': '/home/cltbld', 12:41:03 INFO - 'LANG': 'en_US.UTF-8', 12:41:03 INFO - 'LANGUAGE': 'en_US:en', 12:41:03 INFO - 'LOGNAME': 'cltbld', 12:41:03 INFO - 'MAIL': '/var/mail/cltbld', 12:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:03 INFO - 'MOZ_NO_REMOTE': '1', 12:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:03 INFO - 'NO_EM_RESTART': '1', 12:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:03 INFO - 'PWD': '/builds/slave/test', 12:41:03 INFO - 'SHELL': '/bin/bash', 12:41:03 INFO - 'SHLVL': '1', 12:41:03 INFO - 'TERM': 'linux', 12:41:03 INFO - 'TMOUT': '86400', 12:41:03 INFO - 'USER': 'cltbld', 12:41:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:03 INFO - '_': '/tools/buildbot/bin/python'} 12:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:41:03 INFO - Cleaning up... 12:41:03 INFO - Return code: 0 12:41:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 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 0x7f2409837f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:41:03 INFO - Using env: {'DISPLAY': ':0', 12:41:03 INFO - 'HOME': '/home/cltbld', 12:41:03 INFO - 'LANG': 'en_US.UTF-8', 12:41:03 INFO - 'LANGUAGE': 'en_US:en', 12:41:03 INFO - 'LOGNAME': 'cltbld', 12:41:03 INFO - 'MAIL': '/var/mail/cltbld', 12:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:03 INFO - 'MOZ_NO_REMOTE': '1', 12:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:03 INFO - 'NO_EM_RESTART': '1', 12:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:03 INFO - 'PWD': '/builds/slave/test', 12:41:03 INFO - 'SHELL': '/bin/bash', 12:41:03 INFO - 'SHLVL': '1', 12:41:03 INFO - 'TERM': 'linux', 12:41:03 INFO - 'TMOUT': '86400', 12:41:03 INFO - 'USER': 'cltbld', 12:41:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:03 INFO - '_': '/tools/buildbot/bin/python'} 12:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:41:03 INFO - Cleaning up... 12:41:03 INFO - Return code: 0 12:41:03 INFO - Running post-action listener: _resource_record_post_action 12:41:03 INFO - Running post-action listener: _start_resource_monitoring 12:41:03 INFO - Starting resource monitoring. 12:41:03 INFO - [mozharness: 2016-08-25 19:41:03.720816Z] Finished create-virtualenv step (success) 12:41:03 INFO - [mozharness: 2016-08-25 19:41:03.721266Z] Running install step. 12:41:03 INFO - Running pre-action listener: _resource_record_pre_action 12:41:03 INFO - Running main action method: install 12:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:03 INFO - Reading from file tmpfile_stdout 12:41:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:41:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:41:04 INFO - Reading from file tmpfile_stdout 12:41:04 INFO - Output received: 12:41:04 INFO - Usage: mozinstall [options] installer 12:41:04 INFO - Options: 12:41:04 INFO - -h, --help show this help message and exit 12:41:04 INFO - -d DEST, --destination=DEST 12:41:04 INFO - Directory to install application into. [default: 12:41:04 INFO - "/builds/slave/test"] 12:41:04 INFO - --app=APP Application being installed. [default: firefox] 12:41:04 INFO - mkdir: /builds/slave/test/build/application 12:41:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:41:21 INFO - Reading from file tmpfile_stdout 12:41:21 INFO - Output received: 12:41:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:41:21 INFO - Running post-action listener: _resource_record_post_action 12:41:21 INFO - [mozharness: 2016-08-25 19:41:21.006978Z] Finished install step (success) 12:41:21 INFO - [mozharness: 2016-08-25 19:41:21.007286Z] Running run-tests step. 12:41:21 INFO - Running pre-action listener: _resource_record_pre_action 12:41:21 INFO - Running main action method: run_tests 12:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:41:21 INFO - Python 2.7.3 12:41:21 INFO - Return code: 0 12:41:21 INFO - grabbing minidump binary from tooltool 12:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:21 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 0x299a370>, '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 0x299d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299dd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:41:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:41:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:41:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:41:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:41:21 INFO - Return code: 0 12:41:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:41:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:41:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:41:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:41:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:41:21 INFO - Using env: {'DISPLAY': ':0', 12:41:21 INFO - 'HOME': '/home/cltbld', 12:41:21 INFO - 'LANG': 'en_US.UTF-8', 12:41:21 INFO - 'LANGUAGE': 'en_US:en', 12:41:21 INFO - 'LOGNAME': 'cltbld', 12:41:21 INFO - 'MAIL': '/var/mail/cltbld', 12:41:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:41:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:21 INFO - 'MOZ_NO_REMOTE': '1', 12:41:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:21 INFO - 'NO_EM_RESTART': '1', 12:41:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:21 INFO - 'PWD': '/builds/slave/test', 12:41:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:41:21 INFO - 'SHELL': '/bin/bash', 12:41:21 INFO - 'SHLVL': '1', 12:41:21 INFO - 'TERM': 'linux', 12:41:21 INFO - 'TMOUT': '86400', 12:41:21 INFO - 'USER': 'cltbld', 12:41:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101', 12:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:21 INFO - '_': '/tools/buildbot/bin/python'} 12:41:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:41:21 INFO - mozversion application_buildid: 20160825083014 12:41:21 INFO - mozversion application_changeset: c0c2f6077694008794c06900943654db0143c2b9 12:41:21 INFO - mozversion application_display_name: Nightly 12:41:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:41:21 INFO - mozversion application_name: Firefox 12:41:21 INFO - mozversion application_remotingname: firefox 12:41:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:41:21 INFO - mozversion application_vendor: Mozilla 12:41:21 INFO - mozversion application_version: 51.0a1 12:41:21 INFO - mozversion platform_buildid: 20160825083014 12:41:21 INFO - mozversion platform_changeset: c0c2f6077694008794c06900943654db0143c2b9 12:41:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:41:21 INFO - mozversion platform_version: 51.0a1 12:41:21 INFO - using testdate: 1472154081 12:41:21 INFO - actual date: 1472154081 12:41:21 INFO - starting webserver on 'localhost:60964' 12:41:21 INFO - SUITE-START | Running 2 tests 12:41:21 INFO - TEST-START | dromaeo_css 12:41:21 INFO - operating with platform_type : linux_ 12:41:21 INFO - Initialising browser for dromaeo_css test... 12:41:21 INFO - TEST-INFO | started process 15383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrBrcy/profile http://localhost:60964/getInfo.html) 12:41:26 INFO - PROCESS | 15383 | __metrics Screen width/height:1600/1200 12:41:26 INFO - PROCESS | 15383 | colorDepth:24 12:41:26 INFO - PROCESS | 15383 | Browser inner width/height: 1024/697 12:41:26 INFO - PROCESS | 15383 | __metrics 12:41:26 ERROR - PROCESS | 15383 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:41:27 INFO - TEST-INFO | 15383: exit 0 12:41:27 INFO - Browser initialized. 12:41:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:41:27 INFO - TEST-INFO | started process 15508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrBrcy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:39 INFO - PROCESS | 15508 | RSS: Main: 190279680 12:41:39 INFO - PROCESS | 15508 | 12:42:29 INFO - PROCESS | 15508 | 1472154149396 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:44:39 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60964/tests/dromaeo/cssquery-ext.html) 12:44:40 INFO - PROCESS | 15508 | RSS: Main: 211542016 12:44:40 INFO - PROCESS | 15508 | 12:47:42 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-ext.html (next: http://localhost:60964/tests/dromaeo/cssquery-jquery.html) 12:47:43 INFO - PROCESS | 15508 | RSS: Main: 205152256 12:47:43 INFO - PROCESS | 15508 | 12:50:45 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60964/tests/dromaeo/cssquery-mootools.html) 12:50:45 INFO - PROCESS | 15508 | RSS: Main: 202735616 12:50:45 INFO - PROCESS | 15508 | 12:53:47 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60964/tests/dromaeo/cssquery-prototype.html) 12:53:48 INFO - PROCESS | 15508 | RSS: Main: 195899392 12:53:48 INFO - PROCESS | 15508 | 12:56:50 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60964/tests/dromaeo/cssquery-yui.html) 12:56:51 INFO - PROCESS | 15508 | RSS: Main: 198807552 12:56:51 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | Cycle 1(1): loaded http://localhost:60964/tests/dromaeo/cssquery-yui.html (next: http://localhost:60964/tests/dromaeo/cssquery-dojo.html) 12:59:54 INFO - PROCESS | 15508 | RSS: Main: 199626752 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | __start_tp_report 12:59:54 INFO - PROCESS | 15508 | _x_x_mozilla_page_load 12:59:54 INFO - PROCESS | 15508 | _x_x_mozilla_page_load_details 12:59:54 INFO - PROCESS | 15508 | |i|pagename|runs| 12:59:54 INFO - PROCESS | 15508 | |0;dojo.html;3123.6251649802025;3136.46680064389;3153.526970954358;3170.3500782339615;3191.1543440988125;5381.4349493303225;5471.78112875485;5498;5534.114541673333;5577.832665020051;5430.321209848769;5444.700541470217;5485.917711234325;5486.533644640201;5546.389897111315;4955.776990035457;5005.974970125144;5042.84871453857;5058.0895438821;5134.845954621367;4666.650001249903;5052.646314757969;5106.821261255856;5115.563013895281;5174.016936782018;4784.019276048419;4912.336834527365;4935.161022626162;4996.650234483587;4997.900041999158;4994.275830004629;5032.993401319751;5046.974765126188;5048.697078175322;5077.974610126926;4949.727764972925;4986.40163180417;4997.400311962551;5012.147934851084;5057.291979122889;5185.196294574309;5380.192971054334;5448.83653490396;5453.372862120827;5518.310211223597;5834.737436815353;5848.210491583624;5849.415058494159;5850.3564607893095;5877.794277200277;5860.120981852713;5882.411758824126;5886.646801191942;5888.116782482662;5895.056790913433;5345.144776835727;5403.243545903577;5437.401885792559;5441.020616289106;5448.046591846411;5914.408559144051;5968.432998865101;5995.250593675791;6005.918934591816;6062.727177277033;5677.602567820213;5741.138829175574;5742.368339482654;5755.625884317506;5757.85605359861;5657.462541058593;5660.235868157746;5702;5717.399673034354;5828.708564571839;5690.260266165372;5790.536757059425;5798.072308430631;5829;5883.17635531026;5756.481916627524;5765.769369225268;5774.566907481955;5780.913286300709;5796.1595568642315;4417.1386579616665;4455.554444555519;4483.173136874412;4492.618127459203;4494.662900282492;3961.8811435656976;4005.4792876926394;4069.8575549856205;4094.0992981544014;4108.157827645326;5600.831975040755;5631.915521267184;5649.802256920988;5651.463111004448;5657.632253903483;5618.69097199658;5808.5353171747;5933.851653708692;5935.495482884004;5973.641581505123;5554.666719996732;5606.299212598426;5607.074832652648;5634.915476267859;5671.801486948019;5029.84910452687;5029.874253143701;5034.0938631046765;5040.218766091261;5100.846974590768;5883.117532370179;5901.734421950937;6038.33578306386;6043.09353596964;6046.486048685823;5790.913136302875;5856.092305692625;5862.530997520274;5874.17761513397;5882.647041177372;5959.433853783884;5967.850803729768;5982.700864956648;5990.251218597501;5996;5482.506574408322;5538.889222215614;5731.8853622928145;5756.625819321731;5759.51044161251;5801.332846722681;5839.15332276809;5867.9413205867395;5896.321922978912;5920.851978700567;5710.314762228559;5725.227094342211;5727.7422515986045;5750.856228594319;5781.248437703071;5435.374931882884;5696.686682232517;5699.4300569944335;5715.485606295453;5717.828465146053;5600.355959064596;5629.352624448241;5671.291088613923;5693.032184528557;5760.683162426107;5653.434656534314;5729.054705973468;5736.827895163152;5749.712514374348;5754.021816291157;5490.313710786152;5566.693831839288;5580.190872323572;5595.04884169684;5624.128260119688 12:59:54 INFO - PROCESS | 15508 | |1;ext.html;569.1803802524364;580.1442871764145;586.6509426891;591.2077815726925;614.1555361378105;38085.428718569245;42843.57156428435;42919.35620965688;43015;43085.138297234036;43135;43244.35133472992;43579.56420435795;43660.56339436604;43749;8788.95605521973;8893.599788009522;8904.910950890506;8931.732048038537;8938.106189381042;8830.20528152466;8848.823023539526;8864.601092950832;8899.199072083511;8959.955200223989;9007.414518056337;9029.367944243906;9044.3668943174;9059.637614495445;9066.093390660948;8908.910910890905;8940.508272045035;8993;9013.729588112366;9028.638854445815;8736.213740763298;8791.340649451316;8794.03265640779;8808.119188081204;8825.161609647073;40146.59853401458;40577.59422405768;40657.59342406568;40844.591554084676;40875;3617.149969757105;3913.5695073541888;3977.2244412339605;4193.811278492444;4376.102898905717;32374.514382284284;33299.500507492405;33426.83286583576;33752;34214.31571368559;4227.87316380509;4352.565793730974;4417.730879149406;4444.777761111932;4451.532589078165;326028;332628;333266;333289;335338.99999999756;56605.716971415706;56790;57190.71404643033;57205.14192287119;57382;58176.418235817946;58328;58535.5366115842;58740.412595874346;58774.41225587775;14746.11523308605;15436.996595221499;15461.9226903867;15836;15847.841521584636;11539.88460115388;11769.117316201147;11785.705357365963;11827.172097953233;11830.585929492427;18496.352627658238;18716.53208669767;18774.436766897015;18895.43313700591;18945.147468363957;7111.537750046334;7148.892766608505;7389.113306403266;7418.925810741824;7443.665035073434;972.7373609125497;1127.6617014895662;1137.2607804926863;1152.7348709796793;1160.3212120909363;32661;32959.67040329566;33003.66996330054;33432.33135337328;33535.49696754551;1098.357460885391;1124.6401151631399;1133.9603113890973;1148.242160174281;1171.6250799744;15573.688526229638;17484;17725.645487090187;17987.73018404725;18830;516729;517933;518590;519472;520923;60348.39651603516;60934;61179.38820611737;61410.69294653588;61433.38566614366;1306.4121145484569;1349.311850956;1359.1097830920762;1368.7946807979083;1378.2832926877968;30866.270817089364;33680.15799605029;33857;33974.660253398135;34327.485087724206;52216;52787.20819187792;52992.73503632457;53176.46823531715;53261.201081983025;492663;494256;498245;500704;504581;27754.44491110207;28162.436751265268;28363;28682.56976145318;28717.71282287234;48083.27875081806;48992.5100748988;49369.506304937924;49638.75180624218;49868.750656246484;40884.79557602193;41542.37686434646;41808.1468594391;42179;43352;40910.38634420546;41202.38196426996;41889.58110418857;41950.58049419467;42041.85066987942;35142.82428587841;41271.7936410316;41538.792306038275;41621.37567936423;41812.372814408416;32416.675833241366;37756.867293981224;38342.80828595839;38848;38882;28998.27504312409;29028;29187.70812291935;29322.120336389944;29337.266568335963 12:59:54 INFO - PROCESS | 15508 | |2;jquery.html;378.5438546551406;381.7652143931483;396.3104198694272;401.14756143195706;413.2932685108464;16539.25573349199;18091;20012.799872001277;20111.296104636323;20189.697154542657;11302.943485282583;11335.603253886116;11386;11649;11655.533778648844;4995.250712393134;5171.276021357013;5211.322528071364;5213.895722085556;5227.843164705065;5191.818286359978;5233.319668443116;5240.056789777838;5392.514673679368;5597.160425936101;5684.772609095631;5685.658860468365;5698.43015698431;5701.515371193454;5702.914456283159;5496.890062198733;5651.2935883014625;5671.6880571568545;5705.771769129251;5715.114157305583;5513.917291240635;5534.557235421156;5536;5536.750846211889;5538;12744.107912446132;12834.871651283462;13025.218486890817;13045;16555.586110347336;2191.747948985871;2359.362971997551;2374.798142157919;2415.830891837572;2560.295918622375;9261.583228754722;9635.518224088768;9823.557939892722;10114.848277275847;10222.182225421948;1889.6031833315021;1891.9716204256947;1924.8267655910895;1948.4544327588155;1959.4905324615702;76668;85376.57311713402;85504.57247713722;85697.57151214204;86561.13438865593;9075.183233509017;9534.95232523833;9702.369345992487;10414.375137491776;10679.771826240081;12438.564650237198;12465.688357791129;12470.875291246972;12539.373031348396;12557.74884502323;7508.211637777955;7584.5070070445245;7587.544747315179;7755.728549500854;7779.57212353326;7490.775276741707;7543.585102819397;7776.416768742254;7808.2191780822595;7829.765107046797;3762.6049264827348;3853.421986702017;3906.5312162540677;3972;3980.4029395590314;1837.5314294854993;1891.7635295588052;1900.5248687828043;1954.7458830351964;1968.1143485431612;910.39003867409;920.1028996728137;946.4936259101348;966.21253678252;980.6910823090703;19086.80913190878;20923;21051.68422473664;21097.472563185736;21197.682034769492;948.8671585977969;976.4922240435076;996.496769131584;1003.7691330993912;1004.5027711282962;9956.203503719686;11048.563686720674;11313.943430282796;11422.657320280405;11453.828192577119;542094;543056.3956947138;545048;552186;557682;86465;90153;96695;98312.50843745735;102808;895.9641614335353;975.2393133355994;1007.9496025198711;1039.1478987230398;1050.2438244463974;17947.5513112168;18238.452846414628;18967.810321896606;19163.808361916203;19193.424197274104;42245.788771055944;44003.559964401225;44381.11237775291;44400;44509.88725281894;60999.695001524706;61283.08075378962;61396.38603613907;61848.381516184265;62553.37446625657;8086.87869681967;8218.712345068134;8226.259636632733;8425.2838508725;8637.136286371313;11892.76214475723;13435.12671676338;13565.321733913068;14064.367103480572;14164.220967846455;11338.886611134112;11379.829302560303;11456.140789440991;11565.884341156818;11787.646370608896;11332.150088743212;11484.023857972166;11498.367589782642;11757;11965.700857478632;11506.676732175907;11570;11597.246178998337;11722.94138529302;11935.104867134825;7398.630068496446;7421.257874212535;7610.581418022062;7681.7695469136015;8905.020447750872;10030.398176109165;10596.788064238826;10624.681259562225;10842.620508282173;10985.176111791807 12:59:54 INFO - PROCESS | 15508 | |3;mootools.html;1310.8689131086892;1424.7008128293057;1460.6348412896775;1746.2054765081882;1752.6144248265377;7773.144954055049;8331.250187483125;8744.169303916135;9417.199538039258;9417.670381536647;8354.456960297577;8590.312774978003;8600.096989816057;8629.309655227582;8657.26413254874;2318.547883162784;2340.4382948092507;2347.7652234776556;2349.5770761262966;2352.1179557665873;2277.1574517428576;2295.6900818389554;2332.918347857825;2363.669086327907;2367.8934447949796;2286.9313920582326;2317.478567322356;2327.7555856635063;2332.055517515409;2343.5664402085586;2189.102467988133;2242.1031587365023;2249.538844536882;2251.4371407148215;2253.301476542277;2197.7362716474127;2199.274239500961;2203.272919936417;2207.194374053475;2209.7569267380577;8660.8700869487;9093.363464557484;9186.494742789144;9245.844269466317;9257.537123143817;5295.152775555893;5439.129739241742;5440.972795136038;5448.182772584105;5453.754581043862;3329.6004479462376;3342.9498557521656;3391.3895498810202;3467.1505481157023;3474.2183008823067;1164.3770582738193;1170.104869774623;1194.4684615346175;1195.8923696867237;1198.9040876729841;12504.437300321417;12542.81185782214;12717.173383730027;12731.172473789175;12747.043971702253;4468.240399132155;4707.741074240881;4731.7634118293945;4792.712437253706;4804.42346918372;10611.469426528643;10657.147428205724;10661.253712240225;10662.466876656292;10704.518296676668;5395.676259424368;5414.756335964891;5467.753951072212;5468.7539060742365;5471;4291.249031419489;4771.689840160448;4856.053069651454;4936.407631084293;4955.132851751001;3977.6420122188565;4037.535683396447;4048.332025215865;4070.206309769626;4177.310743727251;1200.7898617742035;1208.7219939413983;1221.8533775946944;1225.3444407242082;1226.0314351662266;908.9592416682993;912.7307444303947;943.7027336389016;944.7779771753633;948.4972964328916;5641.774329026875;5734.856628584319;5885.911711324334;5935.347111817697;6112;460.8456167183964;463.0923390155266;464.69562436604076;465.51732731251076;470.7222738584252;4000.399940009022;4016;4039.2527382434346;4040.3535434330365;4083.9387409188885;10672.146228301717;11314.603988860516;11474.426278686033;11516.827247591293;11580.47887845049;11248;11257.549698012152;11342.773144537063;11365.431728413547;11408.201425900108;8312.709055183039;8505.82988340242;8518.572206920997;8534.74395768128;8543.743687689379;5884.764609415746;5887.4406931341455;5963.642181469126;5969.791057312973;5985.162077309094;10071.949640251752;10314.638987635397;10370.222233332379;10393.63622273247;10483.842742358718;10545.261831671709;10712.839307410552;10750.569977200825;10782.784344313226;10859.674209773719;7129.429645628441;7924.960375198318;8001.439899207;8205.507669539847;8495.787605309917;8630.870536942077;8957.283417326467;9010.954945225232;9014.053524379846;9036.954815225881;7960.4825686330205;7996.60016999136;8053.275205231557;8111;8168.346532277523;7211.4230861532005;7745.457817952689;7748.4576079676135;7775.416843736629;7867.567283799446;6978.441724662116;7118.039064726196;7127.607981561064;7133.500654954103;7144.3570078693165;4953.801847926043;4994.101061808909;5017.24741288795;5041.924371134509;5154.664946778447;4845.442774081026;4975.950240497548;5120.667156634807;5185.637005409585;5239.790408383622 12:59:54 INFO - PROCESS | 15508 | |4;prototype.html;327.5970556215853;336.939350916835;339.4263694356539;341.4860634744709;345.7700629081661;5321.388040375358;5390.921815636869;5550.833474995747;5631.183478395636;5636.323641163056;5321.122014867542;5417.783288668458;5420.214068959998;5420.457954204578;5454.818072770893;4290.935635965463;4293.162833247518;4296.720713153651;4339.609435150835;4340.08858139791;4216.451861258032;4280.614744672979;4286.292761694317;4321.373400856874;4334.956650433503;4250.319948808191;4250.766207858566;4256.59562341577;4259.552746961571;4268.594483524076;4208.705390622657;4219.3249080147025;4243.236217480852;4254.851080212208;4257.595528424795;3679.6872265857432;3786.6970642348547;3824.961750382516;3835.827387767557;3847;5320.441353657849;5322.733863306819;5341.439148889388;5345.946540534584;5369.194620806871;4868.756562171912;4883.682560633548;4894.804207831682;4898.595476144082;4904.302633551532;5526.706416837008;5688.573356998241;5711.400302968212;5768.125359258258;5768.394318596529;4058.817353219112;4090.8159132838796;4106.240345536085;4107.644477322477;4121.567235440296;6001.899335232677;6030.6080104793045;6034.396560343975;6050.515958723292;6096.939030609726;4159.251334759772;4217.304144816132;4293.677974151951;4319.97840010798;4320.503142138631;4245.448091748053;4263.168682107022;4286.249906266391;4294.26997410441;4304.504981927118;4864.80540778372;4900.313956046157;4906.386701662293;4930.11257973561;4942.986687729079;5594.552435805126;5743.741531631086;5814.273215848019;5827.271591051119;5868.2664666916635;1463.3829618271868;1471.8004826066722;1476.5201309574431;1479.2825479642365;1485.93755464841;904.7195369435497;945.9736186237872;948.3693343926212;959.5154447004218;962.8542034978353;4848.975755121272;4860.659753817199;4879.56083952446;4905.509449055137;4910.76560165124;5159.303494028333;5159.664621799571;5168.328117344721;5189.506996835295;5233.71214583194;4663.160631086437;4897.436794768576;4902.48523904992;4911.852644420673;4919.77860996256;2728.9493544984925;2733.671959364889;2736.9726302736717;2751.4222013377016;2759.4894944435346;5331.946680533145;5342.904704535561;5379.54273886724;5384.838454846361;5388.892222155535;4941.430456162847;5251.264822924793;5254.605904557174;5287.70917599528;5311.28297679816;5350.732463376816;5354.491323324278;5368.946310536923;5370.462953704677;5377.677339359651;5204.193350030751;5222.399424066281;5222.425533191422;5226.895462090661;5258.579313654975;4932.457429682804;4976.527229913152;5052.242163675478;5071.377159308986;5098.362704661918;5258.447862974333;5269.47185316254;5292.232626269092;5311.601629877698;5335.413104558573;3891.5135608048995;3971.126352202511;4121.5466298706515;4159.10579225468;4163.354680024601;5903.586748927534;5908.527317814651;5918.733656985532;5924.200232968494;5934.376890426443;5590.5527557796095;5783.595148339576;5793.739281732248;5811.593188476935;5815.563832712479;5727.570432217517;5755.251817263729;5763.567732420001;5782.479576838105;5784.681842498703;5770.653760774199;5787.8553036174435;5791.9131213031;5811.680357580373;5824.912626310524;5564.582656300875;5809;5852.882942341214;5853;5853.707314634336;5713.171590119493;5721.513671337816;5726.398728133486;5727.713614319351;5747.683877386617 12:59:54 INFO - PROCESS | 15508 | |5;yui.html;688.6591137386994;714.2964180282424;719.2591630620461;773.2190487607517;780.7930898311948;13584.456621735131;14505.347259373328;14558.126512409237;14561.92719036406;14582.70834583309;14001.859981400183;14024.789628155586;14035;14055.859441405582;14093.365798539066;659.4065341192917;755.879059350504;767.9500832445887;773.443120952913;788.2866006264311;796.3111908199423;798.6845196147518;799.6161842315692;800.9479383840031;801.2148094867034;836.5440834745078;841.7138173021171;842.9114942930996;844;850.6597361055566;841.8526757817388;841.9242268195861;847.5380917400032;848.3594885861166;849.426637020009;614.9169862068608;614.929283132441;615.5414216408759;616.626940700874;617.3579477343558;13239.470421183141;13265.204087754766;13284.601461956157;13293.86706132936;13314.201147931059;14438.855611443856;14498.927505362512;14531.491397801132;14554.636134096732;14700.970932034761;12391.256524608552;12556.246625202426;12605.243685378906;12670.303133327756;13506;3813.8474461021524;3844.75009124406;3926.175503144343;3992;3995.440638310639;84985.57507212424;87032.12967870303;87851;87935.56032219798;88012;10540.156787456985;10545.736356591147;11017.614383496539;11100.61147859821;11598.246114002563;20000;20049.298274560322;20119;20194.192232310837;20233.89883050605;7904.683812647545;7907.5650839203245;8024.759257222293;8134.75595732129;8412.369072319478;4786.473487916326;4812.831550895702;4891.315215869781;4954.331165292711;5050.04049230645;3098.148009297461;3185.665505121975;3208.326251487214;3219.8390080495883;3220.1627576829724;573.1345668041205;578.9015867302569;596.1207219351422;596.8895754285385;601.8284788835161;657.8618490117034;661.7882277671196;667.3293340193075;667.3493343989571;671.6104659297694;8352.53600187946;9187.63249470027;9285.117913798178;9411.294152938557;9456.14894659484;511.9513646203605;577.9971100144472;641.643887642363;659.3176062775004;660.1220376898713;4248.87253382399;4282.122164956177;4422.933655995163;4460.442444694413;4460.598546130864;74941.62529187319;75574.24425755782;115115;117871;133660;66193.66903165453;96853.51573242088;104473;105558.47220763846;106333;77706.22293777103;79481.60259198667;80042;88262.55868720615;92764.53617731867;9731.9026809731;10371.94814025925;10478.790424191626;10577.788444231226;10651.786964260826;50173;52223.47776522186;52902;53245.46754532405;53804;69228.6538567304;69298.30701692919;70243.29756702571;74177.66200521098;79731;14202.147871127765;14442.783358249844;14832.18422986746;14870.776938345716;15157.242137893281;15137.924310378377;15241.237938103272;16266;16313.429029983894;16336.346546138022;13724.794128088286;14265.64335891611;15150.24248787534;15160.355650094982;15239.161846098572;13424.93287533556;13672.93163534176;13888;14086.506972255922;14568.635784105481;14907;14912.403503860158;15124.941254112107;15141.167235802137;15466.5360039199;10677.709723014481;10922.344659320466;11017.779644407226;11139.83290250663;11214.15893807984;11718.355490448108;12235.755284894074;12323.815142772686;12434.937825310815;12513.812292815797 12:59:54 INFO - PROCESS | 15508 | __end_tp_report 12:59:54 INFO - PROCESS | 15508 | __start_cc_report 12:59:54 INFO - PROCESS | 15508 | _x_x_mozilla_cycle_collect,354 12:59:54 INFO - PROCESS | 15508 | __end_cc_report 12:59:54 INFO - PROCESS | 15508 | __startTimestamp1472155194750__endTimestamp 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | ------- Summary: start ------- 12:59:54 INFO - PROCESS | 15508 | Number of tests: 6 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#0] dojo.html Cycles:165 Average:5426.54 Median:5649.80 stddev:603.15 (10.7%) stddev-sans-first:577.31 12:59:54 INFO - PROCESS | 15508 | Values: 3123.6 3136.5 3153.5 3170.4 3191.2 5381.4 5471.8 5498.0 5534.1 5577.8 5430.3 5444.7 5485.9 5486.5 5546.4 4955.8 5006.0 5042.8 5058.1 5134.8 4666.7 5052.6 5106.8 5115.6 5174.0 4784.0 4912.3 4935.2 4996.7 4997.9 4994.3 5033.0 5047.0 5048.7 5078.0 4949.7 4986.4 4997.4 5012.1 5057.3 5185.2 5380.2 5448.8 5453.4 5518.3 5834.7 5848.2 5849.4 5850.4 5877.8 5860.1 5882.4 5886.6 5888.1 5895.1 5345.1 5403.2 5437.4 5441.0 5448.0 5914.4 5968.4 5995.3 6005.9 6062.7 5677.6 5741.1 5742.4 5755.6 5757.9 5657.5 5660.2 5702.0 5717.4 5828.7 5690.3 5790.5 5798.1 5829.0 5883.2 5756.5 5765.8 5774.6 5780.9 5796.2 4417.1 4455.6 4483.2 4492.6 4494.7 3961.9 4005.5 4069.9 4094.1 4108.2 5600.8 5631.9 5649.8 5651.5 5657.6 5618.7 5808.5 5933.9 5935.5 5973.6 5554.7 5606.3 5607.1 5634.9 5671.8 5029.8 5029.9 5034.1 5040.2 5100.8 5883.1 5901.7 6038.3 6043.1 6046.5 5790.9 5856.1 5862.5 5874.2 5882.6 5959.4 5967.9 5982.7 5990.3 5996.0 5482.5 5538.9 5731.9 5756.6 5759.5 5801.3 5839.2 5867.9 5896.3 5920.9 5710.3 5725.2 5727.7 5750.9 5781.2 5435.4 5696.7 5699.4 5715.5 5717.8 5600.4 5629.4 5671.3 5693.0 5760.7 5653.4 5729.1 5736.8 5749.7 5754.0 5490.3 5566.7 5580.2 5595.0 5624.1 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#1] ext.html Cycles:180 Average:61114.61 Median:41996.22 stddev:121328.17 (288.9%) stddev-sans-first:121583.37 12:59:54 INFO - PROCESS | 15508 | Values: 569.2 580.1 586.7 591.2 614.2 38085.4 42843.6 42919.4 43015.0 43085.1 43135.0 43244.4 43579.6 43660.6 43749.0 8789.0 8893.6 8904.9 8931.7 8938.1 8830.2 8848.8 8864.6 8899.2 8960.0 9007.4 9029.4 9044.4 9059.6 9066.1 8908.9 8940.5 8993.0 9013.7 9028.6 8736.2 8791.3 8794.0 8808.1 8825.2 40146.6 40577.6 40657.6 40844.6 40875.0 3617.1 3913.6 3977.2 4193.8 4376.1 32374.5 33299.5 33426.8 33752.0 34214.3 4227.9 4352.6 4417.7 4444.8 4451.5 326028.0 332628.0 333266.0 333289.0 335339.0 56605.7 56790.0 57190.7 57205.1 57382.0 58176.4 58328.0 58535.5 58740.4 58774.4 14746.1 15437.0 15461.9 15836.0 15847.8 11539.9 11769.1 11785.7 11827.2 11830.6 18496.4 18716.5 18774.4 18895.4 18945.1 7111.5 7148.9 7389.1 7418.9 7443.7 972.7 1127.7 1137.3 1152.7 1160.3 32661.0 32959.7 33003.7 33432.3 33535.5 1098.4 1124.6 1134.0 1148.2 1171.6 15573.7 17484.0 17725.6 17987.7 18830.0 516729.0 517933.0 518590.0 519472.0 520923.0 60348.4 60934.0 61179.4 61410.7 61433.4 1306.4 1349.3 1359.1 1368.8 1378.3 30866.3 33680.2 33857.0 33974.7 34327.5 52216.0 52787.2 52992.7 53176.5 53261.2 492663.0 494256.0 498245.0 500704.0 504581.0 27754.4 28162.4 28363.0 28682.6 28717.7 48083.3 48992.5 49369.5 49638.8 49868.8 40884.8 41542.4 41808.1 42179.0 43352.0 40910.4 41202.4 41889.6 41950.6 42041.9 35142.8 41271.8 41538.8 41621.4 41812.4 32416.7 37756.9 38342.8 38848.0 38882.0 28998.3 29028.0 29187.7 29322.1 29337.3 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#2] jquery.html Cycles:180 Average:30282.04 Median:3976.20 stddev:90348.16 (2272.2%) stddev-sans-first:90573.71 12:59:54 INFO - PROCESS | 15508 | Values: 378.5 381.8 396.3 401.1 413.3 16539.3 18091.0 20012.8 20111.3 20189.7 11302.9 11335.6 11386.0 11649.0 11655.5 4995.3 5171.3 5211.3 5213.9 5227.8 5191.8 5233.3 5240.1 5392.5 5597.2 5684.8 5685.7 5698.4 5701.5 5702.9 5496.9 5651.3 5671.7 5705.8 5715.1 5513.9 5534.6 5536.0 5536.8 5538.0 12744.1 12834.9 13025.2 13045.0 16555.6 2191.7 2359.4 2374.8 2415.8 2560.3 9261.6 9635.5 9823.6 10114.8 10222.2 1889.6 1892.0 1924.8 1948.5 1959.5 76668.0 85376.6 85504.6 85697.6 86561.1 9075.2 9535.0 9702.4 10414.4 10679.8 12438.6 12465.7 12470.9 12539.4 12557.7 7508.2 7584.5 7587.5 7755.7 7779.6 7490.8 7543.6 7776.4 7808.2 7829.8 3762.6 3853.4 3906.5 3972.0 3980.4 1837.5 1891.8 1900.5 1954.7 1968.1 910.4 920.1 946.5 966.2 980.7 19086.8 20923.0 21051.7 21097.5 21197.7 948.9 976.5 996.5 1003.8 1004.5 9956.2 11048.6 11313.9 11422.7 11453.8 542094.0 543056.4 545048.0 552186.0 557682.0 86465.0 90153.0 96695.0 98312.5 102808.0 896.0 975.2 1007.9 1039.1 1050.2 17947.6 18238.5 18967.8 19163.8 19193.4 42245.8 44003.6 44381.1 44400.0 44509.9 60999.7 61283.1 61396.4 61848.4 62553.4 8086.9 8218.7 8226.3 8425.3 8637.1 11892.8 13435.1 13565.3 14064.4 14164.2 11338.9 11379.8 11456.1 11565.9 11787.6 11332.2 11484.0 11498.4 11757.0 11965.7 11506.7 11570.0 11597.2 11722.9 11935.1 7398.6 7421.3 7610.6 7681.8 8905.0 10030.4 10596.8 10624.7 10842.6 10985.2 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#3] mootools.html Cycles:180 Average:5891.14 Median:468.12 stddev:3449.46 (736.9%) stddev-sans-first:3441.97 12:59:54 INFO - PROCESS | 15508 | Values: 1310.9 1424.7 1460.6 1746.2 1752.6 7773.1 8331.3 8744.2 9417.2 9417.7 8354.5 8590.3 8600.1 8629.3 8657.3 2318.5 2340.4 2347.8 2349.6 2352.1 2277.2 2295.7 2332.9 2363.7 2367.9 2286.9 2317.5 2327.8 2332.1 2343.6 2189.1 2242.1 2249.5 2251.4 2253.3 2197.7 2199.3 2203.3 2207.2 2209.8 8660.9 9093.4 9186.5 9245.8 9257.5 5295.2 5439.1 5441.0 5448.2 5453.8 3329.6 3342.9 3391.4 3467.2 3474.2 1164.4 1170.1 1194.5 1195.9 1198.9 12504.4 12542.8 12717.2 12731.2 12747.0 4468.2 4707.7 4731.8 4792.7 4804.4 10611.5 10657.1 10661.3 10662.5 10704.5 5395.7 5414.8 5467.8 5468.8 5471.0 4291.2 4771.7 4856.1 4936.4 4955.1 3977.6 4037.5 4048.3 4070.2 4177.3 1200.8 1208.7 1221.9 1225.3 1226.0 909.0 912.7 943.7 944.8 948.5 5641.8 5734.9 5885.9 5935.3 6112.0 460.8 463.1 464.7 465.5 470.7 4000.4 4016.0 4039.3 4040.4 4083.9 10672.1 11314.6 11474.4 11516.8 11580.5 11248.0 11257.5 11342.8 11365.4 11408.2 8312.7 8505.8 8518.6 8534.7 8543.7 5884.8 5887.4 5963.6 5969.8 5985.2 10071.9 10314.6 10370.2 10393.6 10483.8 10545.3 10712.8 10750.6 10782.8 10859.7 7129.4 7925.0 8001.4 8205.5 8495.8 8630.9 8957.3 9011.0 9014.1 9037.0 7960.5 7996.6 8053.3 8111.0 8168.3 7211.4 7745.5 7748.5 7775.4 7867.6 6978.4 7118.0 7127.6 7133.5 7144.4 4953.8 4994.1 5017.2 5041.9 5154.7 4845.4 4976.0 5120.7 5185.6 5239.8 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#4] prototype.html Cycles:180 Average:4661.22 Median:5213.30 stddev:1347.80 (25.9%) stddev-sans-first:1311.74 12:59:54 INFO - PROCESS | 15508 | Values: 327.6 336.9 339.4 341.5 345.8 5321.4 5390.9 5550.8 5631.2 5636.3 5321.1 5417.8 5420.2 5420.5 5454.8 4290.9 4293.2 4296.7 4339.6 4340.1 4216.5 4280.6 4286.3 4321.4 4335.0 4250.3 4250.8 4256.6 4259.6 4268.6 4208.7 4219.3 4243.2 4254.9 4257.6 3679.7 3786.7 3825.0 3835.8 3847.0 5320.4 5322.7 5341.4 5345.9 5369.2 4868.8 4883.7 4894.8 4898.6 4904.3 5526.7 5688.6 5711.4 5768.1 5768.4 4058.8 4090.8 4106.2 4107.6 4121.6 6001.9 6030.6 6034.4 6050.5 6096.9 4159.3 4217.3 4293.7 4320.0 4320.5 4245.4 4263.2 4286.2 4294.3 4304.5 4864.8 4900.3 4906.4 4930.1 4943.0 5594.6 5743.7 5814.3 5827.3 5868.3 1463.4 1471.8 1476.5 1479.3 1485.9 904.7 946.0 948.4 959.5 962.9 4849.0 4860.7 4879.6 4905.5 4910.8 5159.3 5159.7 5168.3 5189.5 5233.7 4663.2 4897.4 4902.5 4911.9 4919.8 2728.9 2733.7 2737.0 2751.4 2759.5 5331.9 5342.9 5379.5 5384.8 5388.9 4941.4 5251.3 5254.6 5287.7 5311.3 5350.7 5354.5 5368.9 5370.5 5377.7 5204.2 5222.4 5222.4 5226.9 5258.6 4932.5 4976.5 5052.2 5071.4 5098.4 5258.4 5269.5 5292.2 5311.6 5335.4 3891.5 3971.1 4121.5 4159.1 4163.4 5903.6 5908.5 5918.7 5924.2 5934.4 5590.6 5783.6 5793.7 5811.6 5815.6 5727.6 5755.3 5763.6 5782.5 5784.7 5770.7 5787.9 5791.9 5811.7 5824.9 5564.6 5809.0 5852.9 5853.0 5853.7 5713.2 5721.5 5726.4 5727.7 5747.7 12:59:54 INFO - PROCESS | 15508 | 12:59:54 INFO - PROCESS | 15508 | [#5] yui.html Cycles:180 Average:20642.71 Median:4265.50 stddev:29522.31 (692.1%) stddev-sans-first:29567.11 12:59:54 INFO - PROCESS | 15508 | Values: 688.7 714.3 719.3 773.2 780.8 13584.5 14505.3 14558.1 14561.9 14582.7 14001.9 14024.8 14035.0 14055.9 14093.4 659.4 755.9 768.0 773.4 788.3 796.3 798.7 799.6 800.9 801.2 836.5 841.7 842.9 844.0 850.7 841.9 841.9 847.5 848.4 849.4 614.9 614.9 615.5 616.6 617.4 13239.5 13265.2 13284.6 13293.9 13314.2 14438.9 14498.9 14531.5 14554.6 14701.0 12391.3 12556.2 12605.2 12670.3 13506.0 3813.8 3844.8 3926.2 3992.0 3995.4 84985.6 87032.1 87851.0 87935.6 88012.0 10540.2 10545.7 11017.6 11100.6 11598.2 20000.0 20049.3 20119.0 20194.2 20233.9 7904.7 7907.6 8024.8 8134.8 8412.4 4786.5 4812.8 4891.3 4954.3 5050.0 3098.1 3185.7 3208.3 3219.8 3220.2 573.1 578.9 596.1 596.9 601.8 657.9 661.8 667.3 667.3 671.6 8352.5 9187.6 9285.1 9411.3 9456.1 512.0 578.0 641.6 659.3 660.1 4248.9 4282.1 4422.9 4460.4 4460.6 74941.6 75574.2 115115.0 117871.0 133660.0 66193.7 96853.5 104473.0 105558.5 106333.0 77706.2 79481.6 80042.0 88262.6 92764.5 9731.9 10371.9 10478.8 10577.8 10651.8 50173.0 52223.5 52902.0 53245.5 53804.0 69228.7 69298.3 70243.3 74177.7 79731.0 14202.1 14442.8 14832.2 14870.8 15157.2 15137.9 15241.2 16266.0 16313.4 16336.3 13724.8 14265.6 15150.2 15160.4 15239.2 13424.9 13672.9 13888.0 14086.5 14568.6 14907.0 14912.4 15124.9 15141.2 15466.5 10677.7 10922.3 11017.8 11139.8 11214.2 11718.4 12235.8 12323.8 12434.9 12513.8 12:59:54 INFO - PROCESS | 15508 | -------- Summary: end -------- 12:59:54 INFO - PROCESS | 15508 | 12:59:55 INFO - TEST-INFO | 15508: exit 0 12:59:55 INFO - TEST-OK | dromaeo_css | took 1114494ms 12:59:55 INFO - TEST-START | kraken 12:59:55 INFO - operating with platform_type : linux_ 12:59:55 INFO - Initialising browser for kraken test... 12:59:55 INFO - TEST-INFO | started process 15867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihMV0F/profile http://localhost:60964/getInfo.html) 13:00:00 INFO - PROCESS | 15867 | __metrics Screen width/height:1600/1200 13:00:00 INFO - PROCESS | 15867 | colorDepth:24 13:00:00 INFO - PROCESS | 15867 | Browser inner width/height: 1024/697 13:00:00 INFO - PROCESS | 15867 | __metrics 13:00:00 ERROR - PROCESS | 15867 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:00:01 INFO - TEST-INFO | 15867: exit 0 13:00:01 INFO - Browser initialized. 13:00:01 INFO - Running cycle 1/1 for kraken test... 13:00:01 INFO - TEST-INFO | started process 15986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihMV0F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:13 INFO - PROCESS | 15986 | RSS: Main: 190263296 13:00:13 INFO - PROCESS | 15986 | 13:00:16 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60964/tests/kraken/driver.html?testName=audio-beat-detection) 13:00:17 INFO - PROCESS | 15986 | RSS: Main: 203456512 13:00:17 INFO - PROCESS | 15986 | 13:00:20 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60964/tests/kraken/driver.html?testName=audio-dft) 13:00:20 INFO - PROCESS | 15986 | RSS: Main: 202469376 13:00:20 INFO - PROCESS | 15986 | 13:00:23 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60964/tests/kraken/driver.html?testName=audio-fft) 13:00:24 INFO - PROCESS | 15986 | RSS: Main: 194940928 13:00:24 INFO - PROCESS | 15986 | 13:00:26 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60964/tests/kraken/driver.html?testName=audio-oscillator) 13:00:27 INFO - PROCESS | 15986 | RSS: Main: 195899392 13:00:27 INFO - PROCESS | 15986 | 13:00:29 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:00:29 INFO - PROCESS | 15986 | RSS: Main: 196214784 13:00:29 INFO - PROCESS | 15986 | 13:00:33 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60964/tests/kraken/driver.html?testName=imaging-darkroom) 13:00:33 INFO - PROCESS | 15986 | RSS: Main: 196501504 13:00:33 INFO - PROCESS | 15986 | 13:00:37 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60964/tests/kraken/driver.html?testName=imaging-desaturate) 13:00:37 INFO - PROCESS | 15986 | RSS: Main: 196608000 13:00:37 INFO - PROCESS | 15986 | 13:00:40 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60964/tests/kraken/driver.html?testName=json-parse-financial) 13:00:41 INFO - PROCESS | 15986 | RSS: Main: 196702208 13:00:41 INFO - PROCESS | 15986 | 13:00:42 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:00:43 INFO - PROCESS | 15986 | RSS: Main: 196464640 13:00:43 INFO - PROCESS | 15986 | 13:00:45 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:00:45 INFO - PROCESS | 15986 | RSS: Main: 196280320 13:00:45 INFO - PROCESS | 15986 | 13:00:47 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:48 INFO - PROCESS | 15986 | RSS: Main: 197095424 13:00:48 INFO - PROCESS | 15986 | 13:00:51 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:51 INFO - PROCESS | 15986 | RSS: Main: 196972544 13:00:51 INFO - PROCESS | 15986 | 13:00:54 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:55 INFO - PROCESS | 15986 | RSS: Main: 197406720 13:00:55 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | Cycle 1(1): loaded http://localhost:60964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60964/tests/kraken/driver.html?testName=ai-astar) 13:00:57 INFO - PROCESS | 15986 | RSS: Main: 199077888 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | __start_tp_report 13:00:57 INFO - PROCESS | 15986 | _x_x_mozilla_page_load 13:00:57 INFO - PROCESS | 15986 | _x_x_mozilla_page_load_details 13:00:57 INFO - PROCESS | 15986 | |i|pagename|runs| 13:00:57 INFO - PROCESS | 15986 | |0;ai-astar;108;112;112;116;115;111;112;111;112;128 13:00:57 INFO - PROCESS | 15986 | |1;audio-beat-detection;154;120;149;186;126;146;152;121;184;124 13:00:57 INFO - PROCESS | 15986 | |2;audio-dft;164;164;165;175;162;163;163;163;164;162 13:00:57 INFO - PROCESS | 15986 | |3;audio-fft;75;77;78;188;76;78;76;76;187;75 13:00:57 INFO - PROCESS | 15986 | |4;audio-oscillator;86;86;158;86;85;86;138;86;85;149 13:00:57 INFO - PROCESS | 15986 | |5;imaging-gaussian-blur;117;118;117;118;118;118;119;118;117;119 13:00:57 INFO - PROCESS | 15986 | |6;imaging-darkroom;147;149;148;148;148;150;148;149;149;149 13:00:57 INFO - PROCESS | 15986 | |7;imaging-desaturate;97;96;96;95;96;97;96;96;95;96 13:00:57 INFO - PROCESS | 15986 | |8;json-parse-financial;54;53;53;54;54;54;54;53;54;52 13:00:57 INFO - PROCESS | 15986 | |9;json-stringify-tinderbox;61;63;61;63;63;62;63;61;61;63 13:00:57 INFO - PROCESS | 15986 | |10;stanford-crypto-aes;80;82;79;81;80;80;80;81;82;80 13:00:57 INFO - PROCESS | 15986 | |11;stanford-crypto-ccm;146;129;134;124;124;126;133;130;177;128 13:00:57 INFO - PROCESS | 15986 | |12;stanford-crypto-pbkdf2;170;171;166;176;166;163;166;169;164;169 13:00:57 INFO - PROCESS | 15986 | |13;stanford-crypto-sha256-iterative;66;70;68;66;65;66;64;64;72;68 13:00:57 INFO - PROCESS | 15986 | __end_tp_report 13:00:57 INFO - PROCESS | 15986 | __start_cc_report 13:00:57 INFO - PROCESS | 15986 | _x_x_mozilla_cycle_collect,809 13:00:57 INFO - PROCESS | 15986 | __end_cc_report 13:00:57 INFO - PROCESS | 15986 | __startTimestamp1472155257363__endTimestamp 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | ------- Summary: start ------- 13:00:57 INFO - PROCESS | 15986 | Number of tests: 14 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#0] ai-astar Cycles:10 Average:113.70 Median:112.00 stddev:5.48 (4.9%) stddev-sans-first:5.41 13:00:57 INFO - PROCESS | 15986 | Values: 108.0 112.0 112.0 116.0 115.0 111.0 112.0 111.0 112.0 128.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:150.50 stddev:24.35 (16.2%) stddev-sans-first:25.67 13:00:57 INFO - PROCESS | 15986 | Values: 154.0 120.0 149.0 186.0 126.0 146.0 152.0 121.0 184.0 124.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.81 (2.3%) stddev-sans-first:4.03 13:00:57 INFO - PROCESS | 15986 | Values: 164.0 164.0 165.0 175.0 162.0 163.0 163.0 163.0 164.0 162.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#3] audio-fft Cycles:10 Average:98.60 Median:76.00 stddev:46.87 (61.7%) stddev-sans-first:48.93 13:00:57 INFO - PROCESS | 15986 | Values: 75.0 77.0 78.0 188.0 76.0 78.0 76.0 76.0 187.0 75.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:86.00 stddev:30.62 (35.6%) stddev-sans-first:31.73 13:00:57 INFO - PROCESS | 15986 | Values: 86.0 86.0 158.0 86.0 85.0 86.0 138.0 86.0 85.0 149.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 13:00:57 INFO - PROCESS | 15986 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 117.0 119.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 13:00:57 INFO - PROCESS | 15986 | Values: 147.0 149.0 148.0 148.0 148.0 150.0 148.0 149.0 149.0 149.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 13:00:57 INFO - PROCESS | 15986 | Values: 97.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.71 (1.3%) stddev-sans-first:0.73 13:00:57 INFO - PROCESS | 15986 | Values: 54.0 53.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 52.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 13:00:57 INFO - PROCESS | 15986 | Values: 61.0 63.0 61.0 63.0 63.0 62.0 63.0 61.0 61.0 63.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 13:00:57 INFO - PROCESS | 15986 | Values: 80.0 82.0 79.0 81.0 80.0 80.0 80.0 81.0 82.0 80.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:131.50 stddev:16.07 (12.2%) stddev-sans-first:16.55 13:00:57 INFO - PROCESS | 15986 | Values: 146.0 129.0 134.0 124.0 124.0 126.0 133.0 130.0 177.0 128.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:3.83 (2.3%) stddev-sans-first:3.99 13:00:57 INFO - PROCESS | 15986 | Values: 170.0 171.0 166.0 176.0 166.0 163.0 166.0 169.0 164.0 169.0 13:00:57 INFO - PROCESS | 15986 | 13:00:57 INFO - PROCESS | 15986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.60 (3.9%) stddev-sans-first:2.74 13:00:57 INFO - PROCESS | 15986 | Values: 66.0 70.0 68.0 66.0 65.0 66.0 64.0 64.0 72.0 68.0 13:00:57 INFO - PROCESS | 15986 | -------- Summary: end -------- 13:00:57 INFO - PROCESS | 15986 | 13:00:58 INFO - TEST-INFO | 15986: exit 0 13:00:58 INFO - TEST-OK | kraken | took 62698ms 13:00:58 INFO - SUITE-END | took 1177s 13:00:58 INFO - Completed test suite (00:19:37) 13:00:58 INFO - javascript benchmark 13:00:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.066251452584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.6251649802025, 3136.46680064389, 3153.526970954358, 3170.3500782339615, 3191.1543440988125, 5381.4349493303225, 5471.78112875485, 5498.0, 5534.114541673333, 5577.832665020051, 5430.321209848769, 5444.700541470217, 5485.917711234325, 5486.533644640201, 5546.389897111315, 4955.776990035457, 5005.974970125144, 5042.84871453857, 5058.0895438821, 5134.845954621367, 4666.650001249903, 5052.646314757969, 5106.821261255856, 5115.563013895281, 5174.016936782018, 4784.019276048419, 4912.336834527365, 4935.161022626162, 4996.650234483587, 4997.900041999158, 4994.275830004629, 5032.993401319751, 5046.974765126188, 5048.697078175322, 5077.974610126926, 4949.727764972925, 4986.40163180417, 4997.400311962551, 5012.147934851084, 5057.291979122889, 5185.196294574309, 5380.192971054334, 5448.83653490396, 5453.372862120827, 5518.310211223597, 5834.737436815353, 5848.210491583624, 5849.415058494159, 5850.3564607893095, 5877.794277200277, 5860.120981852713, 5882.411758824126, 5886.646801191942, 5888.116782482662, 5895.056790913433, 5345.144776835727, 5403.243545903577, 5437.401885792559, 5441.020616289106, 5448.046591846411, 5914.408559144051, 5968.432998865101, 5995.250593675791, 6005.918934591816, 6062.727177277033, 5677.602567820213, 5741.138829175574, 5742.368339482654, 5755.625884317506, 5757.85605359861, 5657.462541058593, 5660.235868157746, 5702.0, 5717.399673034354, 5828.708564571839, 5690.260266165372, 5790.536757059425, 5798.072308430631, 5829.0, 5883.17635531026, 5756.481916627524, 5765.769369225268, 5774.566907481955, 5780.913286300709, 5796.1595568642315, 4417.1386579616665, 4455.554444555519, 4483.173136874412, 4492.618127459203, 4494.662900282492, 3961.8811435656976, 4005.4792876926394, 4069.8575549856205, 4094.0992981544014, 4108.157827645326, 5600.831975040755, 5631.915521267184, 5649.802256920988, 5651.463111004448, 5657.632253903483, 5618.69097199658, 5808.5353171747, 5933.851653708692, 5935.495482884004, 5973.641581505123, 5554.666719996732, 5606.299212598426, 5607.074832652648, 5634.915476267859, 5671.801486948019, 5029.84910452687, 5029.874253143701, 5034.0938631046765, 5040.218766091261, 5100.846974590768, 5883.117532370179, 5901.734421950937, 6038.33578306386, 6043.09353596964, 6046.486048685823, 5790.913136302875, 5856.092305692625, 5862.530997520274, 5874.17761513397, 5882.647041177372, 5959.433853783884, 5967.850803729768, 5982.700864956648, 5990.251218597501, 5996.0, 5482.506574408322, 5538.889222215614, 5731.8853622928145, 5756.625819321731, 5759.51044161251, 5801.332846722681, 5839.15332276809, 5867.9413205867395, 5896.321922978912, 5920.851978700567, 5710.314762228559, 5725.227094342211, 5727.7422515986045, 5750.856228594319, 5781.248437703071, 5435.374931882884, 5696.686682232517, 5699.4300569944335, 5715.485606295453, 5717.828465146053, 5600.355959064596, 5629.352624448241, 5671.291088613923, 5693.032184528557, 5760.683162426107, 5653.434656534314, 5729.054705973468, 5736.827895163152, 5749.712514374348, 5754.021816291157, 5490.313710786152, 5566.693831839288, 5580.190872323572, 5595.04884169684, 5624.128260119688], "value": 5386.609591759507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.1803802524364, 580.1442871764145, 586.6509426891, 591.2077815726925, 614.1555361378105, 38085.428718569245, 42843.57156428435, 42919.35620965688, 43015.0, 43085.138297234036, 43135.0, 43244.35133472992, 43579.56420435795, 43660.56339436604, 43749.0, 8788.95605521973, 8893.599788009522, 8904.910950890506, 8931.732048038537, 8938.106189381042, 8830.20528152466, 8848.823023539526, 8864.601092950832, 8899.199072083511, 8959.955200223989, 9007.414518056337, 9029.367944243906, 9044.3668943174, 9059.637614495445, 9066.093390660948, 8908.910910890905, 8940.508272045035, 8993.0, 9013.729588112366, 9028.638854445815, 8736.213740763298, 8791.340649451316, 8794.03265640779, 8808.119188081204, 8825.161609647073, 40146.59853401458, 40577.59422405768, 40657.59342406568, 40844.591554084676, 40875.0, 3617.149969757105, 3913.5695073541888, 3977.2244412339605, 4193.811278492444, 4376.102898905717, 32374.514382284284, 33299.500507492405, 33426.83286583576, 33752.0, 34214.31571368559, 4227.87316380509, 4352.565793730974, 4417.730879149406, 4444.777761111932, 4451.532589078165, 326028.0, 332628.0, 333266.0, 333289.0, 335338.99999999756, 56605.716971415706, 56790.0, 57190.71404643033, 57205.14192287119, 57382.0, 58176.418235817946, 58328.0, 58535.5366115842, 58740.412595874346, 58774.41225587775, 14746.11523308605, 15436.996595221499, 15461.9226903867, 15836.0, 15847.841521584636, 11539.88460115388, 11769.117316201147, 11785.705357365963, 11827.172097953233, 11830.585929492427, 18496.352627658238, 18716.53208669767, 18774.436766897015, 18895.43313700591, 18945.147468363957, 7111.537750046334, 7148.892766608505, 7389.113306403266, 7418.925810741824, 7443.665035073434, 972.7373609125497, 1127.6617014895662, 1137.2607804926863, 1152.7348709796793, 1160.3212120909363, 32661.0, 32959.67040329566, 33003.66996330054, 33432.33135337328, 33535.49696754551, 1098.357460885391, 1124.6401151631399, 1133.9603113890973, 1148.242160174281, 1171.6250799744, 15573.688526229638, 17484.0, 17725.645487090187, 17987.73018404725, 18830.0, 516729.0, 517933.0, 518590.0, 519472.0, 520923.0, 60348.39651603516, 60934.0, 61179.38820611737, 61410.69294653588, 61433.38566614366, 1306.4121145484569, 1349.311850956, 1359.1097830920762, 1368.7946807979083, 1378.2832926877968, 30866.270817089364, 33680.15799605029, 33857.0, 33974.660253398135, 34327.485087724206, 52216.0, 52787.20819187792, 52992.73503632457, 53176.46823531715, 53261.201081983025, 492663.0, 494256.0, 498245.0, 500704.0, 504581.0, 27754.44491110207, 28162.436751265268, 28363.0, 28682.56976145318, 28717.71282287234, 48083.27875081806, 48992.5100748988, 49369.506304937924, 49638.75180624218, 49868.750656246484, 40884.79557602193, 41542.37686434646, 41808.1468594391, 42179.0, 43352.0, 40910.38634420546, 41202.38196426996, 41889.58110418857, 41950.58049419467, 42041.85066987942, 35142.82428587841, 41271.7936410316, 41538.792306038275, 41621.37567936423, 41812.372814408416, 32416.675833241366, 37756.867293981224, 38342.80828595839, 38848.0, 38882.0, 28998.27504312409, 29028.0, 29187.70812291935, 29322.120336389944, 29337.266568335963], "value": 20299.067111529406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5438546551406, 381.7652143931483, 396.3104198694272, 401.14756143195706, 413.2932685108464, 16539.25573349199, 18091.0, 20012.799872001277, 20111.296104636323, 20189.697154542657, 11302.943485282583, 11335.603253886116, 11386.0, 11649.0, 11655.533778648844, 4995.250712393134, 5171.276021357013, 5211.322528071364, 5213.895722085556, 5227.843164705065, 5191.818286359978, 5233.319668443116, 5240.056789777838, 5392.514673679368, 5597.160425936101, 5684.772609095631, 5685.658860468365, 5698.43015698431, 5701.515371193454, 5702.914456283159, 5496.890062198733, 5651.2935883014625, 5671.6880571568545, 5705.771769129251, 5715.114157305583, 5513.917291240635, 5534.557235421156, 5536.0, 5536.750846211889, 5538.0, 12744.107912446132, 12834.871651283462, 13025.218486890817, 13045.0, 16555.586110347336, 2191.747948985871, 2359.362971997551, 2374.798142157919, 2415.830891837572, 2560.295918622375, 9261.583228754722, 9635.518224088768, 9823.557939892722, 10114.848277275847, 10222.182225421948, 1889.6031833315021, 1891.9716204256947, 1924.8267655910895, 1948.4544327588155, 1959.4905324615702, 76668.0, 85376.57311713402, 85504.57247713722, 85697.57151214204, 86561.13438865593, 9075.183233509017, 9534.95232523833, 9702.369345992487, 10414.375137491776, 10679.771826240081, 12438.564650237198, 12465.688357791129, 12470.875291246972, 12539.373031348396, 12557.74884502323, 7508.211637777955, 7584.5070070445245, 7587.544747315179, 7755.728549500854, 7779.57212353326, 7490.775276741707, 7543.585102819397, 7776.416768742254, 7808.2191780822595, 7829.765107046797, 3762.6049264827348, 3853.421986702017, 3906.5312162540677, 3972.0, 3980.4029395590314, 1837.5314294854993, 1891.7635295588052, 1900.5248687828043, 1954.7458830351964, 1968.1143485431612, 910.39003867409, 920.1028996728137, 946.4936259101348, 966.21253678252, 980.6910823090703, 19086.80913190878, 20923.0, 21051.68422473664, 21097.472563185736, 21197.682034769492, 948.8671585977969, 976.4922240435076, 996.496769131584, 1003.7691330993912, 1004.5027711282962, 9956.203503719686, 11048.563686720674, 11313.943430282796, 11422.657320280405, 11453.828192577119, 542094.0, 543056.3956947138, 545048.0, 552186.0, 557682.0, 86465.0, 90153.0, 96695.0, 98312.50843745735, 102808.0, 895.9641614335353, 975.2393133355994, 1007.9496025198711, 1039.1478987230398, 1050.2438244463974, 17947.5513112168, 18238.452846414628, 18967.810321896606, 19163.808361916203, 19193.424197274104, 42245.788771055944, 44003.559964401225, 44381.11237775291, 44400.0, 44509.88725281894, 60999.695001524706, 61283.08075378962, 61396.38603613907, 61848.381516184265, 62553.37446625657, 8086.87869681967, 8218.712345068134, 8226.259636632733, 8425.2838508725, 8637.136286371313, 11892.76214475723, 13435.12671676338, 13565.321733913068, 14064.367103480572, 14164.220967846455, 11338.886611134112, 11379.829302560303, 11456.140789440991, 11565.884341156818, 11787.646370608896, 11332.150088743212, 11484.023857972166, 11498.367589782642, 11757.0, 11965.700857478632, 11506.676732175907, 11570.0, 11597.246178998337, 11722.94138529302, 11935.104867134825, 7398.630068496446, 7421.257874212535, 7610.581418022062, 7681.7695469136015, 8905.020447750872, 10030.398176109165, 10596.788064238826, 10624.681259562225, 10842.620508282173, 10985.176111791807], "value": 8784.340913914293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.8689131086892, 1424.7008128293057, 1460.6348412896775, 1746.2054765081882, 1752.6144248265377, 7773.144954055049, 8331.250187483125, 8744.169303916135, 9417.199538039258, 9417.670381536647, 8354.456960297577, 8590.312774978003, 8600.096989816057, 8629.309655227582, 8657.26413254874, 2318.547883162784, 2340.4382948092507, 2347.7652234776556, 2349.5770761262966, 2352.1179557665873, 2277.1574517428576, 2295.6900818389554, 2332.918347857825, 2363.669086327907, 2367.8934447949796, 2286.9313920582326, 2317.478567322356, 2327.7555856635063, 2332.055517515409, 2343.5664402085586, 2189.102467988133, 2242.1031587365023, 2249.538844536882, 2251.4371407148215, 2253.301476542277, 2197.7362716474127, 2199.274239500961, 2203.272919936417, 2207.194374053475, 2209.7569267380577, 8660.8700869487, 9093.363464557484, 9186.494742789144, 9245.844269466317, 9257.537123143817, 5295.152775555893, 5439.129739241742, 5440.972795136038, 5448.182772584105, 5453.754581043862, 3329.6004479462376, 3342.9498557521656, 3391.3895498810202, 3467.1505481157023, 3474.2183008823067, 1164.3770582738193, 1170.104869774623, 1194.4684615346175, 1195.8923696867237, 1198.9040876729841, 12504.437300321417, 12542.81185782214, 12717.173383730027, 12731.172473789175, 12747.043971702253, 4468.240399132155, 4707.741074240881, 4731.7634118293945, 4792.712437253706, 4804.42346918372, 10611.469426528643, 10657.147428205724, 10661.253712240225, 10662.466876656292, 10704.518296676668, 5395.676259424368, 5414.756335964891, 5467.753951072212, 5468.7539060742365, 5471.0, 4291.249031419489, 4771.689840160448, 4856.053069651454, 4936.407631084293, 4955.132851751001, 3977.6420122188565, 4037.535683396447, 4048.332025215865, 4070.206309769626, 4177.310743727251, 1200.7898617742035, 1208.7219939413983, 1221.8533775946944, 1225.3444407242082, 1226.0314351662266, 908.9592416682993, 912.7307444303947, 943.7027336389016, 944.7779771753633, 948.4972964328916, 5641.774329026875, 5734.856628584319, 5885.911711324334, 5935.347111817697, 6112.0, 460.8456167183964, 463.0923390155266, 464.69562436604076, 465.51732731251076, 470.7222738584252, 4000.399940009022, 4016.0, 4039.2527382434346, 4040.3535434330365, 4083.9387409188885, 10672.146228301717, 11314.603988860516, 11474.426278686033, 11516.827247591293, 11580.47887845049, 11248.0, 11257.549698012152, 11342.773144537063, 11365.431728413547, 11408.201425900108, 8312.709055183039, 8505.82988340242, 8518.572206920997, 8534.74395768128, 8543.743687689379, 5884.764609415746, 5887.4406931341455, 5963.642181469126, 5969.791057312973, 5985.162077309094, 10071.949640251752, 10314.638987635397, 10370.222233332379, 10393.63622273247, 10483.842742358718, 10545.261831671709, 10712.839307410552, 10750.569977200825, 10782.784344313226, 10859.674209773719, 7129.429645628441, 7924.960375198318, 8001.439899207, 8205.507669539847, 8495.787605309917, 8630.870536942077, 8957.283417326467, 9010.954945225232, 9014.053524379846, 9036.954815225881, 7960.4825686330205, 7996.60016999136, 8053.275205231557, 8111.0, 8168.346532277523, 7211.4230861532005, 7745.457817952689, 7748.4576079676135, 7775.416843736629, 7867.567283799446, 6978.441724662116, 7118.039064726196, 7127.607981561064, 7133.500654954103, 7144.3570078693165, 4953.801847926043, 4994.101061808909, 5017.24741288795, 5041.924371134509, 5154.664946778447, 4845.442774081026, 4975.950240497548, 5120.667156634807, 5185.637005409585, 5239.790408383622], "value": 4591.580690345114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5970556215853, 336.939350916835, 339.4263694356539, 341.4860634744709, 345.7700629081661, 5321.388040375358, 5390.921815636869, 5550.833474995747, 5631.183478395636, 5636.323641163056, 5321.122014867542, 5417.783288668458, 5420.214068959998, 5420.457954204578, 5454.818072770893, 4290.935635965463, 4293.162833247518, 4296.720713153651, 4339.609435150835, 4340.08858139791, 4216.451861258032, 4280.614744672979, 4286.292761694317, 4321.373400856874, 4334.956650433503, 4250.319948808191, 4250.766207858566, 4256.59562341577, 4259.552746961571, 4268.594483524076, 4208.705390622657, 4219.3249080147025, 4243.236217480852, 4254.851080212208, 4257.595528424795, 3679.6872265857432, 3786.6970642348547, 3824.961750382516, 3835.827387767557, 3847.0, 5320.441353657849, 5322.733863306819, 5341.439148889388, 5345.946540534584, 5369.194620806871, 4868.756562171912, 4883.682560633548, 4894.804207831682, 4898.595476144082, 4904.302633551532, 5526.706416837008, 5688.573356998241, 5711.400302968212, 5768.125359258258, 5768.394318596529, 4058.817353219112, 4090.8159132838796, 4106.240345536085, 4107.644477322477, 4121.567235440296, 6001.899335232677, 6030.6080104793045, 6034.396560343975, 6050.515958723292, 6096.939030609726, 4159.251334759772, 4217.304144816132, 4293.677974151951, 4319.97840010798, 4320.503142138631, 4245.448091748053, 4263.168682107022, 4286.249906266391, 4294.26997410441, 4304.504981927118, 4864.80540778372, 4900.313956046157, 4906.386701662293, 4930.11257973561, 4942.986687729079, 5594.552435805126, 5743.741531631086, 5814.273215848019, 5827.271591051119, 5868.2664666916635, 1463.3829618271868, 1471.8004826066722, 1476.5201309574431, 1479.2825479642365, 1485.93755464841, 904.7195369435497, 945.9736186237872, 948.3693343926212, 959.5154447004218, 962.8542034978353, 4848.975755121272, 4860.659753817199, 4879.56083952446, 4905.509449055137, 4910.76560165124, 5159.303494028333, 5159.664621799571, 5168.328117344721, 5189.506996835295, 5233.71214583194, 4663.160631086437, 4897.436794768576, 4902.48523904992, 4911.852644420673, 4919.77860996256, 2728.9493544984925, 2733.671959364889, 2736.9726302736717, 2751.4222013377016, 2759.4894944435346, 5331.946680533145, 5342.904704535561, 5379.54273886724, 5384.838454846361, 5388.892222155535, 4941.430456162847, 5251.264822924793, 5254.605904557174, 5287.70917599528, 5311.28297679816, 5350.732463376816, 5354.491323324278, 5368.946310536923, 5370.462953704677, 5377.677339359651, 5204.193350030751, 5222.399424066281, 5222.425533191422, 5226.895462090661, 5258.579313654975, 4932.457429682804, 4976.527229913152, 5052.242163675478, 5071.377159308986, 5098.362704661918, 5258.447862974333, 5269.47185316254, 5292.232626269092, 5311.601629877698, 5335.413104558573, 3891.5135608048995, 3971.126352202511, 4121.5466298706515, 4159.10579225468, 4163.354680024601, 5903.586748927534, 5908.527317814651, 5918.733656985532, 5924.200232968494, 5934.376890426443, 5590.5527557796095, 5783.595148339576, 5793.739281732248, 5811.593188476935, 5815.563832712479, 5727.570432217517, 5755.251817263729, 5763.567732420001, 5782.479576838105, 5784.681842498703, 5770.653760774199, 5787.8553036174435, 5791.9131213031, 5811.680357580373, 5824.912626310524, 5564.582656300875, 5809.0, 5852.882942341214, 5853.0, 5853.707314634336, 5713.171590119493, 5721.513671337816, 5726.398728133486, 5727.713614319351, 5747.683877386617], "value": 4233.656936222474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.6591137386994, 714.2964180282424, 719.2591630620461, 773.2190487607517, 780.7930898311948, 13584.456621735131, 14505.347259373328, 14558.126512409237, 14561.92719036406, 14582.70834583309, 14001.859981400183, 14024.789628155586, 14035.0, 14055.859441405582, 14093.365798539066, 659.4065341192917, 755.879059350504, 767.9500832445887, 773.443120952913, 788.2866006264311, 796.3111908199423, 798.6845196147518, 799.6161842315692, 800.9479383840031, 801.2148094867034, 836.5440834745078, 841.7138173021171, 842.9114942930996, 844.0, 850.6597361055566, 841.8526757817388, 841.9242268195861, 847.5380917400032, 848.3594885861166, 849.426637020009, 614.9169862068608, 614.929283132441, 615.5414216408759, 616.626940700874, 617.3579477343558, 13239.470421183141, 13265.204087754766, 13284.601461956157, 13293.86706132936, 13314.201147931059, 14438.855611443856, 14498.927505362512, 14531.491397801132, 14554.636134096732, 14700.970932034761, 12391.256524608552, 12556.246625202426, 12605.243685378906, 12670.303133327756, 13506.0, 3813.8474461021524, 3844.75009124406, 3926.175503144343, 3992.0, 3995.440638310639, 84985.57507212424, 87032.12967870303, 87851.0, 87935.56032219798, 88012.0, 10540.156787456985, 10545.736356591147, 11017.614383496539, 11100.61147859821, 11598.246114002563, 20000.0, 20049.298274560322, 20119.0, 20194.192232310837, 20233.89883050605, 7904.683812647545, 7907.5650839203245, 8024.759257222293, 8134.75595732129, 8412.369072319478, 4786.473487916326, 4812.831550895702, 4891.315215869781, 4954.331165292711, 5050.04049230645, 3098.148009297461, 3185.665505121975, 3208.326251487214, 3219.8390080495883, 3220.1627576829724, 573.1345668041205, 578.9015867302569, 596.1207219351422, 596.8895754285385, 601.8284788835161, 657.8618490117034, 661.7882277671196, 667.3293340193075, 667.3493343989571, 671.6104659297694, 8352.53600187946, 9187.63249470027, 9285.117913798178, 9411.294152938557, 9456.14894659484, 511.9513646203605, 577.9971100144472, 641.643887642363, 659.3176062775004, 660.1220376898713, 4248.87253382399, 4282.122164956177, 4422.933655995163, 4460.442444694413, 4460.598546130864, 74941.62529187319, 75574.24425755782, 115115.0, 117871.0, 133660.0, 66193.66903165453, 96853.51573242088, 104473.0, 105558.47220763846, 106333.0, 77706.22293777103, 79481.60259198667, 80042.0, 88262.55868720615, 92764.53617731867, 9731.9026809731, 10371.94814025925, 10478.790424191626, 10577.788444231226, 10651.786964260826, 50173.0, 52223.47776522186, 52902.0, 53245.46754532405, 53804.0, 69228.6538567304, 69298.30701692919, 70243.29756702571, 74177.66200521098, 79731.0, 14202.147871127765, 14442.783358249844, 14832.18422986746, 14870.776938345716, 15157.242137893281, 15137.924310378377, 15241.237938103272, 16266.0, 16313.429029983894, 16336.346546138022, 13724.794128088286, 14265.64335891611, 15150.24248787534, 15160.355650094982, 15239.161846098572, 13424.93287533556, 13672.93163534176, 13888.0, 14086.506972255922, 14568.635784105481, 14907.0, 14912.403503860158, 15124.941254112107, 15141.167235802137, 15466.5360039199, 10677.709723014481, 10922.344659320466, 11017.779644407226, 11139.83290250663, 11214.15893807984, 11718.355490448108, 12235.755284894074, 12323.815142772686, 12434.937825310815, 12513.812292815797], "value": 7473.415179588335, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 112.0, 116.0, 115.0, 111.0, 112.0, 111.0, 112.0, 128.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 149.0, 186.0, 126.0, 146.0, 152.0, 121.0, 184.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 175.0, 162.0, 163.0, 163.0, 163.0, 164.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 188.0, 76.0, 78.0, 76.0, 76.0, 187.0, 75.0], "value": 98.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 158.0, 86.0, 85.0, 86.0, 138.0, 86.0, 85.0, 149.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0, 149.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 63.0, 63.0, 62.0, 63.0, 61.0, 61.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 79.0, 81.0, 80.0, 80.0, 80.0, 81.0, 82.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 129.0, 134.0, 124.0, 124.0, 126.0, 133.0, 130.0, 177.0, 128.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 166.0, 176.0, 166.0, 163.0, 166.0, 169.0, 164.0, 169.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 66.0, 65.0, 66.0, 64.0, 64.0, 72.0, 68.0], "value": 66.9, "unit": "score"}]}]} 13:00:58 INFO - Return code: 0 13:00:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:00:58 ERROR - # TBPL SUCCESS # 13:00:58 INFO - Running post-action listener: _resource_record_post_action 13:00:58 INFO - [mozharness: 2016-08-25 20:00:58.693285Z] Finished run-tests step (success) 13:00:58 INFO - Running post-run listener: _resource_record_post_run 13:00:58 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 77824; Write bytes: 417783808; Read time: 24; Write time: 332124 13:00:58 INFO - TinderboxPrint: CPU usage
13.4% 13:00:58 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 24 13:00:58 INFO - TinderboxPrint: I/O write bytes / time
417,783,808 / 332,124 13:00:58 INFO - TinderboxPrint: CPU idle
8,240.3 (86.5%) 13:00:58 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 13:00:58 INFO - TinderboxPrint: Swap in / out
0 / 0 13:00:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128913408; Read time: 0; Write time: 90688 13:00:58 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 73728; Write bytes: 288313344; Read time: 12; Write time: 241396 13:00:59 INFO - Running post-run listener: _upload_blobber_files 13:00:59 INFO - Blob upload gear active. 13:00:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:59 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 13:00:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:01:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:03 INFO - (blobuploader) - INFO - Done attempting. 13:01:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:01:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:01:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:04 INFO - (blobuploader) - INFO - Done attempting. 13:01:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:01:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:01:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:05 INFO - (blobuploader) - INFO - Done attempting. 13:01:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:01:05 INFO - Return code: 0 13:01:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:01:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:01:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8b7776773f842a5fc1aa501b9ad68ad3edccaed314df873ac1d7a8e25397dfc84a1f07331e02ea4dd5264d1f31611b9c4af2c43c990b23ebd9539c119a2ce2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/413fd26997342715f1c38c99466a97cabdd5976d3c247a58c2c58b8d9f50a0675dbde13ab8c55d598b2f58be0a05b45d73ada392809174138fb1aa4e34ab9ade", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/659bbc75716fe0eb111886433ecc801c6d40a47df31700f932d59b25aea9c5fce2e2d67b2577ce61689ef4ed8e94726d9e187883836d07bf59340d2772e98748"} 13:01:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:01:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:01:05 INFO - Contents: 13:01:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8b7776773f842a5fc1aa501b9ad68ad3edccaed314df873ac1d7a8e25397dfc84a1f07331e02ea4dd5264d1f31611b9c4af2c43c990b23ebd9539c119a2ce2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/413fd26997342715f1c38c99466a97cabdd5976d3c247a58c2c58b8d9f50a0675dbde13ab8c55d598b2f58be0a05b45d73ada392809174138fb1aa4e34ab9ade", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/659bbc75716fe0eb111886433ecc801c6d40a47df31700f932d59b25aea9c5fce2e2d67b2577ce61689ef4ed8e94726d9e187883836d07bf59340d2772e98748"} 13:01:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:01:05 INFO - Copying logs to upload dir... 13:01:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:01:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.447260 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 13:01:05.881905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 13:01:05.889590) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8b7776773f842a5fc1aa501b9ad68ad3edccaed314df873ac1d7a8e25397dfc84a1f07331e02ea4dd5264d1f31611b9c4af2c43c990b23ebd9539c119a2ce2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/413fd26997342715f1c38c99466a97cabdd5976d3c247a58c2c58b8d9f50a0675dbde13ab8c55d598b2f58be0a05b45d73ada392809174138fb1aa4e34ab9ade", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/659bbc75716fe0eb111886433ecc801c6d40a47df31700f932d59b25aea9c5fce2e2d67b2577ce61689ef4ed8e94726d9e187883836d07bf59340d2772e98748"} build_url:https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/VaWAs6nGQWGJEmXXHR6qpQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8b7776773f842a5fc1aa501b9ad68ad3edccaed314df873ac1d7a8e25397dfc84a1f07331e02ea4dd5264d1f31611b9c4af2c43c990b23ebd9539c119a2ce2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/413fd26997342715f1c38c99466a97cabdd5976d3c247a58c2c58b8d9f50a0675dbde13ab8c55d598b2f58be0a05b45d73ada392809174138fb1aa4e34ab9ade", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/659bbc75716fe0eb111886433ecc801c6d40a47df31700f932d59b25aea9c5fce2e2d67b2577ce61689ef4ed8e94726d9e187883836d07bf59340d2772e98748"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 13:01:05.918227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:01:05.918627) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472152122.669154-931389101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:01:05.998942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 13:01:05.999269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 13:01:05.999569) ========= ========= Total master_lag: 0.20 =========