builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1470668725.16 results: success (0) buildid: 20160808053006 builduid: 175a02a2c58049629ecfc351473c4b75 revision: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.156542) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.156953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.157231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.184336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.184599) ========= 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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 08:05:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-08-08 08:05:25 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.382133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.580230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.580516) ========= 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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.630137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:25.630551) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 --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 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 --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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 08:05:25,892 truncating revision to first 12 chars 2016-08-08 08:05:25,893 Setting DEBUG logging. 2016-08-08 08:05:25,893 attempt 1/10 2016-08-08 08:05:25,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a72f2737bce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 08:05:26,182 unpacking tar archive at: fx-team-1a72f2737bce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:26.269706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:26.270043) ========= script_repo_revision: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:26.270450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:26.270746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 08:05:26.280127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-08 08:05:26.280502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:26 INFO - MultiFileLogger online at 20160808 08:05:26 in /builds/slave/test 08:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:26 INFO - {'append_to_log': False, 08:05:26 INFO - 'base_work_dir': '/builds/slave/test', 08:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:26 INFO - 'branch': 'Fx-Team', 08:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:26 INFO - 'config_files': ('talos/linux_config.py',), 08:05:26 INFO - 'default_actions': ('clobber', 08:05:26 INFO - 'read-buildbot-config', 08:05:26 INFO - 'download-and-extract', 08:05:26 INFO - 'populate-webroot', 08:05:26 INFO - 'create-virtualenv', 08:05:26 INFO - 'install', 08:05:26 INFO - 'run-tests'), 08:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:26 INFO - 'download_minidump_stackwalk': True, 08:05:26 INFO - 'download_symbols': 'ondemand', 08:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:26 INFO - 'installer_path': 'installer.exe', 08:05:26 INFO - 'log_level': 'info', 08:05:26 INFO - 'log_name': 'talos', 08:05:26 INFO - 'log_to_console': True, 08:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:26 INFO - 'opt_config_files': (), 08:05:26 INFO - 'pip_index': False, 08:05:26 INFO - 'sps_profile': False, 08:05:26 INFO - 'sps_profile_interval': 0, 08:05:26 INFO - 'suite': 'dromaeojs', 08:05:26 INFO - 'system_bits': '32', 08:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:26 INFO - 'title': 'talos-linux64-ix-020', 08:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:26 INFO - 'use_talos_json': True, 08:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:26 INFO - 'work_dir': 'build'} 08:05:26 INFO - [mozharness: 2016-08-08 15:05:26.638849Z] Running clobber step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running main action method: clobber 08:05:26 INFO - rmtree: /builds/slave/test/build 08:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:27 INFO - Running post-action listener: _resource_record_post_action 08:05:27 INFO - [mozharness: 2016-08-08 15:05:27.098193Z] Finished clobber step (success) 08:05:27 INFO - [mozharness: 2016-08-08 15:05:27.098296Z] Running read-buildbot-config step. 08:05:27 INFO - Running pre-action listener: _resource_record_pre_action 08:05:27 INFO - Running main action method: read_buildbot_config 08:05:27 INFO - Using buildbot properties: 08:05:27 INFO - { 08:05:27 INFO - "project": "", 08:05:27 INFO - "product": "firefox", 08:05:27 INFO - "script_repo_revision": "production", 08:05:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:05:27 INFO - "repository": "", 08:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:05:27 INFO - "buildid": "20160808053006", 08:05:27 INFO - "pgo_build": "True", 08:05:27 INFO - "basedir": "/builds/slave/test", 08:05:27 INFO - "buildnumber": 343, 08:05:27 INFO - "slavename": "talos-linux64-ix-020", 08:05:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:05:27 INFO - "platform": "ubuntu64_hw", 08:05:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:27 INFO - "branch": "fx-team", 08:05:27 INFO - "repo_path": "integration/fx-team", 08:05:27 INFO - "revision": "1a72f2737bce150bd90c831341cc7b5a93fc2aa9", 08:05:27 INFO - "stage_platform": "linux64-pgo", 08:05:27 INFO - "builduid": "175a02a2c58049629ecfc351473c4b75", 08:05:27 INFO - "slavebuilddir": "test" 08:05:27 INFO - } 08:05:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:05:27 INFO - Running post-action listener: _resource_record_post_action 08:05:27 INFO - [mozharness: 2016-08-08 15:05:27.100759Z] Finished read-buildbot-config step (success) 08:05:27 INFO - [mozharness: 2016-08-08 15:05:27.100849Z] Running download-and-extract step. 08:05:27 INFO - Running pre-action listener: _resource_record_pre_action 08:05:27 INFO - Running main action method: download_and_extract 08:05:27 INFO - mkdir: /builds/slave/test/build/tests 08:05:27 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')]} 08:05:27 INFO - trying https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:27 INFO - Downloaded 1361 bytes. 08:05:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:05:27 INFO - Using the following test package requirements: 08:05:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'jsshell-linux-x86_64.zip'], 08:05:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:27 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')]} 08:05:27 INFO - trying https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:29 INFO - Downloaded 21828529 bytes. 08:05:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:30 INFO - Return code: 0 08:05:30 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 08:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:30 INFO - trying https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:31 INFO - Downloaded 21828529 bytes. 08:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:33 INFO - Return code: 0 08:05: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')]} 08:05:33 INFO - trying https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:33 INFO - Downloading https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:34 INFO - Downloaded 14413723 bytes. 08:05:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:05:34 INFO - Return code: 0 08:05:34 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')]} 08:05:34 INFO - trying https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:34 INFO - Downloading https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/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 08:05:35 INFO - Downloaded 59965686 bytes. 08:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:35 INFO - mkdir: /builds/slave/test/properties 08:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:35 INFO - Contents: 08:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:36 INFO - Running post-action listener: _resource_record_post_action 08:05:36 INFO - Running post-action listener: set_extra_try_arguments 08:05:36 INFO - [mozharness: 2016-08-08 15:05:36.413919Z] Finished download-and-extract step (success) 08:05:36 INFO - [mozharness: 2016-08-08 15:05:36.414154Z] Running populate-webroot step. 08:05:36 INFO - Running pre-action listener: _resource_record_pre_action 08:05:36 INFO - Running main action method: populate_webroot 08:05:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:36 INFO - '--tppagecycles', 08:05:36 INFO - '7'], 08:05:36 INFO - 'tests': ['tsvgm']}}, 08:05:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['damp', 'tps']}, 08:05:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'tests': ['damp', 'tps']}, 08:05:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['dromaeo_dom']}, 08:05:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['basic_compositor_video']}, 08:05:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['a11yr', 08:05:36 INFO - 'ts_paint', 08:05:36 INFO - 'tpaint', 08:05:36 INFO - 'sessionrestore', 08:05:36 INFO - 'sessionrestore_no_auto_restore', 08:05:36 INFO - 'tabpaint']}, 08:05:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['tsvgx', 08:05:36 INFO - 'tsvgr_opacity', 08:05:36 INFO - 'tart', 08:05:36 INFO - 'tscrollx', 08:05:36 INFO - 'cart']}, 08:05:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:36 INFO - 'tsvgr_opacity', 08:05:36 INFO - 'tart', 08:05:36 INFO - 'tscrollx', 08:05:36 INFO - 'cart']}, 08:05:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'talos_options': ['--disable-e10s'], 08:05:36 INFO - 'tests': ['tp5o']}, 08:05:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'tests': ['tp5o']}, 08:05:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'talos_options': ['--disable-e10s', 08:05:36 INFO - '--xperf_path', 08:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:36 INFO - 'tests': ['tp5n']}, 08:05:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:36 INFO - 'talos_options': ['--xperf_path', 08:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:36 INFO - 'tests': ['tp5n']}}, 08:05:36 INFO - 'talos.zip': {'path': '', 08:05:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:36 INFO - Running post-action listener: _resource_record_post_action 08:05:36 INFO - [mozharness: 2016-08-08 15:05:36.430873Z] Finished populate-webroot step (success) 08:05:36 INFO - [mozharness: 2016-08-08 15:05:36.430962Z] Running create-virtualenv step. 08:05:36 INFO - Running pre-action listener: _resource_record_pre_action 08:05:36 INFO - Running main action method: create_virtualenv 08:05:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:36 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 08:05:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:36 INFO - Using real prefix '/usr' 08:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:38 INFO - Installing pip.................done. 08:05:38 INFO - Return code: 0 08:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:39 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 08:05:39 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 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 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 08:05:39 INFO - Cleaning up... 08:05:39 INFO - Return code: 0 08:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:39 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 08:05:39 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 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 INFO - Downloading/unpacking psutil>=3.1.1 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:41 INFO - Installing collected packages: psutil 08:05:41 INFO - Running setup.py install for psutil 08:05:41 INFO - building 'psutil._psutil_linux' extension 08:05:41 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 08:05:41 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 08:05:41 INFO - building 'psutil._psutil_posix' extension 08:05:41 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 08:05:41 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 08:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:41 INFO - Successfully installed psutil 08:05:41 INFO - Cleaning up... 08:05:41 INFO - Return code: 0 08:05:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:41 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:41 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 08:05:41 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 08:05:41 INFO - Using env: {'DISPLAY': ':0', 08:05:41 INFO - 'HOME': '/home/cltbld', 08:05:41 INFO - 'LANG': 'en_US.UTF-8', 08:05:41 INFO - 'LANGUAGE': 'en_US:en', 08:05:41 INFO - 'LOGNAME': 'cltbld', 08:05:41 INFO - 'MAIL': '/var/mail/cltbld', 08:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:41 INFO - 'MOZ_NO_REMOTE': '1', 08:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:41 INFO - 'NO_EM_RESTART': '1', 08:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:41 INFO - 'PWD': '/builds/slave/test', 08:05:41 INFO - 'SHELL': '/bin/bash', 08:05:41 INFO - 'SHLVL': '1', 08:05:41 INFO - 'TERM': 'linux', 08:05:41 INFO - 'TMOUT': '86400', 08:05:41 INFO - 'USER': 'cltbld', 08:05:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:41 INFO - '_': '/tools/buildbot/bin/python'} 08:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:42 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 08:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:44 INFO - Installing collected packages: mozsystemmonitor 08:05:44 INFO - Running setup.py install for mozsystemmonitor 08:05:44 INFO - Successfully installed mozsystemmonitor 08:05:44 INFO - Cleaning up... 08:05:44 INFO - Return code: 0 08:05:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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', '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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05: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 jsonschema==2.5.1 08:05:44 INFO - Using env: {'DISPLAY': ':0', 08:05:44 INFO - 'HOME': '/home/cltbld', 08:05:44 INFO - 'LANG': 'en_US.UTF-8', 08:05:44 INFO - 'LANGUAGE': 'en_US:en', 08:05:44 INFO - 'LOGNAME': 'cltbld', 08:05:44 INFO - 'MAIL': '/var/mail/cltbld', 08:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:44 INFO - 'MOZ_NO_REMOTE': '1', 08:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:44 INFO - 'NO_EM_RESTART': '1', 08:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:44 INFO - 'PWD': '/builds/slave/test', 08:05:44 INFO - 'SHELL': '/bin/bash', 08:05:44 INFO - 'SHLVL': '1', 08:05:44 INFO - 'TERM': 'linux', 08:05:44 INFO - 'TMOUT': '86400', 08:05:44 INFO - 'USER': 'cltbld', 08:05:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:44 INFO - '_': '/tools/buildbot/bin/python'} 08:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:46 INFO - warning: no files found matching '*.txt' 08:05:46 INFO - no previously-included directories found matching 'build' 08:05:46 INFO - no previously-included directories found matching 'dist' 08:05:46 INFO - no previously-included directories found matching '.git*' 08:05:46 INFO - Installing collected packages: jsonschema, functools32 08:05:46 INFO - Running setup.py install for functools32 08:05:46 INFO - warning: no files found matching '*.txt' 08:05:46 INFO - no previously-included directories found matching 'build' 08:05:46 INFO - no previously-included directories found matching 'dist' 08:05:46 INFO - no previously-included directories found matching '.git*' 08:05:46 INFO - Successfully installed jsonschema functools32 08:05:46 INFO - Cleaning up... 08:05:46 INFO - Return code: 0 08:05:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:05:46 INFO - Using env: {'DISPLAY': ':0', 08:05:46 INFO - 'HOME': '/home/cltbld', 08:05:46 INFO - 'LANG': 'en_US.UTF-8', 08:05:46 INFO - 'LANGUAGE': 'en_US:en', 08:05:46 INFO - 'LOGNAME': 'cltbld', 08:05:46 INFO - 'MAIL': '/var/mail/cltbld', 08:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:46 INFO - 'MOZ_NO_REMOTE': '1', 08:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:46 INFO - 'NO_EM_RESTART': '1', 08:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:46 INFO - 'PWD': '/builds/slave/test', 08:05:46 INFO - 'SHELL': '/bin/bash', 08:05:46 INFO - 'SHLVL': '1', 08:05:46 INFO - 'TERM': 'linux', 08:05:46 INFO - 'TMOUT': '86400', 08:05:46 INFO - 'USER': 'cltbld', 08:05:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:46 INFO - '_': '/tools/buildbot/bin/python'} 08:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:05:47 INFO - Cleaning up... 08:05:47 INFO - Return code: 0 08:05:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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', '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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05: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 blobuploader==1.2.4 08:05:47 INFO - Using env: {'DISPLAY': ':0', 08:05:47 INFO - 'HOME': '/home/cltbld', 08:05:47 INFO - 'LANG': 'en_US.UTF-8', 08:05:47 INFO - 'LANGUAGE': 'en_US:en', 08:05:47 INFO - 'LOGNAME': 'cltbld', 08:05:47 INFO - 'MAIL': '/var/mail/cltbld', 08:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:47 INFO - 'MOZ_NO_REMOTE': '1', 08:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:47 INFO - 'NO_EM_RESTART': '1', 08:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:47 INFO - 'PWD': '/builds/slave/test', 08:05:47 INFO - 'SHELL': '/bin/bash', 08:05:47 INFO - 'SHLVL': '1', 08:05:47 INFO - 'TERM': 'linux', 08:05:47 INFO - 'TMOUT': '86400', 08:05:47 INFO - 'USER': 'cltbld', 08:05:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:47 INFO - '_': '/tools/buildbot/bin/python'} 08:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:49 INFO - Downloading docopt-0.6.1.tar.gz 08:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:49 INFO - Running setup.py install for blobuploader 08:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:49 INFO - Running setup.py install for requests 08:05:50 INFO - Running setup.py install for docopt 08:05:50 INFO - Successfully installed blobuploader requests docopt 08:05:50 INFO - Cleaning up... 08:05:50 INFO - Return code: 0 08:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:50 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')]} 08:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:50 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')]} 08:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:50 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:50 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 08:05:50 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 08:05:50 INFO - Using env: {'DISPLAY': ':0', 08:05:50 INFO - 'HOME': '/home/cltbld', 08:05:50 INFO - 'LANG': 'en_US.UTF-8', 08:05:50 INFO - 'LANGUAGE': 'en_US:en', 08:05:50 INFO - 'LOGNAME': 'cltbld', 08:05:50 INFO - 'MAIL': '/var/mail/cltbld', 08:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:50 INFO - 'MOZ_NO_REMOTE': '1', 08:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:50 INFO - 'NO_EM_RESTART': '1', 08:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:50 INFO - 'PWD': '/builds/slave/test', 08:05:50 INFO - 'SHELL': '/bin/bash', 08:05:50 INFO - 'SHLVL': '1', 08:05:50 INFO - 'TERM': 'linux', 08:05:50 INFO - 'TMOUT': '86400', 08:05:50 INFO - 'USER': 'cltbld', 08:05:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:50 INFO - '_': '/tools/buildbot/bin/python'} 08:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:50 INFO - Running setup.py (path:/tmp/pip-fgKHaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:50 INFO - Running setup.py (path:/tmp/pip-CHkglT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:50 INFO - Running setup.py (path:/tmp/pip-PNywcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:50 INFO - Running setup.py (path:/tmp/pip-vOTNtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:51 INFO - Running setup.py (path:/tmp/pip-PSkpKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:51 INFO - Running setup.py (path:/tmp/pip-kdHkUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:51 INFO - Running setup.py (path:/tmp/pip-yey3nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:51 INFO - Running setup.py (path:/tmp/pip-qkMTgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:51 INFO - Running setup.py (path:/tmp/pip-nttPjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:51 INFO - Running setup.py (path:/tmp/pip-08b8Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:51 INFO - Running setup.py (path:/tmp/pip-_VlXIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:51 INFO - Running setup.py (path:/tmp/pip-cWPHVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:51 INFO - Running setup.py (path:/tmp/pip-FaoZQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:51 INFO - Running setup.py (path:/tmp/pip-uKJgOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:51 INFO - Running setup.py (path:/tmp/pip-Vn22sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:51 INFO - Running setup.py (path:/tmp/pip-nLyrek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:51 INFO - Running setup.py (path:/tmp/pip-nD7nwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:51 INFO - Running setup.py install for manifestparser 08:05:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for mozcrash 08:05:52 INFO - Running setup.py install for mozdebug 08:05:52 INFO - Running setup.py install for mozdevice 08:05:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for mozfile 08:05:52 INFO - Running setup.py install for mozhttpd 08:05:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for mozinfo 08:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for mozInstall 08:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for mozleak 08:05:52 INFO - Running setup.py install for mozlog 08:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:52 INFO - Running setup.py install for moznetwork 08:05:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Running setup.py install for mozprocess 08:05:53 INFO - Running setup.py install for mozprofile 08:05:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Running setup.py install for mozrunner 08:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Running setup.py install for mozscreenshot 08:05:53 INFO - Running setup.py install for moztest 08:05:53 INFO - Running setup.py install for mozversion 08:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:53 INFO - Cleaning up... 08:05:53 INFO - Return code: 0 08:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:53 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')]} 08:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:53 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')]} 08:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:53 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:53 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 08:05:53 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 08:05:53 INFO - Using env: {'DISPLAY': ':0', 08:05:53 INFO - 'HOME': '/home/cltbld', 08:05:53 INFO - 'LANG': 'en_US.UTF-8', 08:05:53 INFO - 'LANGUAGE': 'en_US:en', 08:05:53 INFO - 'LOGNAME': 'cltbld', 08:05:53 INFO - 'MAIL': '/var/mail/cltbld', 08:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:53 INFO - 'MOZ_NO_REMOTE': '1', 08:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:53 INFO - 'NO_EM_RESTART': '1', 08:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:53 INFO - 'PWD': '/builds/slave/test', 08:05:53 INFO - 'SHELL': '/bin/bash', 08:05:53 INFO - 'SHLVL': '1', 08:05:53 INFO - 'TERM': 'linux', 08:05:53 INFO - 'TMOUT': '86400', 08:05:53 INFO - 'USER': 'cltbld', 08:05:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:53 INFO - '_': '/tools/buildbot/bin/python'} 08:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:53 INFO - Running setup.py (path:/tmp/pip-gi0QEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:54 INFO - Running setup.py (path:/tmp/pip-4lZkVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:54 INFO - Running setup.py (path:/tmp/pip-T2oSKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:54 INFO - Running setup.py (path:/tmp/pip-EF83xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:54 INFO - Running setup.py (path:/tmp/pip-yIetKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:54 INFO - Running setup.py (path:/tmp/pip-93HL4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:54 INFO - Running setup.py (path:/tmp/pip-mIGGAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:54 INFO - Running setup.py (path:/tmp/pip-cOT3RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:54 INFO - Running setup.py (path:/tmp/pip-XS5Y9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:54 INFO - Running setup.py (path:/tmp/pip-xEy4on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:54 INFO - Running setup.py (path:/tmp/pip-J6WuHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:54 INFO - Running setup.py (path:/tmp/pip-4ymhNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:54 INFO - Running setup.py (path:/tmp/pip-gYEaxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:54 INFO - Running setup.py (path:/tmp/pip-Ddw5wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:54 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)) 08:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:54 INFO - Running setup.py (path:/tmp/pip-PDzyAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:55 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)) 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:55 INFO - Running setup.py (path:/tmp/pip-_CGrd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:55 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)) 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:55 INFO - Running setup.py (path:/tmp/pip-fKuxNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:57 INFO - Downloading blessings-1.6.tar.gz 08:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:57 INFO - Installing collected packages: blessings 08:05:57 INFO - Running setup.py install for blessings 08:05:57 INFO - Successfully installed blessings 08:05:57 INFO - Cleaning up... 08:05:57 INFO - Return code: 0 08:05:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:57 INFO - Reading from file tmpfile_stdout 08:05:57 INFO - Current package versions: 08:05:57 INFO - argparse == 1.2.1 08:05:57 INFO - blessings == 1.6 08:05:57 INFO - blobuploader == 1.2.4 08:05:57 INFO - docopt == 0.6.1 08:05:57 INFO - functools32 == 3.2.3-2 08:05:57 INFO - jsonschema == 2.5.1 08:05:57 INFO - manifestparser == 1.1 08:05:57 INFO - mozInstall == 1.12 08:05:57 INFO - mozcrash == 0.17 08:05:57 INFO - mozdebug == 0.1 08:05:57 INFO - mozdevice == 0.48 08:05:57 INFO - mozfile == 1.2 08:05:57 INFO - mozhttpd == 0.7 08:05:57 INFO - mozinfo == 0.9 08:05:57 INFO - mozleak == 0.1 08:05:57 INFO - mozlog == 3.3 08:05:57 INFO - moznetwork == 0.27 08:05:57 INFO - mozprocess == 0.23 08:05:57 INFO - mozprofile == 0.28 08:05:57 INFO - mozrunner == 6.12 08:05:57 INFO - mozscreenshot == 0.1 08:05:57 INFO - mozsystemmonitor == 0.3 08:05:57 INFO - moztest == 0.7 08:05:57 INFO - mozversion == 1.4 08:05:57 INFO - psutil == 3.1.1 08:05:57 INFO - requests == 1.2.3 08:05:57 INFO - wsgiref == 0.1.2 08:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:57 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 08:05:57 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 08:05:57 INFO - Using env: {'DISPLAY': ':0', 08:05:57 INFO - 'HOME': '/home/cltbld', 08:05:57 INFO - 'LANG': 'en_US.UTF-8', 08:05:57 INFO - 'LANGUAGE': 'en_US:en', 08:05:57 INFO - 'LOGNAME': 'cltbld', 08:05:57 INFO - 'MAIL': '/var/mail/cltbld', 08:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:57 INFO - 'MOZ_NO_REMOTE': '1', 08:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:57 INFO - 'NO_EM_RESTART': '1', 08:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:57 INFO - 'PWD': '/builds/slave/test', 08:05:57 INFO - 'SHELL': '/bin/bash', 08:05:57 INFO - 'SHLVL': '1', 08:05:57 INFO - 'TERM': 'linux', 08:05:57 INFO - 'TMOUT': '86400', 08:05:57 INFO - 'USER': 'cltbld', 08:05:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:57 INFO - '_': '/tools/buildbot/bin/python'} 08:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 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)) 08:05:57 INFO - Cleaning up... 08:05:57 INFO - Return code: 0 08:05:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:57 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 0x17e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', '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 08:05:57 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 08:05:57 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 08:05:57 INFO - Using env: {'DISPLAY': ':0', 08:05:57 INFO - 'HOME': '/home/cltbld', 08:05:57 INFO - 'LANG': 'en_US.UTF-8', 08:05:57 INFO - 'LANGUAGE': 'en_US:en', 08:05:57 INFO - 'LOGNAME': 'cltbld', 08:05:57 INFO - 'MAIL': '/var/mail/cltbld', 08:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:57 INFO - 'MOZ_NO_REMOTE': '1', 08:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:57 INFO - 'NO_EM_RESTART': '1', 08:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:57 INFO - 'PWD': '/builds/slave/test', 08:05:57 INFO - 'SHELL': '/bin/bash', 08:05:57 INFO - 'SHLVL': '1', 08:05:57 INFO - 'TERM': 'linux', 08:05:57 INFO - 'TMOUT': '86400', 08:05:57 INFO - 'USER': 'cltbld', 08:05:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:57 INFO - '_': '/tools/buildbot/bin/python'} 08:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:57 INFO - Cleaning up... 08:05:57 INFO - Return code: 0 08:05:57 INFO - Running post-action listener: _resource_record_post_action 08:05:57 INFO - Running post-action listener: _start_resource_monitoring 08:05:58 INFO - Starting resource monitoring. 08:05:58 INFO - [mozharness: 2016-08-08 15:05:58.024498Z] Finished create-virtualenv step (success) 08:05:58 INFO - [mozharness: 2016-08-08 15:05:58.024935Z] Running install step. 08:05:58 INFO - Running pre-action listener: _resource_record_pre_action 08:05:58 INFO - Running main action method: install 08:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:58 INFO - Reading from file tmpfile_stdout 08:05:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:58 INFO - Reading from file tmpfile_stdout 08:05:58 INFO - Output received: 08:05:58 INFO - Usage: mozinstall [options] installer 08:05:58 INFO - Options: 08:05:58 INFO - -h, --help show this help message and exit 08:05:58 INFO - -d DEST, --destination=DEST 08:05:58 INFO - Directory to install application into. [default: 08:05:58 INFO - "/builds/slave/test"] 08:05:58 INFO - --app=APP Application being installed. [default: firefox] 08:05:58 INFO - mkdir: /builds/slave/test/build/application 08:05:58 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'] 08:05:58 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 08:06:15 INFO - Reading from file tmpfile_stdout 08:06:15 INFO - Output received: 08:06:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:06:15 INFO - Running post-action listener: _resource_record_post_action 08:06:15 INFO - [mozharness: 2016-08-08 15:06:15.658579Z] Finished install step (success) 08:06:15 INFO - [mozharness: 2016-08-08 15:06:15.658829Z] Running run-tests step. 08:06:15 INFO - Running pre-action listener: _resource_record_pre_action 08:06:15 INFO - Running main action method: run_tests 08:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:15 INFO - Python 2.7.3 08:06:15 INFO - Return code: 0 08:06:15 INFO - grabbing minidump binary from tooltool 08:06:15 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')]} 08:06:15 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 0x1a9f3b0>, '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 0x1aa02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:15 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 08:06:15 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 08:06:15 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 08:06:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:15 INFO - Return code: 0 08:06:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:15 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:06:15 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:06:15 INFO - Using env: {'DISPLAY': ':0', 08:06:15 INFO - 'HOME': '/home/cltbld', 08:06:15 INFO - 'LANG': 'en_US.UTF-8', 08:06:15 INFO - 'LANGUAGE': 'en_US:en', 08:06:15 INFO - 'LOGNAME': 'cltbld', 08:06:15 INFO - 'MAIL': '/var/mail/cltbld', 08:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:15 INFO - 'MOZ_NO_REMOTE': '1', 08:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:15 INFO - 'NO_EM_RESTART': '1', 08:06:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:15 INFO - 'PWD': '/builds/slave/test', 08:06:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:15 INFO - 'SHELL': '/bin/bash', 08:06:15 INFO - 'SHLVL': '1', 08:06:15 INFO - 'TERM': 'linux', 08:06:15 INFO - 'TMOUT': '86400', 08:06:15 INFO - 'USER': 'cltbld', 08:06:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604', 08:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:15 INFO - '_': '/tools/buildbot/bin/python'} 08:06:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:06:15 INFO - mozversion application_buildid: 20160808053006 08:06:15 INFO - mozversion application_changeset: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 08:06:15 INFO - mozversion application_display_name: Nightly 08:06:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:15 INFO - mozversion application_name: Firefox 08:06:15 INFO - mozversion application_remotingname: firefox 08:06:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:15 INFO - mozversion application_vendor: Mozilla 08:06:15 INFO - mozversion application_version: 51.0a1 08:06:15 INFO - mozversion platform_buildid: 20160808053006 08:06:15 INFO - mozversion platform_changeset: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 08:06:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:15 INFO - mozversion platform_version: 51.0a1 08:06:15 INFO - using testdate: 1470668775 08:06:15 INFO - actual date: 1470668775 08:06:15 INFO - starting webserver on 'localhost:55757' 08:06:15 INFO - SUITE-START | Running 2 tests 08:06:15 INFO - TEST-START | dromaeo_css 08:06:15 INFO - operating with platform_type : linux_ 08:06:15 INFO - Initialising browser for dromaeo_css test... 08:06:15 INFO - TEST-INFO | started process 5995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcm72V/profile http://localhost:55757/getInfo.html) 08:06:20 INFO - PROCESS | 5995 | __metrics Screen width/height:1600/1200 08:06:20 INFO - PROCESS | 5995 | colorDepth:24 08:06:20 INFO - PROCESS | 5995 | Browser inner width/height: 1024/697 08:06:20 INFO - PROCESS | 5995 | __metrics 08:06:21 INFO - PROCESS | 5995 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:21 INFO - PROCESS | 5995 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:22 INFO - TEST-INFO | 5995: exit 0 08:06:22 INFO - Browser initialized. 08:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:22 INFO - TEST-INFO | started process 6073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcm72V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:33 INFO - PROCESS | 6073 | RSS: Main: 156635136 08:06:33 INFO - PROCESS | 6073 | 08:07:24 INFO - PROCESS | 6073 | 1470668844725 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] 08:09:35 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55757/tests/dromaeo/cssquery-ext.html) 08:09:36 INFO - PROCESS | 6073 | RSS: Main: 269197312 08:09:36 INFO - PROCESS | 6073 | 08:12:38 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-ext.html (next: http://localhost:55757/tests/dromaeo/cssquery-jquery.html) 08:12:39 INFO - PROCESS | 6073 | RSS: Main: 242728960 08:12:39 INFO - PROCESS | 6073 | 08:15:41 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55757/tests/dromaeo/cssquery-mootools.html) 08:15:41 INFO - PROCESS | 6073 | RSS: Main: 185876480 08:15:41 INFO - PROCESS | 6073 | 08:18:44 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55757/tests/dromaeo/cssquery-prototype.html) 08:18:44 INFO - PROCESS | 6073 | RSS: Main: 217829376 08:18:44 INFO - PROCESS | 6073 | 08:21:47 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55757/tests/dromaeo/cssquery-yui.html) 08:21:47 INFO - PROCESS | 6073 | RSS: Main: 185163776 08:21:47 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | Cycle 1(1): loaded http://localhost:55757/tests/dromaeo/cssquery-yui.html (next: http://localhost:55757/tests/dromaeo/cssquery-dojo.html) 08:24:51 INFO - PROCESS | 6073 | RSS: Main: 289783808 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | __start_tp_report 08:24:51 INFO - PROCESS | 6073 | _x_x_mozilla_page_load 08:24:51 INFO - PROCESS | 6073 | _x_x_mozilla_page_load_details 08:24:51 INFO - PROCESS | 6073 | |i|pagename|runs| 08:24:51 INFO - PROCESS | 6073 | |0;dojo.html;3066.172133523948;3089.7682673799472;3109.626844778626;3117.9710695470485;3132.3422081362914;5252.737363131847;5262.631615786887;5298.523132918037;5387.326584176978;5440.945590544094;5262.684238945666;5305.0450918834595;5325.520703136717;5369.4362091980265;5398.48714372135;4729.10147072056;4820.517948205186;4833.10587541306;4845.588125009378;5046.24306354048;4952.034353301107;4958.776855041532;4991.550760431561;5005.1491246488185;5007.924881126786;4788.257820037899;4809.086273608038;4819.397575303087;4849.854504364839;4889.804407823683;4811.422629284508;4816.807327706888;4823.951760482385;4873.415190177166;4911.50884911506;4837.4920633333695;4869.172240719051;4880.219164933594;4906.828261010847;4935.950640493585;5186.559142472895;5274.340707411574;5358.517733404013;5385.542228910547;5440.265564148868;5699.487046165865;5707.086866101404;5741.598088133832;5749.195112684228;5753.597248192628;5785.016547186946;5793.594448388572;5796.13058041293;5799.3620701722775;5799.971000145015;5175.741212939376;5283.1546952487415;5301.125314323093;5321.946780532146;5374.838754837361;5843.444872737083;5844.795432159854;5850.180974663551;5891.410858914074;5899.911501327483;5656.321241451053;5658.547316214693;5696.174054762037;5706.087026075808;5706.115552089433;5571.777128914879;5609.915851262234;5635.323761148688;5660.037793575102;5785.334686511021;5694.9430505695245;5699.5725320600295;5702.629329093678;5702.6863522506665;5742.224799652077;5654.236678048493;5700.771969121189;5707.771689132472;5714.428557144335;5716.514096301861;4254.851080212177;4362.978185109054;4372.994211331412;4388.166248412791;4394.157744877524;3929.351656976567;3931.5478719947573;3939.684825213976;3974.7615143091507;3977.8607748728655;5430.70131142791;5433.26650902131;5434.375046869582;5479.75341109651;5499.615026948155;5603.2435621191435;5645.322561292671;5678.318601767732;5691.345495268097;5735.971320143372;5423.050966080999;5425.26758887553;5429.701366424884;5430.049741295257;5439.728013599304;4917.950820491749;4926.926096108561;4927.285543596158;4927.975360123177;4972.90054198914;5816.272965879265;5934.8813023739285;5942.61373010753;5980.162777211107;5987.88024239504;5753.280839895013;5758.3090029196765;5758.856028599319;5761.135829625589;5797.246357973605;5991.340952495135;6000.219971403864;6002.0996850472775;6005.579609427298;6011.428914253139;5430.918536222039;5577.498025177753;5586.078297080936;5607.07483265273;5645;5709;5748.109043098327;5753.626014309057;5757.481826635623;5791.420857914175;5602.13166959122;5608.859778505407;5612.045952188219;5621.381648018796;5624.156376543551;5450.618456707993;5557;5574.665520068809;5598.916016259841;5599.300087489064;5550.9444905552045;5558.416366281483;5567.498925096761;5568.053430916835;5599;5645.040343141758;5647.6893770843;5693.800716975052;5707.143928410605;5710.685912274865;5362.436944120967;5362.785488580413;5439.619226654097;5471.151971444432;5533.2253484513 08:24:51 INFO - PROCESS | 6073 | |1;ext.html;573.5870173475097;589.1280904261693;607.6323824086425;618.3105836991756;620.22162186456;43708.56291437085;45294.320585191206;45323.77338113313;48712.75643621786;48760.26859597109;45300.773496132555;45645;45693.314600281024;45809;45933.311000334936;8963.910360896389;9109.134632209963;9119.680811171611;9120.954395228047;9122.315826313019;8984.955075224614;9070.501122438263;9079.273658107368;9082.09179082093;9085.046070162603;9072.09279072094;9121.45271283725;9122.133397327243;9125.22435592972;9127.178553930178;9022.052684468135;9039.276857851357;9051.909480905173;9056.637734490612;9060.501672408014;9030.593623286968;9076.591553380047;9096.226820720247;9111.544422778834;9111.908880911238;43279.35080973788;43378.56621433777;43503.34744978828;43651.34522982158;43784.12431751379;3270.411325961326;3353.7149342305934;3481.860725570974;3520.806355650438;3695.334839728848;32395.676043239502;33035.834820825985;33511;33552.32895342104;33561;4023.6579890709327;4106.507219133693;4122.072533679928;4151.750894946313;4262.25410553152;343847.2807635971;343888;346422;347663;347704;58609.4139058604;59042;59239;59252.70373648104;59327.406725933055;62318.688406557674;62444.06333904995;62522.68738656278;62536.687316563126;62546;16440.260188291555;16696.916515417346;16699;16701.83298167027;16712.498625041026;11289.20975531705;11622.593209237637;11633.941830290963;11887.821682674767;12372;15916;16519.421820236475;16532.83467165337;17176.484705458606;17284.567885802957;4198.492848720978;6280.717367718464;6582.275949645536;6681.064650948871;6727.730890764413;880.8722735203488;1018.2312354172552;1033.7260625934134;1165.9681182153686;1187.5784096645739;33730.15674608154;33949.66050339514;34310.82844585761;34387.31225375478;34868.302633947176;1074.983875241872;1088.6081010836092;1094.4473041114186;1155.9595414160465;1229.7970834812156;17381.478555643353;17534.561635959202;17644.647107057786;17866.28534858617;17950.19224134917;579494;583671;584089;584923;588311;61286.69356653188;62032.06951895725;62067.68966155231;62150.378496215366;62215.688921555105;1186.9169158158845;1251.4055823483773;1311.1608570514877;1314.2508770001007;1354.8103265542832;33455.49816752799;34811.825940870134;35125;35191.824040879634;35402.46896296506;52205.47794522006;52898.471015290896;52958.73520632372;52990;53011;417386;419078;419106;419121;419616;28807.42385152243;30021.69978300189;30080.097597072123;31133.221669458446;31152.844235779583;49004.50995490142;49249;49561;49764.751176245336;50936.74531627318;41089;41520;42106;43531.564684354016;43541.346879797464;41736;41837.22772080024;42653.30965257124;42828.14343713171;43355.78322108369;41547.58452415437;42001.78999104985;42215.788921055195;42229.15541689211;42266.788666056476;35309.47035794517;37493.81253093717;37904.810475947445;38518.80740596279;38934.805325974325;28564.857175713987;28767.568486473137;28861;28879.133625991253;29069.273268168465 08:24:51 INFO - PROCESS | 6073 | |2;jquery.html;377.1006150331462;390.46311321932325;403.18958892625824;404.50650206747764;420.56891686021845;14127.646808829772;18008.45974620762;19752.506187345323;20026.999999999964;20046.398608041764;19716.21135154592;19954.201831926704;19960.800391996076;20147.09338079786;20256.189752409922;5510.366307874606;5581.2186293918885;5741.311042674884;5785.884282314351;5788.971055144719;5712.285964254468;5722.084466485363;5757.65454072757;5782.479576838084;5784.4504772046585;5561.916571251434;5710.7715691372505;5749.108888122327;5757.510611598019;5775.364709881909;5741.655500669973;5765.990951583456;5767.423257674241;5785;5792.333881603628;4881.4630390657;5129.666571672867;5152;5182.559482443997;5207.453217412193;13058.151220170754;13276.203427794268;13284.136531125447;19573.902130489256;23826;2080.0431801371387;2238;2302.6167916206814;2701.6352792372973;2890.580865774472;9202.585883635253;9698.836139663215;9896.703098907044;10036.498175091216;10217.182625390025;1795.5780391607962;1864.6736821056397;1880.69908814589;1906.2756152662039;1940.3596813051659;80537.59731201307;81661;82135.17864821335;82443.58778206131;89192;11105.611303604497;11106.167037472222;11279.830802537968;11280.492377842853;11287;15798;15817.762733559006;15864.365425383086;15876.52370428889;15878.761818572731;7864.331531819745;8118.715844945398;8148.959255203805;8152.4293299469655;8226.62980165882;7718.922810771933;7756.146823849372;7915.683372665144;7923.881141782877;8020.679172833022;4728.881777955578;4773.785179666923;4850.975745121323;4867.780949857265;4962.9007419851405;1968.6948522978962;1972.8125828046313;1998.8201061904208;2032.3801240621751;2056.897155142237;888.7778055486128;919.8850143732034;1036.9222308326905;1065.8454524093963;1088.1729885287239;19027.429177124708;20134.093965771575;20148.496287592636;20197.59604807925;20306;939.5912777941618;965.3483898368573;987.437160818341;987.5309228116587;1042.2860340666668;10978.890211097787;11300.660980170607;11326.207165498336;11333.093352531943;11352.94323528377;458218;467351;467720;467931;470082;91359.5432022849;92400.53799731092;94195.52902235444;96990;97978;979.2704435195682;1031.8194315994672;1033.1837848100067;1047.863777708893;1050.4800123938699;17808.821911781233;18420.631587368447;18916.243350266384;18926.52683682919;18955.620887581896;46739.766301168274;46886.76556617195;46952;47647;48477;63071;63821.68089159524;64185.35814641794;65833.34166658272;66978.33021669721;7975.322097621767;8384.958075209584;8385.28725058377;8404.915950840414;8617.741467755977;8902.42134261271;13130.127785795208;13666.316684165553;13708.383122759698;14102.36539355711;11085.722856928642;11834.76330473403;11918.344491053076;12301.261924284572;12360.81458778137;11594.47824847867;11640.417979101181;11841.407929603312;11889;12441.93779031099;6068.757249710139;9266.907330926604;9649.903500965182;11672.474738636613;12385.876141238832;8384.496930184208;8461.196186362286;8659.350548708999;8950.597223124845;9005.909940900507;11784.234024788362;11855.34795586251;12230.205036672587;12301.815472767737;12335.198212116184 08:24:51 INFO - PROCESS | 6073 | |3;mootools.html;1318.288124412817;1451.1220711469562;1537.4311504743243;1648.48896841979;1832.9725054124183;8820.250278726307;9207.953960230197;9285;9523.523823808817;9526.285528585366;9285.442873427599;9310.394824336414;9348.345615806897;9413.905860941388;9414;2418.4800267942387;2453.6196889482158;2475.5420247254315;2475.5420247254315;2475.900963961439;2383.8688872112025;2496.950060998779;2502.887370068351;2505.34860936157;2510.2469259222253;2413.9155129570468;2415.408224984881;2420.334408037786;2429.9514009719796;2434.573949558829;2370.8458950168356;2407.1935901473025;2409.771071748181;2425.3087869957153;2427.1990243219693;2291.7937385635205;2340.414896275931;2347.5657003454417;2350.4358953851124;2356.3166681662296;9075.63697452101;9252.398594091363;9270.582823772946;9332.626694932194;9379.577918993662;5307.946920530784;5479.287692599936;5550.86122846928;5557.5831812614215;5557.694326812024;3409.829508524564;3422.5892892853017;3484.111551554363;3494.4583589543663;3505.263894582141;1065.206421216191;1071.9142468602572;1073.8228192348254;1090.231386872253;1091.0998426298256;12998.480060797558;13108.934455327662;13194.208347499181;13231.933840330834;13257.072004959657;4709.920111688502;4726.550977657117;4892.779824907888;4940.333055037524;5063.113955057924;11153;11173.608923687632;11188.440577971232;11188.496517656726;11191.384473854016;5546.140348246028;5561.416051314634;5568.610197286151;5571;5578.693171875586;4524.343970124313;4589.059242855206;4647.837325693585;5068.594512438996;5104.387473503203;4069.7965101744794;4102.78431104649;4176.979115104405;4202.789860507023;4245.235857545671;1324.3510679767037;1361.7548841208677;1363.9931800341133;1371.6296599918167;1379.9931000345134;876.54419701756;881.1849039638437;891.5497673674753;911.2436677557612;911.4986757283467;5964.880702385928;6005.3694362091355;6097.664628445389;6114.38856114385;6298.338674439209;430.18265295937346;432.3946474935053;439.5253126623239;463.6777439679458;464.9767511624473;4132.483439570054;4214.957850421518;4229.788510574521;4252.957470425256;4321.546237645002;11361.14791390649;11860.881391185978;11890.762184756257;11893.04855611549;11896.405179740977;11731.41342932867;11732.882671173349;11748.88251117495;11787.174897757246;11800.232984855957;8650.826983460296;8679.609417576225;8740;8746.737597872074;8750.86873696895;5989.101634754822;6077.726502307495;6107.877842443215;6172.290186628596;6185.41238582334;10738.248322617654;10779.083777878654;10807.729806754895;10827.891721082688;10954.178436617127;9092.181703646704;9795.657151999645;10751.301165424222;10888.40113793749;10989.395583242998;7893.644785984529;8191.631376588187;8220.273742514139;8226.136255693065;8255.752327430188;7988.400869934894;8212.425130241065;8213.917860821315;8277.83444331122;8282.006159260927;7500.437467189873;7592.240775922584;7599.316061554487;7602.771916842504;7714.575698336421;7245.456590755609;7359.411247100326;7371.520851144658;7443.627818609156;7462.664180111799;6856.657167141722;7140.964295178491;7141.143062832493;7142.928570714226;7147;5037.2695959084995;5136.280920671184;5261.816091379409;5330.520253177233;5376.086065368975;5236.738163091754;5287.709175995357;5293.232481290114;5390;5513.917291240715 08:24:51 INFO - PROCESS | 6073 | |4;prototype.html;302.4012455338431;311.21418418493306;319.7601798651012;321.73456898059106;323.5147279081378;5240.266362709223;5283.762230699618;5289.338832645919;5298.841034768959;5309.654872433299;4934.383202099738;4956.504349565051;5032.849014529561;5087.287779710834;5196.610254230929;4008.9398659020067;4036.091879327157;4040.2323558523785;4056.553779084298;4070.959290407088;4061.614146656063;4066.146109317047;4109.239790638727;4117.547069822317;4122.381642753596;3876.6511014008734;3888.202918401721;3989.2819292527333;4023.4769479967563;4041.393790931369;4015.19696060789;4029.798510074514;4042.333015052513;4046.271671099201;4062.7156099073077;3608.386574282378;3609.4946707460977;3610.277944411102;3610.5125808015846;3614.3132804767274;4811.278308253755;5093.567046801027;5103.56619687327;5103.642745007851;5128.307678463434;4628.213203755336;4628.32889231063;4639.559241872017;4648.604868586174;4658.161530924433;5360.249565060894;5411;5412.972935135299;5420.593455490814;5435.537979271767;3810.3522401191863;3930.960690393088;3970.68234541236;3980.383040628707;3993.1614360984227;5550.474534087021;5557.5831812614215;5613.10190369543;5631.662100273997;5635.182408795602;4046.9595304046584;4055.986003499125;4061.918761624751;4064.9390259145543;4078.653314468244;4014.237294913957;4120.484939382577;4135.979320103441;4136.420901073852;4139.77231252284;4602.493725690171;4605.677602567788;4617.607503362185;4663.230566956482;4700.294955756595;5400.6498375406145;5406.972965135228;5412.07994640912;5438.374586922476;5462.8361149165585;1405.1639274631577;1414.8655877691808;1416.2989320286524;1424.522784867081;1425.9804239968264;942.5664194470484;979.490664854286;981.3572110267786;987.7431867714303;990.7869807991173;5192.714400707921;5210.270562121306;5215.504527069922;5239.921401178985;5275.920861187085;5530.723463826793;5535.889282214333;5554.91667624986;5605.271314729059;5613.971930140323;5159.329287192641;5179.290834024763;5223.503767142115;5236.266922630834;5273.894522109613;2916.5271537873236;2921.1236629011637;2934.5744866994164;2958.2694123937736;2961.2892905702474;5680.431956804369;5765.711714414347;5775.220345253337;5824.242848429677;5852.853678658068;5601.831945041656;5620.4660557247;5626.240457538262;5631.802886898939;5672.688002159838;5726.856828579319;5746.396628353963;5747.166660834156;5816.243888294494;5816.680082595498;5384.6230763847725;5468.890622187613;5496.725163741877;5509.917351239815;5562.471565201299;5412.702301373305;5412.864678383072;5420.349558053059;5458.1266997280245;5472.589555783253;5485.835424937259;5723.399043100415;5730.341010783646;5794.739236734273;5810.053632033148;4012.277789997828;4018.1361007383553;4022.778747168934;4031.193761247821;4055.6755459563756;5361.043219225033;5495.203195536545;5558.694271814928;5562.582806289463;5606.355269143937;5355.277037599874;5379.838604841861;5428.212909128075;5436.646617969819;5447.863803404946;5374.543163831118;5375.5162035417;5405.8107966221;5411.242426060433;5449.754761035683;5134.589232861437;5363.436839131835;5370.704611246419;5396.730163491731;5410.83767486976;5387.0572649785345;5402.162664786964;5407.621466497308;5416.7020813855615;5426.186072089218;5101.709397438705;5328.333958255218;5350.7425754948335;5353.197020446964;5357.276767636319 08:24:51 INFO - PROCESS | 6073 | |5;yui.html;657.6284399314387;660.9239937407193;691.4848437913754;706.8833642448997;755.0373274075553;15037.699246015087;16122.83877161228;16341.918290408532;16344;16384.672306553875;15307.158106304149;15923.442679506219;16054.1170235637;16094.83905160948;16223.432179873676;812.5896422306741;832.2592892325835;835.578033093287;836.9121242269565;837.0624900111883;668.9665516724168;800.9038915330168;832.9083800781909;833.5207255827893;836.9874451883227;878.1481962496368;878.1525827576387;878.2798105553449;879.7228872905047;879.9516026618534;871.6905498547987;876.5047748022411;876.6142897125244;876.8202518483728;876.8991565969932;507.0619354194747;613.4601550635413;626.8401557602782;632.8924082905917;633.1452539072262;14821.77767333491;14834.184119873511;14870.479533216285;14874.925625371803;14875.776863347059;13840.723185536233;14329.49846755369;14775.778363324558;14808.851911480855;15026.849731502654;13454.610592520441;13529.052966292364;13560.660983475393;13842;13849;4417.757023363713;4474.619657329131;4524.366588677588;4536.183486972343;4542.250528662767;86833.56583217107;87183;88696;89022;89340;11084.501197446134;11381.260218085798;11408.88591114095;11418.257813242113;11468.54125834974;21690.50559185682;21800.563988720136;21818.672719909213;21841.453963651034;21844.78155218459;7918.683252669944;8193.180681931879;8201.056878458934;8285.171482851667;8315.584220788936;4877.439094504107;4880.975595122072;5049.84850454487;5056.6713163644245;5190.325257716473;3442.3287458945265;3555.6088830228655;3587.9103022424647;3587.982060089683;3598.3163198992106;653.2128784814382;655.0861548140317;664.7839452178061;665.9800205993828;670.8490589617395;699.51034276007;715.2132654080574;746.2127455534463;772.7179579453459;778.9532628042335;9140;9523.476208808583;9665.130138287588;9758.756031099138;9915.069133824598;601.0891020363553;606.3239487970881;690.1442211657509;719.6473727873305;754.1252147508864;4764.213904705684;4782;4783.928241076386;4788.61691064714;4820.204666230033;127376;131630;133993;134162.3291883554;140985.29507352604;67042.32957670458;100047;110942.44528777305;111313.44343278231;111851;60065;83204.58397707973;83325.73083177958;85333.57333213295;92760;9730.12428881404;9774.82877138167;9864.753381165528;9886.110250077527;9946.950265248628;54313.18530221971;55406;55708;56148;56849.14726279192;72817.6359118201;77321;79303.60348198222;81769;82020.58989705013;12647.24116552973;12783.424745886643;12978;12981;13055.608331750063;14600.415983360546;14849.40602375893;14983.77524337114;14984;14997.17515536656;10634.946825265824;12990.35048247565;14035.368408421442;14230.857691423367;14500.492482763053;12921.612351629467;13643.386047628079;13705.520306789214;13913.58259252224;14151.858481415054;13038.043747829743;13450.394732237268;13619.727605447637;14117.929410352883;14357.353919073876;11487.616926280789;11517.424128793695;12051.216670916363;12218.327991960172;12977.610671679864;11662.94168529152;11793.764124717285;12035.398230088636;12147.817782733442;12212.69468263265 08:24:51 INFO - PROCESS | 6073 | __end_tp_report 08:24:51 INFO - PROCESS | 6073 | __start_cc_report 08:24:51 INFO - PROCESS | 6073 | _x_x_mozilla_cycle_collect,981 08:24:51 INFO - PROCESS | 6073 | __end_cc_report 08:24:51 INFO - PROCESS | 6073 | __startTimestamp1470669891254__endTimestamp 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | ------- Summary: start ------- 08:24:51 INFO - PROCESS | 6073 | Number of tests: 6 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#0] dojo.html Cycles:165 Average:5320.99 Median:5550.94 stddev:603.28 (10.9%) stddev-sans-first:578.62 08:24:51 INFO - PROCESS | 6073 | Values: 3066.2 3089.8 3109.6 3118.0 3132.3 5252.7 5262.6 5298.5 5387.3 5440.9 5262.7 5305.0 5325.5 5369.4 5398.5 4729.1 4820.5 4833.1 4845.6 5046.2 4952.0 4958.8 4991.6 5005.1 5007.9 4788.3 4809.1 4819.4 4849.9 4889.8 4811.4 4816.8 4824.0 4873.4 4911.5 4837.5 4869.2 4880.2 4906.8 4936.0 5186.6 5274.3 5358.5 5385.5 5440.3 5699.5 5707.1 5741.6 5749.2 5753.6 5785.0 5793.6 5796.1 5799.4 5800.0 5175.7 5283.2 5301.1 5321.9 5374.8 5843.4 5844.8 5850.2 5891.4 5899.9 5656.3 5658.5 5696.2 5706.1 5706.1 5571.8 5609.9 5635.3 5660.0 5785.3 5694.9 5699.6 5702.6 5702.7 5742.2 5654.2 5700.8 5707.8 5714.4 5716.5 4254.9 4363.0 4373.0 4388.2 4394.2 3929.4 3931.5 3939.7 3974.8 3977.9 5430.7 5433.3 5434.4 5479.8 5499.6 5603.2 5645.3 5678.3 5691.3 5736.0 5423.1 5425.3 5429.7 5430.0 5439.7 4918.0 4926.9 4927.3 4928.0 4972.9 5816.3 5934.9 5942.6 5980.2 5987.9 5753.3 5758.3 5758.9 5761.1 5797.2 5991.3 6000.2 6002.1 6005.6 6011.4 5430.9 5577.5 5586.1 5607.1 5645.0 5709.0 5748.1 5753.6 5757.5 5791.4 5602.1 5608.9 5612.0 5621.4 5624.2 5450.6 5557.0 5574.7 5598.9 5599.3 5550.9 5558.4 5567.5 5568.1 5599.0 5645.0 5647.7 5693.8 5707.1 5710.7 5362.4 5362.8 5439.6 5471.2 5533.2 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#1] ext.html Cycles:180 Average:61728.65 Median:42160.89 stddev:122273.53 (290.0%) stddev-sans-first:122530.32 08:24:51 INFO - PROCESS | 6073 | Values: 573.6 589.1 607.6 618.3 620.2 43708.6 45294.3 45323.8 48712.8 48760.3 45300.8 45645.0 45693.3 45809.0 45933.3 8963.9 9109.1 9119.7 9121.0 9122.3 8985.0 9070.5 9079.3 9082.1 9085.0 9072.1 9121.5 9122.1 9125.2 9127.2 9022.1 9039.3 9051.9 9056.6 9060.5 9030.6 9076.6 9096.2 9111.5 9111.9 43279.4 43378.6 43503.3 43651.3 43784.1 3270.4 3353.7 3481.9 3520.8 3695.3 32395.7 33035.8 33511.0 33552.3 33561.0 4023.7 4106.5 4122.1 4151.8 4262.3 343847.3 343888.0 346422.0 347663.0 347704.0 58609.4 59042.0 59239.0 59252.7 59327.4 62318.7 62444.1 62522.7 62536.7 62546.0 16440.3 16696.9 16699.0 16701.8 16712.5 11289.2 11622.6 11633.9 11887.8 12372.0 15916.0 16519.4 16532.8 17176.5 17284.6 4198.5 6280.7 6582.3 6681.1 6727.7 880.9 1018.2 1033.7 1166.0 1187.6 33730.2 33949.7 34310.8 34387.3 34868.3 1075.0 1088.6 1094.4 1156.0 1229.8 17381.5 17534.6 17644.6 17866.3 17950.2 579494.0 583671.0 584089.0 584923.0 588311.0 61286.7 62032.1 62067.7 62150.4 62215.7 1186.9 1251.4 1311.2 1314.3 1354.8 33455.5 34811.8 35125.0 35191.8 35402.5 52205.5 52898.5 52958.7 52990.0 53011.0 417386.0 419078.0 419106.0 419121.0 419616.0 28807.4 30021.7 30080.1 31133.2 31152.8 49004.5 49249.0 49561.0 49764.8 50936.7 41089.0 41520.0 42106.0 43531.6 43541.3 41736.0 41837.2 42653.3 42828.1 43355.8 41547.6 42001.8 42215.8 42229.2 42266.8 35309.5 37493.8 37904.8 38518.8 38934.8 28564.9 28767.6 28861.0 28879.1 29069.3 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#2] jquery.html Cycles:180 Average:28662.93 Median:229319.28 stddev:77263.37 (33.7%) stddev-sans-first:77450.92 08:24:51 INFO - PROCESS | 6073 | Values: 377.1 390.5 403.2 404.5 420.6 14127.6 18008.5 19752.5 20027.0 20046.4 19716.2 19954.2 19960.8 20147.1 20256.2 5510.4 5581.2 5741.3 5785.9 5789.0 5712.3 5722.1 5757.7 5782.5 5784.5 5561.9 5710.8 5749.1 5757.5 5775.4 5741.7 5766.0 5767.4 5785.0 5792.3 4881.5 5129.7 5152.0 5182.6 5207.5 13058.2 13276.2 13284.1 19573.9 23826.0 2080.0 2238.0 2302.6 2701.6 2890.6 9202.6 9698.8 9896.7 10036.5 10217.2 1795.6 1864.7 1880.7 1906.3 1940.4 80537.6 81661.0 82135.2 82443.6 89192.0 11105.6 11106.2 11279.8 11280.5 11287.0 15798.0 15817.8 15864.4 15876.5 15878.8 7864.3 8118.7 8149.0 8152.4 8226.6 7718.9 7756.1 7915.7 7923.9 8020.7 4728.9 4773.8 4851.0 4867.8 4962.9 1968.7 1972.8 1998.8 2032.4 2056.9 888.8 919.9 1036.9 1065.8 1088.2 19027.4 20134.1 20148.5 20197.6 20306.0 939.6 965.3 987.4 987.5 1042.3 10978.9 11300.7 11326.2 11333.1 11352.9 458218.0 467351.0 467720.0 467931.0 470082.0 91359.5 92400.5 94195.5 96990.0 97978.0 979.3 1031.8 1033.2 1047.9 1050.5 17808.8 18420.6 18916.2 18926.5 18955.6 46739.8 46886.8 46952.0 47647.0 48477.0 63071.0 63821.7 64185.4 65833.3 66978.3 7975.3 8385.0 8385.3 8404.9 8617.7 8902.4 13130.1 13666.3 13708.4 14102.4 11085.7 11834.8 11918.3 12301.3 12360.8 11594.5 11640.4 11841.4 11889.0 12441.9 6068.8 9266.9 9649.9 11672.5 12385.9 8384.5 8461.2 8659.4 8950.6 9005.9 11784.2 11855.3 12230.2 12301.8 12335.2 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#3] mootools.html Cycles:180 Average:6022.34 Median:4678.88 stddev:3529.75 (75.4%) stddev-sans-first:3521.95 08:24:51 INFO - PROCESS | 6073 | Values: 1318.3 1451.1 1537.4 1648.5 1833.0 8820.3 9208.0 9285.0 9523.5 9526.3 9285.4 9310.4 9348.3 9413.9 9414.0 2418.5 2453.6 2475.5 2475.5 2475.9 2383.9 2497.0 2502.9 2505.3 2510.2 2413.9 2415.4 2420.3 2430.0 2434.6 2370.8 2407.2 2409.8 2425.3 2427.2 2291.8 2340.4 2347.6 2350.4 2356.3 9075.6 9252.4 9270.6 9332.6 9379.6 5307.9 5479.3 5550.9 5557.6 5557.7 3409.8 3422.6 3484.1 3494.5 3505.3 1065.2 1071.9 1073.8 1090.2 1091.1 12998.5 13108.9 13194.2 13231.9 13257.1 4709.9 4726.6 4892.8 4940.3 5063.1 11153.0 11173.6 11188.4 11188.5 11191.4 5546.1 5561.4 5568.6 5571.0 5578.7 4524.3 4589.1 4647.8 5068.6 5104.4 4069.8 4102.8 4177.0 4202.8 4245.2 1324.4 1361.8 1364.0 1371.6 1380.0 876.5 881.2 891.5 911.2 911.5 5964.9 6005.4 6097.7 6114.4 6298.3 430.2 432.4 439.5 463.7 465.0 4132.5 4215.0 4229.8 4253.0 4321.5 11361.1 11860.9 11890.8 11893.0 11896.4 11731.4 11732.9 11748.9 11787.2 11800.2 8650.8 8679.6 8740.0 8746.7 8750.9 5989.1 6077.7 6107.9 6172.3 6185.4 10738.2 10779.1 10807.7 10827.9 10954.2 9092.2 9795.7 10751.3 10888.4 10989.4 7893.6 8191.6 8220.3 8226.1 8255.8 7988.4 8212.4 8213.9 8277.8 8282.0 7500.4 7592.2 7599.3 7602.8 7714.6 7245.5 7359.4 7371.5 7443.6 7462.7 6856.7 7141.0 7141.1 7142.9 7147.0 5037.3 5136.3 5261.8 5330.5 5376.1 5236.7 5287.7 5293.2 5390.0 5513.9 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#4] prototype.html Cycles:180 Average:4578.01 Median:5257.08 stddev:1329.47 (25.3%) stddev-sans-first:1293.88 08:24:51 INFO - PROCESS | 6073 | Values: 302.4 311.2 319.8 321.7 323.5 5240.3 5283.8 5289.3 5298.8 5309.7 4934.4 4956.5 5032.8 5087.3 5196.6 4008.9 4036.1 4040.2 4056.6 4071.0 4061.6 4066.1 4109.2 4117.5 4122.4 3876.7 3888.2 3989.3 4023.5 4041.4 4015.2 4029.8 4042.3 4046.3 4062.7 3608.4 3609.5 3610.3 3610.5 3614.3 4811.3 5093.6 5103.6 5103.6 5128.3 4628.2 4628.3 4639.6 4648.6 4658.2 5360.2 5411.0 5413.0 5420.6 5435.5 3810.4 3931.0 3970.7 3980.4 3993.2 5550.5 5557.6 5613.1 5631.7 5635.2 4047.0 4056.0 4061.9 4064.9 4078.7 4014.2 4120.5 4136.0 4136.4 4139.8 4602.5 4605.7 4617.6 4663.2 4700.3 5400.6 5407.0 5412.1 5438.4 5462.8 1405.2 1414.9 1416.3 1424.5 1426.0 942.6 979.5 981.4 987.7 990.8 5192.7 5210.3 5215.5 5239.9 5275.9 5530.7 5535.9 5554.9 5605.3 5614.0 5159.3 5179.3 5223.5 5236.3 5273.9 2916.5 2921.1 2934.6 2958.3 2961.3 5680.4 5765.7 5775.2 5824.2 5852.9 5601.8 5620.5 5626.2 5631.8 5672.7 5726.9 5746.4 5747.2 5816.2 5816.7 5384.6 5468.9 5496.7 5509.9 5562.5 5412.7 5412.9 5420.3 5458.1 5472.6 5485.8 5723.4 5730.3 5794.7 5810.1 4012.3 4018.1 4022.8 4031.2 4055.7 5361.0 5495.2 5558.7 5562.6 5606.4 5355.3 5379.8 5428.2 5436.6 5447.9 5374.5 5375.5 5405.8 5411.2 5449.8 5134.6 5363.4 5370.7 5396.7 5410.8 5387.1 5402.2 5407.6 5416.7 5426.2 5101.7 5328.3 5350.7 5353.2 5357.3 08:24:51 INFO - PROCESS | 6073 | 08:24:51 INFO - PROCESS | 6073 | [#5] yui.html Cycles:180 Average:21950.47 Median:4782.96 stddev:32551.35 (680.6%) stddev-sans-first:32603.40 08:24:51 INFO - PROCESS | 6073 | Values: 657.6 660.9 691.5 706.9 755.0 15037.7 16122.8 16341.9 16344.0 16384.7 15307.2 15923.4 16054.1 16094.8 16223.4 812.6 832.3 835.6 836.9 837.1 669.0 800.9 832.9 833.5 837.0 878.1 878.2 878.3 879.7 880.0 871.7 876.5 876.6 876.8 876.9 507.1 613.5 626.8 632.9 633.1 14821.8 14834.2 14870.5 14874.9 14875.8 13840.7 14329.5 14775.8 14808.9 15026.8 13454.6 13529.1 13560.7 13842.0 13849.0 4417.8 4474.6 4524.4 4536.2 4542.3 86833.6 87183.0 88696.0 89022.0 89340.0 11084.5 11381.3 11408.9 11418.3 11468.5 21690.5 21800.6 21818.7 21841.5 21844.8 7918.7 8193.2 8201.1 8285.2 8315.6 4877.4 4881.0 5049.8 5056.7 5190.3 3442.3 3555.6 3587.9 3588.0 3598.3 653.2 655.1 664.8 666.0 670.8 699.5 715.2 746.2 772.7 779.0 9140.0 9523.5 9665.1 9758.8 9915.1 601.1 606.3 690.1 719.6 754.1 4764.2 4782.0 4783.9 4788.6 4820.2 127376.0 131630.0 133993.0 134162.3 140985.3 67042.3 100047.0 110942.4 111313.4 111851.0 60065.0 83204.6 83325.7 85333.6 92760.0 9730.1 9774.8 9864.8 9886.1 9947.0 54313.2 55406.0 55708.0 56148.0 56849.1 72817.6 77321.0 79303.6 81769.0 82020.6 12647.2 12783.4 12978.0 12981.0 13055.6 14600.4 14849.4 14983.8 14984.0 14997.2 10634.9 12990.4 14035.4 14230.9 14500.5 12921.6 13643.4 13705.5 13913.6 14151.9 13038.0 13450.4 13619.7 14117.9 14357.4 11487.6 11517.4 12051.2 12218.3 12977.6 11662.9 11793.8 12035.4 12147.8 12212.7 08:24:51 INFO - PROCESS | 6073 | -------- Summary: end -------- 08:24:51 INFO - PROCESS | 6073 | 08:24:52 INFO - TEST-INFO | 6073: exit 0 08:24:52 INFO - TEST-OK | dromaeo_css | took 1116149ms 08:24:52 INFO - TEST-START | kraken 08:24:52 INFO - operating with platform_type : linux_ 08:24:52 INFO - Initialising browser for kraken test... 08:24:52 INFO - TEST-INFO | started process 6264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfZk_p/profile http://localhost:55757/getInfo.html) 08:24:56 INFO - PROCESS | 6264 | __metrics Screen width/height:1600/1200 08:24:56 INFO - PROCESS | 6264 | colorDepth:24 08:24:56 INFO - PROCESS | 6264 | Browser inner width/height: 1024/697 08:24:56 INFO - PROCESS | 6264 | __metrics 08:24:57 INFO - PROCESS | 6264 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:24:57 INFO - PROCESS | 6264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:58 INFO - TEST-INFO | 6264: exit 0 08:24:58 INFO - Browser initialized. 08:24:58 INFO - Running cycle 1/1 for kraken test... 08:24:58 INFO - TEST-INFO | started process 6343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfZk_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:10 INFO - PROCESS | 6343 | RSS: Main: 156602368 08:25:10 INFO - PROCESS | 6343 | 08:25:12 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55757/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:13 INFO - PROCESS | 6343 | RSS: Main: 212869120 08:25:13 INFO - PROCESS | 6343 | 08:25:16 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55757/tests/kraken/driver.html?testName=audio-dft) 08:25:16 INFO - PROCESS | 6343 | RSS: Main: 192036864 08:25:16 INFO - PROCESS | 6343 | 08:25:19 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55757/tests/kraken/driver.html?testName=audio-fft) 08:25:20 INFO - PROCESS | 6343 | RSS: Main: 268558336 08:25:20 INFO - PROCESS | 6343 | 08:25:22 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55757/tests/kraken/driver.html?testName=audio-oscillator) 08:25:23 INFO - PROCESS | 6343 | RSS: Main: 179675136 08:25:23 INFO - PROCESS | 6343 | 08:25:25 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:25 INFO - PROCESS | 6343 | RSS: Main: 183676928 08:25:25 INFO - PROCESS | 6343 | 08:25:28 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55757/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:29 INFO - PROCESS | 6343 | RSS: Main: 218836992 08:25:29 INFO - PROCESS | 6343 | 08:25:32 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55757/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:33 INFO - PROCESS | 6343 | RSS: Main: 219475968 08:25:33 INFO - PROCESS | 6343 | 08:25:36 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55757/tests/kraken/driver.html?testName=json-parse-financial) 08:25:36 INFO - PROCESS | 6343 | RSS: Main: 219652096 08:25:36 INFO - PROCESS | 6343 | 08:25:38 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:38 INFO - PROCESS | 6343 | RSS: Main: 183914496 08:25:38 INFO - PROCESS | 6343 | 08:25:40 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:41 INFO - PROCESS | 6343 | RSS: Main: 189825024 08:25:41 INFO - PROCESS | 6343 | 08:25:43 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:43 INFO - PROCESS | 6343 | RSS: Main: 193814528 08:25:43 INFO - PROCESS | 6343 | 08:25:46 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:47 INFO - PROCESS | 6343 | RSS: Main: 188764160 08:25:47 INFO - PROCESS | 6343 | 08:25:49 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:50 INFO - PROCESS | 6343 | RSS: Main: 192147456 08:25:50 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:55757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55757/tests/kraken/driver.html?testName=ai-astar) 08:25:52 INFO - PROCESS | 6343 | RSS: Main: 242802688 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | __start_tp_report 08:25:52 INFO - PROCESS | 6343 | _x_x_mozilla_page_load 08:25:52 INFO - PROCESS | 6343 | _x_x_mozilla_page_load_details 08:25:52 INFO - PROCESS | 6343 | |i|pagename|runs| 08:25:52 INFO - PROCESS | 6343 | |0;ai-astar;104;110;111;110;113;110;111;109;109;109 08:25:52 INFO - PROCESS | 6343 | |1;audio-beat-detection;141;118;129;176;120;117;143;117;150;116 08:25:52 INFO - PROCESS | 6343 | |2;audio-dft;160;161;161;160;161;160;161;162;163;162 08:25:52 INFO - PROCESS | 6343 | |3;audio-fft;74;75;74;113;74;76;74;74;102;75 08:25:52 INFO - PROCESS | 6343 | |4;audio-oscillator;85;85;133;84;84;83;130;84;83;129 08:25:52 INFO - PROCESS | 6343 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;118;118 08:25:52 INFO - PROCESS | 6343 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 08:25:52 INFO - PROCESS | 6343 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 08:25:52 INFO - PROCESS | 6343 | |8;json-parse-financial;51;49;48;49;49;50;52;50;48;49 08:25:52 INFO - PROCESS | 6343 | |9;json-stringify-tinderbox;61;62;62;61;62;61;60;61;62;60 08:25:52 INFO - PROCESS | 6343 | |10;stanford-crypto-aes;80;81;76;75;77;76;79;76;77;76 08:25:52 INFO - PROCESS | 6343 | |11;stanford-crypto-ccm;123;120;121;121;120;125;137;120;156;125 08:25:52 INFO - PROCESS | 6343 | |12;stanford-crypto-pbkdf2;163;161;159;159;156;162;161;161;163;160 08:25:52 INFO - PROCESS | 6343 | |13;stanford-crypto-sha256-iterative;65;66;64;63;63;63;64;62;62;61 08:25:52 INFO - PROCESS | 6343 | __end_tp_report 08:25:52 INFO - PROCESS | 6343 | __start_cc_report 08:25:52 INFO - PROCESS | 6343 | _x_x_mozilla_cycle_collect,1672 08:25:52 INFO - PROCESS | 6343 | __end_cc_report 08:25:52 INFO - PROCESS | 6343 | __startTimestamp1470669952265__endTimestamp 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | ------- Summary: start ------- 08:25:52 INFO - PROCESS | 6343 | Number of tests: 14 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.32 (2.1%) stddev-sans-first:1.30 08:25:52 INFO - PROCESS | 6343 | Values: 104.0 110.0 111.0 110.0 113.0 110.0 111.0 109.0 109.0 109.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:135.00 stddev:19.75 (14.6%) stddev-sans-first:20.72 08:25:52 INFO - PROCESS | 6343 | Values: 141.0 118.0 129.0 176.0 120.0 117.0 143.0 117.0 150.0 116.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 08:25:52 INFO - PROCESS | 6343 | Values: 160.0 161.0 161.0 160.0 161.0 160.0 161.0 162.0 163.0 162.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.00 stddev:14.17 (19.1%) stddev-sans-first:14.79 08:25:52 INFO - PROCESS | 6343 | Values: 74.0 75.0 74.0 113.0 74.0 76.0 74.0 74.0 102.0 75.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:84.00 stddev:22.57 (26.9%) stddev-sans-first:23.45 08:25:52 INFO - PROCESS | 6343 | Values: 85.0 85.0 133.0 84.0 84.0 83.0 130.0 84.0 83.0 129.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:25:52 INFO - PROCESS | 6343 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 118.0 118.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:25:52 INFO - PROCESS | 6343 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:25:52 INFO - PROCESS | 6343 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.50 stddev:1.27 (2.6%) stddev-sans-first:1.22 08:25:52 INFO - PROCESS | 6343 | Values: 51.0 49.0 48.0 49.0 49.0 50.0 52.0 50.0 48.0 49.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 08:25:52 INFO - PROCESS | 6343 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 60.0 61.0 62.0 60.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:2.00 (2.6%) stddev-sans-first:1.87 08:25:52 INFO - PROCESS | 6343 | Values: 80.0 81.0 76.0 75.0 77.0 76.0 79.0 76.0 77.0 76.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:124.00 stddev:11.47 (9.2%) stddev-sans-first:12.08 08:25:52 INFO - PROCESS | 6343 | Values: 123.0 120.0 121.0 121.0 120.0 125.0 137.0 120.0 156.0 125.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:2.12 (1.3%) stddev-sans-first:2.05 08:25:52 INFO - PROCESS | 6343 | Values: 163.0 161.0 159.0 159.0 156.0 162.0 161.0 161.0 163.0 160.0 08:25:52 INFO - PROCESS | 6343 | 08:25:52 INFO - PROCESS | 6343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.49 (2.4%) stddev-sans-first:1.45 08:25:52 INFO - PROCESS | 6343 | Values: 65.0 66.0 64.0 63.0 63.0 63.0 64.0 62.0 62.0 61.0 08:25:52 INFO - PROCESS | 6343 | -------- Summary: end -------- 08:25:52 INFO - PROCESS | 6343 | 08:25:53 INFO - TEST-INFO | 6343: exit 0 08:25:53 INFO - TEST-OK | kraken | took 61185ms 08:25:53 INFO - SUITE-END | took 1177s 08:25:53 INFO - Completed test suite (00:19:37) 08:25:53 INFO - javascript benchmark 08:25:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.172133523948, 3089.7682673799472, 3109.626844778626, 3117.9710695470485, 3132.3422081362914, 5252.737363131847, 5262.631615786887, 5298.523132918037, 5387.326584176978, 5440.945590544094, 5262.684238945666, 5305.0450918834595, 5325.520703136717, 5369.4362091980265, 5398.48714372135, 4729.10147072056, 4820.517948205186, 4833.10587541306, 4845.588125009378, 5046.24306354048, 4952.034353301107, 4958.776855041532, 4991.550760431561, 5005.1491246488185, 5007.924881126786, 4788.257820037899, 4809.086273608038, 4819.397575303087, 4849.854504364839, 4889.804407823683, 4811.422629284508, 4816.807327706888, 4823.951760482385, 4873.415190177166, 4911.50884911506, 4837.4920633333695, 4869.172240719051, 4880.219164933594, 4906.828261010847, 4935.950640493585, 5186.559142472895, 5274.340707411574, 5358.517733404013, 5385.542228910547, 5440.265564148868, 5699.487046165865, 5707.086866101404, 5741.598088133832, 5749.195112684228, 5753.597248192628, 5785.016547186946, 5793.594448388572, 5796.13058041293, 5799.3620701722775, 5799.971000145015, 5175.741212939376, 5283.1546952487415, 5301.125314323093, 5321.946780532146, 5374.838754837361, 5843.444872737083, 5844.795432159854, 5850.180974663551, 5891.410858914074, 5899.911501327483, 5656.321241451053, 5658.547316214693, 5696.174054762037, 5706.087026075808, 5706.115552089433, 5571.777128914879, 5609.915851262234, 5635.323761148688, 5660.037793575102, 5785.334686511021, 5694.9430505695245, 5699.5725320600295, 5702.629329093678, 5702.6863522506665, 5742.224799652077, 5654.236678048493, 5700.771969121189, 5707.771689132472, 5714.428557144335, 5716.514096301861, 4254.851080212177, 4362.978185109054, 4372.994211331412, 4388.166248412791, 4394.157744877524, 3929.351656976567, 3931.5478719947573, 3939.684825213976, 3974.7615143091507, 3977.8607748728655, 5430.70131142791, 5433.26650902131, 5434.375046869582, 5479.75341109651, 5499.615026948155, 5603.2435621191435, 5645.322561292671, 5678.318601767732, 5691.345495268097, 5735.971320143372, 5423.050966080999, 5425.26758887553, 5429.701366424884, 5430.049741295257, 5439.728013599304, 4917.950820491749, 4926.926096108561, 4927.285543596158, 4927.975360123177, 4972.90054198914, 5816.272965879265, 5934.8813023739285, 5942.61373010753, 5980.162777211107, 5987.88024239504, 5753.280839895013, 5758.3090029196765, 5758.856028599319, 5761.135829625589, 5797.246357973605, 5991.340952495135, 6000.219971403864, 6002.0996850472775, 6005.579609427298, 6011.428914253139, 5430.918536222039, 5577.498025177753, 5586.078297080936, 5607.07483265273, 5645.0, 5709.0, 5748.109043098327, 5753.626014309057, 5757.481826635623, 5791.420857914175, 5602.13166959122, 5608.859778505407, 5612.045952188219, 5621.381648018796, 5624.156376543551, 5450.618456707993, 5557.0, 5574.665520068809, 5598.916016259841, 5599.300087489064, 5550.9444905552045, 5558.416366281483, 5567.498925096761, 5568.053430916835, 5599.0, 5645.040343141758, 5647.6893770843, 5693.800716975052, 5707.143928410605, 5710.685912274865, 5362.436944120967, 5362.785488580413, 5439.619226654097, 5471.151971444432, 5533.2253484513], "value": 5280.387646169851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5870173475097, 589.1280904261693, 607.6323824086425, 618.3105836991756, 620.22162186456, 43708.56291437085, 45294.320585191206, 45323.77338113313, 48712.75643621786, 48760.26859597109, 45300.773496132555, 45645.0, 45693.314600281024, 45809.0, 45933.311000334936, 8963.910360896389, 9109.134632209963, 9119.680811171611, 9120.954395228047, 9122.315826313019, 8984.955075224614, 9070.501122438263, 9079.273658107368, 9082.09179082093, 9085.046070162603, 9072.09279072094, 9121.45271283725, 9122.133397327243, 9125.22435592972, 9127.178553930178, 9022.052684468135, 9039.276857851357, 9051.909480905173, 9056.637734490612, 9060.501672408014, 9030.593623286968, 9076.591553380047, 9096.226820720247, 9111.544422778834, 9111.908880911238, 43279.35080973788, 43378.56621433777, 43503.34744978828, 43651.34522982158, 43784.12431751379, 3270.411325961326, 3353.7149342305934, 3481.860725570974, 3520.806355650438, 3695.334839728848, 32395.676043239502, 33035.834820825985, 33511.0, 33552.32895342104, 33561.0, 4023.6579890709327, 4106.507219133693, 4122.072533679928, 4151.750894946313, 4262.25410553152, 343847.2807635971, 343888.0, 346422.0, 347663.0, 347704.0, 58609.4139058604, 59042.0, 59239.0, 59252.70373648104, 59327.406725933055, 62318.688406557674, 62444.06333904995, 62522.68738656278, 62536.687316563126, 62546.0, 16440.260188291555, 16696.916515417346, 16699.0, 16701.83298167027, 16712.498625041026, 11289.20975531705, 11622.593209237637, 11633.941830290963, 11887.821682674767, 12372.0, 15916.0, 16519.421820236475, 16532.83467165337, 17176.484705458606, 17284.567885802957, 4198.492848720978, 6280.717367718464, 6582.275949645536, 6681.064650948871, 6727.730890764413, 880.8722735203488, 1018.2312354172552, 1033.7260625934134, 1165.9681182153686, 1187.5784096645739, 33730.15674608154, 33949.66050339514, 34310.82844585761, 34387.31225375478, 34868.302633947176, 1074.983875241872, 1088.6081010836092, 1094.4473041114186, 1155.9595414160465, 1229.7970834812156, 17381.478555643353, 17534.561635959202, 17644.647107057786, 17866.28534858617, 17950.19224134917, 579494.0, 583671.0, 584089.0, 584923.0, 588311.0, 61286.69356653188, 62032.06951895725, 62067.68966155231, 62150.378496215366, 62215.688921555105, 1186.9169158158845, 1251.4055823483773, 1311.1608570514877, 1314.2508770001007, 1354.8103265542832, 33455.49816752799, 34811.825940870134, 35125.0, 35191.824040879634, 35402.46896296506, 52205.47794522006, 52898.471015290896, 52958.73520632372, 52990.0, 53011.0, 417386.0, 419078.0, 419106.0, 419121.0, 419616.0, 28807.42385152243, 30021.69978300189, 30080.097597072123, 31133.221669458446, 31152.844235779583, 49004.50995490142, 49249.0, 49561.0, 49764.751176245336, 50936.74531627318, 41089.0, 41520.0, 42106.0, 43531.564684354016, 43541.346879797464, 41736.0, 41837.22772080024, 42653.30965257124, 42828.14343713171, 43355.78322108369, 41547.58452415437, 42001.78999104985, 42215.788921055195, 42229.15541689211, 42266.788666056476, 35309.47035794517, 37493.81253093717, 37904.810475947445, 38518.80740596279, 38934.805325974325, 28564.857175713987, 28767.568486473137, 28861.0, 28879.133625991253, 29069.273268168465], "value": 20367.670530937285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1006150331462, 390.46311321932325, 403.18958892625824, 404.50650206747764, 420.56891686021845, 14127.646808829772, 18008.45974620762, 19752.506187345323, 20026.999999999964, 20046.398608041764, 19716.21135154592, 19954.201831926704, 19960.800391996076, 20147.09338079786, 20256.189752409922, 5510.366307874606, 5581.2186293918885, 5741.311042674884, 5785.884282314351, 5788.971055144719, 5712.285964254468, 5722.084466485363, 5757.65454072757, 5782.479576838084, 5784.4504772046585, 5561.916571251434, 5710.7715691372505, 5749.108888122327, 5757.510611598019, 5775.364709881909, 5741.655500669973, 5765.990951583456, 5767.423257674241, 5785.0, 5792.333881603628, 4881.4630390657, 5129.666571672867, 5152.0, 5182.559482443997, 5207.453217412193, 13058.151220170754, 13276.203427794268, 13284.136531125447, 19573.902130489256, 23826.0, 2080.0431801371387, 2238.0, 2302.6167916206814, 2701.6352792372973, 2890.580865774472, 9202.585883635253, 9698.836139663215, 9896.703098907044, 10036.498175091216, 10217.182625390025, 1795.5780391607962, 1864.6736821056397, 1880.69908814589, 1906.2756152662039, 1940.3596813051659, 80537.59731201307, 81661.0, 82135.17864821335, 82443.58778206131, 89192.0, 11105.611303604497, 11106.167037472222, 11279.830802537968, 11280.492377842853, 11287.0, 15798.0, 15817.762733559006, 15864.365425383086, 15876.52370428889, 15878.761818572731, 7864.331531819745, 8118.715844945398, 8148.959255203805, 8152.4293299469655, 8226.62980165882, 7718.922810771933, 7756.146823849372, 7915.683372665144, 7923.881141782877, 8020.679172833022, 4728.881777955578, 4773.785179666923, 4850.975745121323, 4867.780949857265, 4962.9007419851405, 1968.6948522978962, 1972.8125828046313, 1998.8201061904208, 2032.3801240621751, 2056.897155142237, 888.7778055486128, 919.8850143732034, 1036.9222308326905, 1065.8454524093963, 1088.1729885287239, 19027.429177124708, 20134.093965771575, 20148.496287592636, 20197.59604807925, 20306.0, 939.5912777941618, 965.3483898368573, 987.437160818341, 987.5309228116587, 1042.2860340666668, 10978.890211097787, 11300.660980170607, 11326.207165498336, 11333.093352531943, 11352.94323528377, 458218.0, 467351.0, 467720.0, 467931.0, 470082.0, 91359.5432022849, 92400.53799731092, 94195.52902235444, 96990.0, 97978.0, 979.2704435195682, 1031.8194315994672, 1033.1837848100067, 1047.863777708893, 1050.4800123938699, 17808.821911781233, 18420.631587368447, 18916.243350266384, 18926.52683682919, 18955.620887581896, 46739.766301168274, 46886.76556617195, 46952.0, 47647.0, 48477.0, 63071.0, 63821.68089159524, 64185.35814641794, 65833.34166658272, 66978.33021669721, 7975.322097621767, 8384.958075209584, 8385.28725058377, 8404.915950840414, 8617.741467755977, 8902.42134261271, 13130.127785795208, 13666.316684165553, 13708.383122759698, 14102.36539355711, 11085.722856928642, 11834.76330473403, 11918.344491053076, 12301.261924284572, 12360.81458778137, 11594.47824847867, 11640.417979101181, 11841.407929603312, 11889.0, 12441.93779031099, 6068.757249710139, 9266.907330926604, 9649.903500965182, 11672.474738636613, 12385.876141238832, 8384.496930184208, 8461.196186362286, 8659.350548708999, 8950.597223124845, 9005.909940900507, 11784.234024788362, 11855.34795586251, 12230.205036672587, 12301.815472767737, 12335.198212116184], "value": 9197.441698775963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.288124412817, 1451.1220711469562, 1537.4311504743243, 1648.48896841979, 1832.9725054124183, 8820.250278726307, 9207.953960230197, 9285.0, 9523.523823808817, 9526.285528585366, 9285.442873427599, 9310.394824336414, 9348.345615806897, 9413.905860941388, 9414.0, 2418.4800267942387, 2453.6196889482158, 2475.5420247254315, 2475.5420247254315, 2475.900963961439, 2383.8688872112025, 2496.950060998779, 2502.887370068351, 2505.34860936157, 2510.2469259222253, 2413.9155129570468, 2415.408224984881, 2420.334408037786, 2429.9514009719796, 2434.573949558829, 2370.8458950168356, 2407.1935901473025, 2409.771071748181, 2425.3087869957153, 2427.1990243219693, 2291.7937385635205, 2340.414896275931, 2347.5657003454417, 2350.4358953851124, 2356.3166681662296, 9075.63697452101, 9252.398594091363, 9270.582823772946, 9332.626694932194, 9379.577918993662, 5307.946920530784, 5479.287692599936, 5550.86122846928, 5557.5831812614215, 5557.694326812024, 3409.829508524564, 3422.5892892853017, 3484.111551554363, 3494.4583589543663, 3505.263894582141, 1065.206421216191, 1071.9142468602572, 1073.8228192348254, 1090.231386872253, 1091.0998426298256, 12998.480060797558, 13108.934455327662, 13194.208347499181, 13231.933840330834, 13257.072004959657, 4709.920111688502, 4726.550977657117, 4892.779824907888, 4940.333055037524, 5063.113955057924, 11153.0, 11173.608923687632, 11188.440577971232, 11188.496517656726, 11191.384473854016, 5546.140348246028, 5561.416051314634, 5568.610197286151, 5571.0, 5578.693171875586, 4524.343970124313, 4589.059242855206, 4647.837325693585, 5068.594512438996, 5104.387473503203, 4069.7965101744794, 4102.78431104649, 4176.979115104405, 4202.789860507023, 4245.235857545671, 1324.3510679767037, 1361.7548841208677, 1363.9931800341133, 1371.6296599918167, 1379.9931000345134, 876.54419701756, 881.1849039638437, 891.5497673674753, 911.2436677557612, 911.4986757283467, 5964.880702385928, 6005.3694362091355, 6097.664628445389, 6114.38856114385, 6298.338674439209, 430.18265295937346, 432.3946474935053, 439.5253126623239, 463.6777439679458, 464.9767511624473, 4132.483439570054, 4214.957850421518, 4229.788510574521, 4252.957470425256, 4321.546237645002, 11361.14791390649, 11860.881391185978, 11890.762184756257, 11893.04855611549, 11896.405179740977, 11731.41342932867, 11732.882671173349, 11748.88251117495, 11787.174897757246, 11800.232984855957, 8650.826983460296, 8679.609417576225, 8740.0, 8746.737597872074, 8750.86873696895, 5989.101634754822, 6077.726502307495, 6107.877842443215, 6172.290186628596, 6185.41238582334, 10738.248322617654, 10779.083777878654, 10807.729806754895, 10827.891721082688, 10954.178436617127, 9092.181703646704, 9795.657151999645, 10751.301165424222, 10888.40113793749, 10989.395583242998, 7893.644785984529, 8191.631376588187, 8220.273742514139, 8226.136255693065, 8255.752327430188, 7988.400869934894, 8212.425130241065, 8213.917860821315, 8277.83444331122, 8282.006159260927, 7500.437467189873, 7592.240775922584, 7599.316061554487, 7602.771916842504, 7714.575698336421, 7245.456590755609, 7359.411247100326, 7371.520851144658, 7443.627818609156, 7462.664180111799, 6856.657167141722, 7140.964295178491, 7141.143062832493, 7142.928570714226, 7147.0, 5037.2695959084995, 5136.280920671184, 5261.816091379409, 5330.520253177233, 5376.086065368975, 5236.738163091754, 5287.709175995357, 5293.232481290114, 5390.0, 5513.917291240715], "value": 4689.897774754472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.4012455338431, 311.21418418493306, 319.7601798651012, 321.73456898059106, 323.5147279081378, 5240.266362709223, 5283.762230699618, 5289.338832645919, 5298.841034768959, 5309.654872433299, 4934.383202099738, 4956.504349565051, 5032.849014529561, 5087.287779710834, 5196.610254230929, 4008.9398659020067, 4036.091879327157, 4040.2323558523785, 4056.553779084298, 4070.959290407088, 4061.614146656063, 4066.146109317047, 4109.239790638727, 4117.547069822317, 4122.381642753596, 3876.6511014008734, 3888.202918401721, 3989.2819292527333, 4023.4769479967563, 4041.393790931369, 4015.19696060789, 4029.798510074514, 4042.333015052513, 4046.271671099201, 4062.7156099073077, 3608.386574282378, 3609.4946707460977, 3610.277944411102, 3610.5125808015846, 3614.3132804767274, 4811.278308253755, 5093.567046801027, 5103.56619687327, 5103.642745007851, 5128.307678463434, 4628.213203755336, 4628.32889231063, 4639.559241872017, 4648.604868586174, 4658.161530924433, 5360.249565060894, 5411.0, 5412.972935135299, 5420.593455490814, 5435.537979271767, 3810.3522401191863, 3930.960690393088, 3970.68234541236, 3980.383040628707, 3993.1614360984227, 5550.474534087021, 5557.5831812614215, 5613.10190369543, 5631.662100273997, 5635.182408795602, 4046.9595304046584, 4055.986003499125, 4061.918761624751, 4064.9390259145543, 4078.653314468244, 4014.237294913957, 4120.484939382577, 4135.979320103441, 4136.420901073852, 4139.77231252284, 4602.493725690171, 4605.677602567788, 4617.607503362185, 4663.230566956482, 4700.294955756595, 5400.6498375406145, 5406.972965135228, 5412.07994640912, 5438.374586922476, 5462.8361149165585, 1405.1639274631577, 1414.8655877691808, 1416.2989320286524, 1424.522784867081, 1425.9804239968264, 942.5664194470484, 979.490664854286, 981.3572110267786, 987.7431867714303, 990.7869807991173, 5192.714400707921, 5210.270562121306, 5215.504527069922, 5239.921401178985, 5275.920861187085, 5530.723463826793, 5535.889282214333, 5554.91667624986, 5605.271314729059, 5613.971930140323, 5159.329287192641, 5179.290834024763, 5223.503767142115, 5236.266922630834, 5273.894522109613, 2916.5271537873236, 2921.1236629011637, 2934.5744866994164, 2958.2694123937736, 2961.2892905702474, 5680.431956804369, 5765.711714414347, 5775.220345253337, 5824.242848429677, 5852.853678658068, 5601.831945041656, 5620.4660557247, 5626.240457538262, 5631.802886898939, 5672.688002159838, 5726.856828579319, 5746.396628353963, 5747.166660834156, 5816.243888294494, 5816.680082595498, 5384.6230763847725, 5468.890622187613, 5496.725163741877, 5509.917351239815, 5562.471565201299, 5412.702301373305, 5412.864678383072, 5420.349558053059, 5458.1266997280245, 5472.589555783253, 5485.835424937259, 5723.399043100415, 5730.341010783646, 5794.739236734273, 5810.053632033148, 4012.277789997828, 4018.1361007383553, 4022.778747168934, 4031.193761247821, 4055.6755459563756, 5361.043219225033, 5495.203195536545, 5558.694271814928, 5562.582806289463, 5606.355269143937, 5355.277037599874, 5379.838604841861, 5428.212909128075, 5436.646617969819, 5447.863803404946, 5374.543163831118, 5375.5162035417, 5405.8107966221, 5411.242426060433, 5449.754761035683, 5134.589232861437, 5363.436839131835, 5370.704611246419, 5396.730163491731, 5410.83767486976, 5387.0572649785345, 5402.162664786964, 5407.621466497308, 5416.7020813855615, 5426.186072089218, 5101.709397438705, 5328.333958255218, 5350.7425754948335, 5353.197020446964, 5357.276767636319], "value": 4154.883684899054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.6284399314387, 660.9239937407193, 691.4848437913754, 706.8833642448997, 755.0373274075553, 15037.699246015087, 16122.83877161228, 16341.918290408532, 16344.0, 16384.672306553875, 15307.158106304149, 15923.442679506219, 16054.1170235637, 16094.83905160948, 16223.432179873676, 812.5896422306741, 832.2592892325835, 835.578033093287, 836.9121242269565, 837.0624900111883, 668.9665516724168, 800.9038915330168, 832.9083800781909, 833.5207255827893, 836.9874451883227, 878.1481962496368, 878.1525827576387, 878.2798105553449, 879.7228872905047, 879.9516026618534, 871.6905498547987, 876.5047748022411, 876.6142897125244, 876.8202518483728, 876.8991565969932, 507.0619354194747, 613.4601550635413, 626.8401557602782, 632.8924082905917, 633.1452539072262, 14821.77767333491, 14834.184119873511, 14870.479533216285, 14874.925625371803, 14875.776863347059, 13840.723185536233, 14329.49846755369, 14775.778363324558, 14808.851911480855, 15026.849731502654, 13454.610592520441, 13529.052966292364, 13560.660983475393, 13842.0, 13849.0, 4417.757023363713, 4474.619657329131, 4524.366588677588, 4536.183486972343, 4542.250528662767, 86833.56583217107, 87183.0, 88696.0, 89022.0, 89340.0, 11084.501197446134, 11381.260218085798, 11408.88591114095, 11418.257813242113, 11468.54125834974, 21690.50559185682, 21800.563988720136, 21818.672719909213, 21841.453963651034, 21844.78155218459, 7918.683252669944, 8193.180681931879, 8201.056878458934, 8285.171482851667, 8315.584220788936, 4877.439094504107, 4880.975595122072, 5049.84850454487, 5056.6713163644245, 5190.325257716473, 3442.3287458945265, 3555.6088830228655, 3587.9103022424647, 3587.982060089683, 3598.3163198992106, 653.2128784814382, 655.0861548140317, 664.7839452178061, 665.9800205993828, 670.8490589617395, 699.51034276007, 715.2132654080574, 746.2127455534463, 772.7179579453459, 778.9532628042335, 9140.0, 9523.476208808583, 9665.130138287588, 9758.756031099138, 9915.069133824598, 601.0891020363553, 606.3239487970881, 690.1442211657509, 719.6473727873305, 754.1252147508864, 4764.213904705684, 4782.0, 4783.928241076386, 4788.61691064714, 4820.204666230033, 127376.0, 131630.0, 133993.0, 134162.3291883554, 140985.29507352604, 67042.32957670458, 100047.0, 110942.44528777305, 111313.44343278231, 111851.0, 60065.0, 83204.58397707973, 83325.73083177958, 85333.57333213295, 92760.0, 9730.12428881404, 9774.82877138167, 9864.753381165528, 9886.110250077527, 9946.950265248628, 54313.18530221971, 55406.0, 55708.0, 56148.0, 56849.14726279192, 72817.6359118201, 77321.0, 79303.60348198222, 81769.0, 82020.58989705013, 12647.24116552973, 12783.424745886643, 12978.0, 12981.0, 13055.608331750063, 14600.415983360546, 14849.40602375893, 14983.77524337114, 14984.0, 14997.17515536656, 10634.946825265824, 12990.35048247565, 14035.368408421442, 14230.857691423367, 14500.492482763053, 12921.612351629467, 13643.386047628079, 13705.520306789214, 13913.58259252224, 14151.858481415054, 13038.043747829743, 13450.394732237268, 13619.727605447637, 14117.929410352883, 14357.353919073876, 11487.616926280789, 11517.424128793695, 12051.216670916363, 12218.327991960172, 12977.610671679864, 11662.94168529152, 11793.764124717285, 12035.398230088636, 12147.817782733442, 12212.69468263265], "value": 7770.168652381117, "unit": "score"}], "name": "dromaeo_css", "value": 7287.504830665259, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 110.0, 113.0, 110.0, 111.0, 109.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 129.0, 176.0, 120.0, 117.0, 143.0, 117.0, 150.0, 116.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 113.0, 74.0, 76.0, 74.0, 74.0, 102.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 133.0, 84.0, 84.0, 83.0, 130.0, 84.0, 83.0, 129.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 48.0, 49.0, 49.0, 50.0, 52.0, 50.0, 48.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 60.0, 61.0, 62.0, 60.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 76.0, 75.0, 77.0, 76.0, 79.0, 76.0, 77.0, 76.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 121.0, 121.0, 120.0, 125.0, 137.0, 120.0, 156.0, 125.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 159.0, 159.0, 156.0, 162.0, 161.0, 161.0, 163.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1478.8999999999999, "alertThreshold": 2.0}]} 08:25:53 INFO - Return code: 0 08:25:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:53 INFO - # TBPL SUCCESS # 08:25:53 INFO - Running post-action listener: _resource_record_post_action 08:25:53 INFO - [mozharness: 2016-08-08 15:25:53.592069Z] Finished run-tests step (success) 08:25:53 INFO - Running post-run listener: _resource_record_post_run 08:25:53 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 551612416; Read time: 0; Write time: 1044516 08:25:53 INFO - TinderboxPrint: CPU usage
13.1% 08:25:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:25:53 INFO - TinderboxPrint: I/O write bytes / time
551,612,416 / 1,044,516 08:25:53 INFO - TinderboxPrint: CPU idle
8,289.1 (86.9%) 08:25:53 INFO - TinderboxPrint: CPU user
1,197.4 (12.6%) 08:25:53 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:53 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 259256320; Read time: 0; Write time: 640384 08:25:53 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 292298752; Read time: 0; Write time: 404112 08:25:54 INFO - Running post-run listener: _upload_blobber_files 08:25:54 INFO - Blob upload gear active. 08:25:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:25:54 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:04 INFO - (blobuploader) - INFO - Done attempting. 08:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:05 INFO - (blobuploader) - INFO - Done attempting. 08:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:06 INFO - (blobuploader) - INFO - Done attempting. 08:26:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:06 INFO - Return code: 0 08:26:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da28046e8041740d44a592a9009ffce44413064f64e9ff2ca1420d60a481d8e6690123159bf357ae5ca12ac99c81d89c6fa682e2a871928c9bb217955dcd7248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803799304ecfe2c63a9a64437a73ba90190c24c78e43ac765dce71bf64a92d7239422ff11e9b41045baeb47c69d2a4d164bc718b4721a5e4730db7d62e2fc17d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df14dee771e0ee6243f63fce79953103b206be034e7808af3baab24ff7f3a872192be271b6118f35e69fe1398f5e646ef624b723f10885d31dc5ad198f88ea84"} 08:26:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:06 INFO - Contents: 08:26:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da28046e8041740d44a592a9009ffce44413064f64e9ff2ca1420d60a481d8e6690123159bf357ae5ca12ac99c81d89c6fa682e2a871928c9bb217955dcd7248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803799304ecfe2c63a9a64437a73ba90190c24c78e43ac765dce71bf64a92d7239422ff11e9b41045baeb47c69d2a4d164bc718b4721a5e4730db7d62e2fc17d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df14dee771e0ee6243f63fce79953103b206be034e7808af3baab24ff7f3a872192be271b6118f35e69fe1398f5e646ef624b723f10885d31dc5ad198f88ea84"} 08:26:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:06 INFO - Copying logs to upload dir... 08:26:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.027567 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-08 08:26:06.319322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 08:26:06.322737) ========= 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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da28046e8041740d44a592a9009ffce44413064f64e9ff2ca1420d60a481d8e6690123159bf357ae5ca12ac99c81d89c6fa682e2a871928c9bb217955dcd7248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803799304ecfe2c63a9a64437a73ba90190c24c78e43ac765dce71bf64a92d7239422ff11e9b41045baeb47c69d2a4d164bc718b4721a5e4730db7d62e2fc17d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df14dee771e0ee6243f63fce79953103b206be034e7808af3baab24ff7f3a872192be271b6118f35e69fe1398f5e646ef624b723f10885d31dc5ad198f88ea84"} build_url:https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/XgEnxUwhQFOUwUSiEqQGxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da28046e8041740d44a592a9009ffce44413064f64e9ff2ca1420d60a481d8e6690123159bf357ae5ca12ac99c81d89c6fa682e2a871928c9bb217955dcd7248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803799304ecfe2c63a9a64437a73ba90190c24c78e43ac765dce71bf64a92d7239422ff11e9b41045baeb47c69d2a4d164bc718b4721a5e4730db7d62e2fc17d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df14dee771e0ee6243f63fce79953103b206be034e7808af3baab24ff7f3a872192be271b6118f35e69fe1398f5e646ef624b723f10885d31dc5ad198f88ea84"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 08:26:06.348470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:26:06.348816) ========= 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=af724c981e2a0f424dbabf99000001e7-1470666407.710061-117702604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 08:26:06.431212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 08:26:06.431527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 08:26:06.431815) ========= ========= Total master_lag: 0.16 =========