builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1450303047.17 results: success (0) buildid: 20151216124705 builduid: 05c5456ac3804f26a0bf80572e3ba27d revision: 5621bf5d87e491c8856b90e5ff86919c96bf04c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.170690) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.171173) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.171508) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004247 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.202032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.202427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.220577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.220968) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030312 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.270736) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.271070) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.271484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.271787) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 13:57:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2015-12-16 13:57:27 (41.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.218564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.503326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.503748) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.146602 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.664032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:27.664631) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5621bf5d87e491c8856b90e5ff86919c96bf04c6 --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 5621bf5d87e491c8856b90e5ff86919c96bf04c6 --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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 13:57:27,395 truncating revision to first 12 chars 2015-12-16 13:57:27,395 Setting DEBUG logging. 2015-12-16 13:57:27,395 attempt 1/10 2015-12-16 13:57:27,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5621bf5d87e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 13:57:28,063 unpacking tar archive at: fx-team-5621bf5d87e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:28.664585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:28.664926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:28.676026) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:28.676447) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:57:28.676975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-16 13:57:28.677395) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:57:28 INFO - MultiFileLogger online at 20151216 13:57:28 in /builds/slave/test 13:57:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:57:28 INFO - {'append_to_log': False, 13:57:28 INFO - 'base_work_dir': '/builds/slave/test', 13:57:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:57:28 INFO - 'branch': 'Fx-Team-Non-PGO', 13:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:57:28 INFO - 'config_files': ('talos/linux_config.py',), 13:57:28 INFO - 'default_actions': ('clobber', 13:57:28 INFO - 'read-buildbot-config', 13:57:28 INFO - 'download-and-extract', 13:57:28 INFO - 'populate-webroot', 13:57:28 INFO - 'create-virtualenv', 13:57:28 INFO - 'install', 13:57:28 INFO - 'run-tests'), 13:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:57:28 INFO - 'download_minidump_stackwalk': True, 13:57:28 INFO - 'download_symbols': 'ondemand', 13:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:57:28 INFO - 'installer_path': 'installer.exe', 13:57:28 INFO - 'log_level': 'info', 13:57:28 INFO - 'log_name': 'talos', 13:57:28 INFO - 'log_to_console': True, 13:57:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:57:28 INFO - 'opt_config_files': (), 13:57:28 INFO - 'pip_index': False, 13:57:28 INFO - 'sps_profile': False, 13:57:28 INFO - 'sps_profile_interval': 0, 13:57:28 INFO - 'suite': 'dromaeojs-e10s', 13:57:28 INFO - 'system_bits': '64', 13:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:57:28 INFO - 'title': 'talos-linux64-ix-022', 13:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:57:28 INFO - 'use_talos_json': True, 13:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:57:28 INFO - 'work_dir': 'build'} 13:57:28 INFO - ##### 13:57:28 INFO - ##### Running clobber step. 13:57:28 INFO - ##### 13:57:28 INFO - Running pre-action listener: _resource_record_pre_action 13:57:28 INFO - Running main action method: clobber 13:57:28 INFO - rmtree: /builds/slave/test/build 13:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:57:31 INFO - Running post-action listener: _resource_record_post_action 13:57:31 INFO - ##### 13:57:31 INFO - ##### Running read-buildbot-config step. 13:57:31 INFO - ##### 13:57:31 INFO - Running pre-action listener: _resource_record_pre_action 13:57:31 INFO - Running main action method: read_buildbot_config 13:57:31 INFO - Using buildbot properties: 13:57:31 INFO - { 13:57:31 INFO - "project": "", 13:57:31 INFO - "product": "firefox", 13:57:31 INFO - "script_repo_revision": "production", 13:57:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:57:31 INFO - "repository": "", 13:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:57:31 INFO - "buildid": "20151216124705", 13:57:31 INFO - "pgo_build": "False", 13:57:31 INFO - "basedir": "/builds/slave/test", 13:57:31 INFO - "buildnumber": 591, 13:57:31 INFO - "slavename": "talos-linux64-ix-022", 13:57:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:57:31 INFO - "platform": "ubuntu64_hw", 13:57:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:57:31 INFO - "branch": "fx-team", 13:57:31 INFO - "repo_path": "integration/fx-team", 13:57:31 INFO - "revision": "5621bf5d87e491c8856b90e5ff86919c96bf04c6", 13:57:31 INFO - "stage_platform": "linux64", 13:57:31 INFO - "builduid": "05c5456ac3804f26a0bf80572e3ba27d", 13:57:31 INFO - "slavebuilddir": "test" 13:57:31 INFO - } 13:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:57:31 INFO - Running post-action listener: _resource_record_post_action 13:57:31 INFO - ##### 13:57:31 INFO - ##### Running download-and-extract step. 13:57:31 INFO - ##### 13:57:31 INFO - Running pre-action listener: _resource_record_pre_action 13:57:31 INFO - Running main action method: download_and_extract 13:57:31 INFO - mkdir: /builds/slave/test/build/tests 13:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:31 INFO - https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/test_packages.json 13:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/test_packages.json 13:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:57:31 INFO - Downloaded 1302 bytes. 13:57:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:57:31 INFO - Using the following test package requirements: 13:57:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:57:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:57:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'jsshell-linux-x86_64.zip'], 13:57:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:57:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:57:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:57:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:57:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:57:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:57:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:57:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:57:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:31 INFO - https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:33 INFO - Downloaded 21870297 bytes. 13:57:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:57:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:57:34 INFO - Return code: 0 13:57:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:34 INFO - https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:57:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:36 INFO - Downloaded 21870297 bytes. 13:57:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:57:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:57:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:57:37 INFO - Return code: 0 13:57:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:37 INFO - https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:57:38 INFO - Downloaded 11132052 bytes. 13:57:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:57:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:57:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:57:38 INFO - Return code: 0 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:38 INFO - https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:57:40 INFO - Downloaded 57773015 bytes. 13:57:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:57:40 INFO - mkdir: /builds/slave/test/properties 13:57:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:57:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:57:40 INFO - Contents: 13:57:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:57:40 INFO - Running post-action listener: _resource_record_post_action 13:57:40 INFO - Running post-action listener: set_extra_try_arguments 13:57:40 INFO - ##### 13:57:40 INFO - ##### Running populate-webroot step. 13:57:40 INFO - ##### 13:57:40 INFO - Running pre-action listener: _resource_record_pre_action 13:57:40 INFO - Running main action method: populate_webroot 13:57:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:40 INFO - '--tppagecycles', 13:57:40 INFO - '7'], 13:57:40 INFO - 'tests': ['tsvgm']}}, 13:57:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:57:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:57:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:57:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'tests': ['damp', 'tps']}, 13:57:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['damp', 'tps']}, 13:57:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:57:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:40 INFO - 'other': {'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'other_l64': {'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'other_nol64': {'tests': ['a11yr', 13:57:40 INFO - 'ts_paint', 13:57:40 INFO - 'tpaint', 13:57:40 INFO - 'sessionrestore', 13:57:40 INFO - 'sessionrestore_no_auto_restore']}, 13:57:40 INFO - 'svgr': {'tests': ['tsvgx', 13:57:40 INFO - 'tsvgr_opacity', 13:57:40 INFO - 'tart', 13:57:40 INFO - 'tscrollx', 13:57:40 INFO - 'cart']}, 13:57:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['tsvgx', 13:57:40 INFO - 'tsvgr_opacity', 13:57:40 INFO - 'tart', 13:57:40 INFO - 'tscrollx', 13:57:40 INFO - 'cart']}, 13:57:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'tests': ['tp5o']}, 13:57:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'talos_options': ['--e10s'], 13:57:40 INFO - 'tests': ['tp5o']}, 13:57:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'talos_options': ['--xperf_path', 13:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:40 INFO - 'tests': ['tp5n']}, 13:57:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:40 INFO - 'talos_options': ['--e10s', 13:57:40 INFO - '--xperf_path', 13:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:40 INFO - 'tests': ['tp5n']}}, 13:57:40 INFO - 'talos.zip': {'path': '', 13:57:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:40 INFO - Running post-action listener: _resource_record_post_action 13:57:40 INFO - ##### 13:57:40 INFO - ##### Running create-virtualenv step. 13:57:40 INFO - ##### 13:57:40 INFO - Running pre-action listener: _resource_record_pre_action 13:57:40 INFO - Running main action method: create_virtualenv 13:57:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:57:40 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 13:57:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:57:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:40 INFO - Using real prefix '/usr' 13:57:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:57:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:43 INFO - Installing pip.................done. 13:57:43 INFO - Return code: 0 13:57:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:57:43 INFO - Using env: {'DISPLAY': ':0', 13:57:43 INFO - 'HOME': '/home/cltbld', 13:57:43 INFO - 'LANG': 'en_US.UTF-8', 13:57:43 INFO - 'LANGUAGE': 'en_US:en', 13:57:43 INFO - 'LOGNAME': 'cltbld', 13:57:43 INFO - 'MAIL': '/var/mail/cltbld', 13:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:43 INFO - 'MOZ_NO_REMOTE': '1', 13:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:43 INFO - 'NO_EM_RESTART': '1', 13:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:43 INFO - 'PWD': '/builds/slave/test', 13:57:43 INFO - 'SHELL': '/bin/bash', 13:57:43 INFO - 'SHLVL': '1', 13:57:43 INFO - 'TERM': 'linux', 13:57:43 INFO - 'TMOUT': '86400', 13:57:43 INFO - 'USER': 'cltbld', 13:57:43 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:43 INFO - '_': '/tools/buildbot/bin/python'} 13:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:43 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 13:57:43 INFO - Cleaning up... 13:57:43 INFO - Return code: 0 13:57:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:57:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 13:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 13:57:43 INFO - Using env: {'DISPLAY': ':0', 13:57:43 INFO - 'HOME': '/home/cltbld', 13:57:43 INFO - 'LANG': 'en_US.UTF-8', 13:57:43 INFO - 'LANGUAGE': 'en_US:en', 13:57:43 INFO - 'LOGNAME': 'cltbld', 13:57:43 INFO - 'MAIL': '/var/mail/cltbld', 13:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:43 INFO - 'MOZ_NO_REMOTE': '1', 13:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:43 INFO - 'NO_EM_RESTART': '1', 13:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:43 INFO - 'PWD': '/builds/slave/test', 13:57:43 INFO - 'SHELL': '/bin/bash', 13:57:43 INFO - 'SHLVL': '1', 13:57:43 INFO - 'TERM': 'linux', 13:57:43 INFO - 'TMOUT': '86400', 13:57:43 INFO - 'USER': 'cltbld', 13:57:43 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:43 INFO - '_': '/tools/buildbot/bin/python'} 13:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:43 INFO - Downloading/unpacking psutil>=0.7.1 13:57:43 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 13:57:43 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 13:57:43 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 13:57:43 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 13:57:43 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 13:57:43 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 13:57:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:57:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:46 INFO - Installing collected packages: psutil 13:57:46 INFO - Running setup.py install for psutil 13:57:46 INFO - building 'psutil._psutil_linux' extension 13:57:46 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 13:57:51 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 13:57:51 INFO - building 'psutil._psutil_posix' extension 13:57:51 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 13:57:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:57:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:52 INFO - Successfully installed psutil 13:57:52 INFO - Cleaning up... 13:57:52 INFO - Return code: 0 13:57:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 13:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 13:57:52 INFO - Using env: {'DISPLAY': ':0', 13:57:52 INFO - 'HOME': '/home/cltbld', 13:57:52 INFO - 'LANG': 'en_US.UTF-8', 13:57:52 INFO - 'LANGUAGE': 'en_US:en', 13:57:52 INFO - 'LOGNAME': 'cltbld', 13:57:52 INFO - 'MAIL': '/var/mail/cltbld', 13:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:52 INFO - 'MOZ_NO_REMOTE': '1', 13:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:52 INFO - 'NO_EM_RESTART': '1', 13:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:52 INFO - 'PWD': '/builds/slave/test', 13:57:52 INFO - 'SHELL': '/bin/bash', 13:57:52 INFO - 'SHLVL': '1', 13:57:52 INFO - 'TERM': 'linux', 13:57:52 INFO - 'TMOUT': '86400', 13:57:52 INFO - 'USER': 'cltbld', 13:57:52 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:52 INFO - '_': '/tools/buildbot/bin/python'} 13:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:57:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:57:54 INFO - Installing collected packages: mozsystemmonitor 13:57:54 INFO - Running setup.py install for mozsystemmonitor 13:57:54 INFO - Successfully installed mozsystemmonitor 13:57:54 INFO - Cleaning up... 13:57:54 INFO - Return code: 0 13:57:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:57:54 INFO - Using env: {'DISPLAY': ':0', 13:57:54 INFO - 'HOME': '/home/cltbld', 13:57:54 INFO - 'LANG': 'en_US.UTF-8', 13:57:54 INFO - 'LANGUAGE': 'en_US:en', 13:57:54 INFO - 'LOGNAME': 'cltbld', 13:57:54 INFO - 'MAIL': '/var/mail/cltbld', 13:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:54 INFO - 'MOZ_NO_REMOTE': '1', 13:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:54 INFO - 'NO_EM_RESTART': '1', 13:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:54 INFO - 'PWD': '/builds/slave/test', 13:57:54 INFO - 'SHELL': '/bin/bash', 13:57:54 INFO - 'SHLVL': '1', 13:57:54 INFO - 'TERM': 'linux', 13:57:54 INFO - 'TMOUT': '86400', 13:57:54 INFO - 'USER': 'cltbld', 13:57:54 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:54 INFO - '_': '/tools/buildbot/bin/python'} 13:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:56 INFO - Downloading docopt-0.6.1.tar.gz 13:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:56 INFO - Running setup.py install for blobuploader 13:57:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:56 INFO - Running setup.py install for requests 13:57:57 INFO - Running setup.py install for docopt 13:57:57 INFO - Successfully installed blobuploader requests docopt 13:57:57 INFO - Cleaning up... 13:57:57 INFO - Return code: 0 13:57:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 13:57:57 INFO - Using env: {'DISPLAY': ':0', 13:57:57 INFO - 'HOME': '/home/cltbld', 13:57:57 INFO - 'LANG': 'en_US.UTF-8', 13:57:57 INFO - 'LANGUAGE': 'en_US:en', 13:57:57 INFO - 'LOGNAME': 'cltbld', 13:57:57 INFO - 'MAIL': '/var/mail/cltbld', 13:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:57 INFO - 'MOZ_NO_REMOTE': '1', 13:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:57 INFO - 'NO_EM_RESTART': '1', 13:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:57 INFO - 'PWD': '/builds/slave/test', 13:57:57 INFO - 'SHELL': '/bin/bash', 13:57:57 INFO - 'SHLVL': '1', 13:57:57 INFO - 'TERM': 'linux', 13:57:57 INFO - 'TMOUT': '86400', 13:57:57 INFO - 'USER': 'cltbld', 13:57:57 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:57 INFO - '_': '/tools/buildbot/bin/python'} 13:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:57 INFO - Running setup.py (path:/tmp/pip-N1Zk1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:57 INFO - Running setup.py (path:/tmp/pip-aR_hmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:57 INFO - Running setup.py (path:/tmp/pip-lYIX7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:57 INFO - Running setup.py (path:/tmp/pip-AD1IV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:57 INFO - Running setup.py (path:/tmp/pip-ImwQgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:58 INFO - Running setup.py (path:/tmp/pip-tQYIdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:58 INFO - Running setup.py (path:/tmp/pip-wTmtUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:58 INFO - Running setup.py (path:/tmp/pip-AB0Pd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:58 INFO - Running setup.py (path:/tmp/pip-a8ppuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:58 INFO - Running setup.py (path:/tmp/pip-1O0CwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:58 INFO - Running setup.py (path:/tmp/pip-q3geCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:58 INFO - Running setup.py (path:/tmp/pip-6BsTCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:58 INFO - Running setup.py (path:/tmp/pip-mU29Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:58 INFO - Running setup.py (path:/tmp/pip-ouzzTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:58 INFO - Running setup.py (path:/tmp/pip-Y_o_Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:58 INFO - Running setup.py (path:/tmp/pip-B5wbTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:58 INFO - Running setup.py (path:/tmp/pip-8FwCO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:58 INFO - Running setup.py install for manifestparser 13:57:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:58 INFO - Running setup.py install for mozcrash 13:57:59 INFO - Running setup.py install for mozdebug 13:57:59 INFO - Running setup.py install for mozdevice 13:57:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Running setup.py install for mozfile 13:57:59 INFO - Running setup.py install for mozhttpd 13:57:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Running setup.py install for mozinfo 13:57:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Running setup.py install for mozInstall 13:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Running setup.py install for mozleak 13:57:59 INFO - Running setup.py install for mozlog 13:57:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:59 INFO - Running setup.py install for moznetwork 13:58:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Running setup.py install for mozprocess 13:58:00 INFO - Running setup.py install for mozprofile 13:58:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Running setup.py install for mozrunner 13:58:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Running setup.py install for mozscreenshot 13:58:00 INFO - Running setup.py install for moztest 13:58:00 INFO - Running setup.py install for mozversion 13:58:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:00 INFO - Cleaning up... 13:58:00 INFO - Return code: 0 13:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:58:00 INFO - Using env: {'DISPLAY': ':0', 13:58:00 INFO - 'HOME': '/home/cltbld', 13:58:00 INFO - 'LANG': 'en_US.UTF-8', 13:58:00 INFO - 'LANGUAGE': 'en_US:en', 13:58:00 INFO - 'LOGNAME': 'cltbld', 13:58:00 INFO - 'MAIL': '/var/mail/cltbld', 13:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:00 INFO - 'MOZ_NO_REMOTE': '1', 13:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:00 INFO - 'NO_EM_RESTART': '1', 13:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:00 INFO - 'PWD': '/builds/slave/test', 13:58:00 INFO - 'SHELL': '/bin/bash', 13:58:00 INFO - 'SHLVL': '1', 13:58:00 INFO - 'TERM': 'linux', 13:58:00 INFO - 'TMOUT': '86400', 13:58:00 INFO - 'USER': 'cltbld', 13:58:00 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:00 INFO - '_': '/tools/buildbot/bin/python'} 13:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:00 INFO - Running setup.py (path:/tmp/pip-JUgM1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:00 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)) 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:00 INFO - Running setup.py (path:/tmp/pip-AtrXu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:01 INFO - Running setup.py (path:/tmp/pip-34z0wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:01 INFO - Running setup.py (path:/tmp/pip-MDJuFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:01 INFO - Running setup.py (path:/tmp/pip-Ky0SPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:01 INFO - Running setup.py (path:/tmp/pip-NZIEJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:01 INFO - Running setup.py (path:/tmp/pip-tw9Xul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:01 INFO - Running setup.py (path:/tmp/pip-n7ejOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:01 INFO - Running setup.py (path:/tmp/pip-NueJGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:01 INFO - Running setup.py (path:/tmp/pip-UadMG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:01 INFO - Running setup.py (path:/tmp/pip-owWB5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:01 INFO - Running setup.py (path:/tmp/pip-kwkaK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:01 INFO - Running setup.py (path:/tmp/pip-nul2ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:01 INFO - Running setup.py (path:/tmp/pip-ocLUv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:01 INFO - Running setup.py (path:/tmp/pip-59nCws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:01 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)) 13:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:01 INFO - Running setup.py (path:/tmp/pip-FSRUHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:02 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)) 13:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:02 INFO - Running setup.py (path:/tmp/pip-sRddOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:03 INFO - Downloading blessings-1.5.1.tar.gz 13:58:03 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:03 INFO - Installing collected packages: blessings 13:58:03 INFO - Running setup.py install for blessings 13:58:03 INFO - Successfully installed blessings 13:58:03 INFO - Cleaning up... 13:58:04 INFO - Return code: 0 13:58:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:04 INFO - Reading from file tmpfile_stdout 13:58:04 INFO - Current package versions: 13:58:04 INFO - argparse == 1.2.1 13:58:04 INFO - blessings == 1.5.1 13:58:04 INFO - blobuploader == 1.2.4 13:58:04 INFO - docopt == 0.6.1 13:58:04 INFO - manifestparser == 1.1 13:58:04 INFO - mozInstall == 1.12 13:58:04 INFO - mozcrash == 0.16 13:58:04 INFO - mozdebug == 0.1 13:58:04 INFO - mozdevice == 0.47 13:58:04 INFO - mozfile == 1.2 13:58:04 INFO - mozhttpd == 0.7 13:58:04 INFO - mozinfo == 0.9 13:58:04 INFO - mozleak == 0.1 13:58:04 INFO - mozlog == 3.1 13:58:04 INFO - moznetwork == 0.27 13:58:04 INFO - mozprocess == 0.22 13:58:04 INFO - mozprofile == 0.27 13:58:04 INFO - mozrunner == 6.11 13:58:04 INFO - mozscreenshot == 0.1 13:58:04 INFO - mozsystemmonitor == 0.0 13:58:04 INFO - moztest == 0.7 13:58:04 INFO - mozversion == 1.4 13:58:04 INFO - psutil == 3.1.1 13:58:04 INFO - requests == 1.2.3 13:58:04 INFO - wsgiref == 0.1.2 13:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:58:04 INFO - Using env: {'DISPLAY': ':0', 13:58:04 INFO - 'HOME': '/home/cltbld', 13:58:04 INFO - 'LANG': 'en_US.UTF-8', 13:58:04 INFO - 'LANGUAGE': 'en_US:en', 13:58:04 INFO - 'LOGNAME': 'cltbld', 13:58:04 INFO - 'MAIL': '/var/mail/cltbld', 13:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:04 INFO - 'MOZ_NO_REMOTE': '1', 13:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:04 INFO - 'NO_EM_RESTART': '1', 13:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:04 INFO - 'PWD': '/builds/slave/test', 13:58:04 INFO - 'SHELL': '/bin/bash', 13:58:04 INFO - 'SHLVL': '1', 13:58:04 INFO - 'TERM': 'linux', 13:58:04 INFO - 'TMOUT': '86400', 13:58:04 INFO - 'USER': 'cltbld', 13:58:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:04 INFO - '_': '/tools/buildbot/bin/python'} 13:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:04 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 1)) 13:58:04 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 2)) 13:58:04 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 3)) 13:58:04 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 4)) 13:58:04 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 5)) 13:58:04 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 6)) 13:58:04 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 7)) 13:58:04 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 8)) 13:58:04 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:58:04 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 3)) 13:58:04 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:58:04 INFO - Cleaning up... 13:58:04 INFO - Return code: 0 13:58:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:58:04 INFO - Using env: {'DISPLAY': ':0', 13:58:04 INFO - 'HOME': '/home/cltbld', 13:58:04 INFO - 'LANG': 'en_US.UTF-8', 13:58:04 INFO - 'LANGUAGE': 'en_US:en', 13:58:04 INFO - 'LOGNAME': 'cltbld', 13:58:04 INFO - 'MAIL': '/var/mail/cltbld', 13:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:04 INFO - 'MOZ_NO_REMOTE': '1', 13:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:04 INFO - 'NO_EM_RESTART': '1', 13:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:04 INFO - 'PWD': '/builds/slave/test', 13:58:04 INFO - 'SHELL': '/bin/bash', 13:58:04 INFO - 'SHLVL': '1', 13:58:04 INFO - 'TERM': 'linux', 13:58:04 INFO - 'TMOUT': '86400', 13:58:04 INFO - 'USER': 'cltbld', 13:58:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:04 INFO - '_': '/tools/buildbot/bin/python'} 13:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:04 INFO - Downloading/unpacking jsonschema 13:58:04 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 13:58:04 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 13:58:04 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 13:58:04 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 13:58:04 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 13:58:04 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 13:58:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:58:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:06 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 13:58:06 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 13:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:06 INFO - warning: no files found matching '*.txt' 13:58:06 INFO - no previously-included directories found matching 'build' 13:58:06 INFO - no previously-included directories found matching 'dist' 13:58:06 INFO - no previously-included directories found matching '.git*' 13:58:06 INFO - Installing collected packages: jsonschema, functools32 13:58:06 INFO - Running setup.py install for functools32 13:58:06 INFO - warning: no files found matching '*.txt' 13:58:06 INFO - no previously-included directories found matching 'build' 13:58:06 INFO - no previously-included directories found matching 'dist' 13:58:06 INFO - no previously-included directories found matching '.git*' 13:58:06 INFO - Successfully installed jsonschema functools32 13:58:06 INFO - Cleaning up... 13:58:06 INFO - Return code: 0 13:58:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5de25bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', '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 13:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 13:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 13:58:06 INFO - Using env: {'DISPLAY': ':0', 13:58:06 INFO - 'HOME': '/home/cltbld', 13:58:06 INFO - 'LANG': 'en_US.UTF-8', 13:58:06 INFO - 'LANGUAGE': 'en_US:en', 13:58:06 INFO - 'LOGNAME': 'cltbld', 13:58:06 INFO - 'MAIL': '/var/mail/cltbld', 13:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:06 INFO - 'MOZ_NO_REMOTE': '1', 13:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:06 INFO - 'NO_EM_RESTART': '1', 13:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:06 INFO - 'PWD': '/builds/slave/test', 13:58:06 INFO - 'SHELL': '/bin/bash', 13:58:06 INFO - 'SHLVL': '1', 13:58:06 INFO - 'TERM': 'linux', 13:58:06 INFO - 'TMOUT': '86400', 13:58:06 INFO - 'USER': 'cltbld', 13:58:06 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:06 INFO - '_': '/tools/buildbot/bin/python'} 13:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:07 INFO - Downloading/unpacking flake8 13:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:07 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 13:58:07 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 13:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:58:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:58:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:08 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 13:58:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:58:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:58:09 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 13:58:09 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 13:58:09 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 13:58:09 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 13:58:09 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 13:58:09 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 13:58:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:58:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:09 INFO - no previously-included directories found matching 'docs/_build' 13:58:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:58:09 INFO - Running setup.py install for pep8 13:58:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:09 INFO - no previously-included directories found matching 'docs/_build' 13:58:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:58:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:58:09 INFO - Cleaning up... 13:58:09 INFO - Return code: 0 13:58:09 INFO - Running post-action listener: _resource_record_post_action 13:58:09 INFO - Running post-action listener: _start_resource_monitoring 13:58:09 INFO - Starting resource monitoring. 13:58:09 INFO - ##### 13:58:09 INFO - ##### Running install step. 13:58:09 INFO - ##### 13:58:09 INFO - Running pre-action listener: _resource_record_pre_action 13:58:09 INFO - Running main action method: install 13:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:09 INFO - Reading from file tmpfile_stdout 13:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:10 INFO - Reading from file tmpfile_stdout 13:58:10 INFO - Output received: 13:58:10 INFO - Usage: mozinstall [options] installer 13:58:10 INFO - Options: 13:58:10 INFO - -h, --help show this help message and exit 13:58:10 INFO - -d DEST, --destination=DEST 13:58:10 INFO - Directory to install application into. [default: 13:58:10 INFO - "/builds/slave/test"] 13:58:10 INFO - --app=APP Application being installed. [default: firefox] 13:58:10 INFO - mkdir: /builds/slave/test/build/application 13:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:58:24 INFO - Reading from file tmpfile_stdout 13:58:24 INFO - Output received: 13:58:24 INFO - /builds/slave/test/build/application/firefox/firefox 13:58:24 INFO - Running post-action listener: _resource_record_post_action 13:58:24 INFO - ##### 13:58:24 INFO - ##### Running run-tests step. 13:58:24 INFO - ##### 13:58:24 INFO - Running pre-action listener: _resource_record_pre_action 13:58:24 INFO - Running main action method: run_tests 13:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:24 INFO - Python 2.7.3 13:58:24 INFO - Return code: 0 13:58:24 INFO - grabbing minidump binary from tooltool 13:58:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:24 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17660b0>, '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 0x1766fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:24 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 13:58:24 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 13:58:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:24 INFO - Return code: 0 13:58:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:58:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:58:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:58:25 INFO - Return code: 0 13:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 13:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 13:58:25 INFO - Using env: {'DISPLAY': ':0', 13:58:25 INFO - 'HOME': '/home/cltbld', 13:58:25 INFO - 'LANG': 'en_US.UTF-8', 13:58:25 INFO - 'LANGUAGE': 'en_US:en', 13:58:25 INFO - 'LOGNAME': 'cltbld', 13:58:25 INFO - 'MAIL': '/var/mail/cltbld', 13:58:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:25 INFO - 'MOZ_NO_REMOTE': '1', 13:58:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:25 INFO - 'NO_EM_RESTART': '1', 13:58:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:25 INFO - 'PWD': '/builds/slave/test', 13:58:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:25 INFO - 'SHELL': '/bin/bash', 13:58:25 INFO - 'SHLVL': '1', 13:58:25 INFO - 'TERM': 'linux', 13:58:25 INFO - 'TMOUT': '86400', 13:58:25 INFO - 'USER': 'cltbld', 13:58:25 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209', 13:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:25 INFO - '_': '/tools/buildbot/bin/python'} 13:58:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 13:58:25 INFO - mozversion INFO | application_buildid: 20151216124705 13:58:25 INFO - mozversion INFO | application_changeset: 5621bf5d87e491c8856b90e5ff86919c96bf04c6 13:58:25 INFO - mozversion INFO | application_display_name: Nightly 13:58:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:25 INFO - mozversion INFO | application_name: Firefox 13:58:25 INFO - mozversion INFO | application_remotingname: firefox 13:58:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:58:25 INFO - mozversion INFO | application_vendor: Mozilla 13:58:25 INFO - mozversion INFO | application_version: 46.0a1 13:58:25 INFO - mozversion INFO | platform_buildid: 20151216124705 13:58:25 INFO - mozversion INFO | platform_changeset: 5621bf5d87e491c8856b90e5ff86919c96bf04c6 13:58:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:58:25 INFO - mozversion INFO | platform_version: 46.0a1 13:58:25 INFO - 2015-12-16 13:58:25,902 DEBUG : using testdate: 1450303105 13:58:25 INFO - 2015-12-16 13:58:25,902 DEBUG : actual date: 1450303105 13:58:25 INFO - 2015-12-16 13:58:25,910 INFO : starting webserver on 'localhost:50276' 13:58:25 INFO - 2015-12-16 13:58:25,911 INFO : Starting test suite talos-linux64-ix-022.e 13:58:25 INFO - 2015-12-16 13:58:25,911 INFO : Starting test dromaeo_css 13:58:25 INFO - 2015-12-16 13:58:25,911 DEBUG : operating with platform_type : linux_ 13:58:25 INFO - 2015-12-16 13:58:25,911 INFO : Initialising browser for dromaeo_css test... 13:58:25 INFO - 2015-12-16 13:58:25,921 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIfbCEx/profile http://localhost:50276/getInfo.html 13:58:33 INFO - 2015-12-16 13:58:33,863 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:58:33 INFO - 2015-12-16 13:58:33,863 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:58:33 INFO - 2015-12-16 13:58:33,863 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:58:33 INFO - 2015-12-16 13:58:33,863 DEBUG : BROWSER_OUTPUT: __metrics 13:58:34 INFO - 2015-12-16 13:58:34,020 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:58:34 INFO - 2015-12-16 13:58:34,997 INFO : Browser initialized. 13:58:34 INFO - 2015-12-16 13:58:34,998 INFO : Running cycle 1/1 for dromaeo_css test... 13:58:34 INFO - 2015-12-16 13:58:34,998 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIfbCEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:58:47 INFO - 2015-12-16 13:58:47,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 143859712 13:58:47 INFO - 2015-12-16 13:58:47,056 DEBUG : BROWSER_OUTPUT: 13:59:36 INFO - 2015-12-16 13:59:36,700 DEBUG : BROWSER_OUTPUT: 1450303176695 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] 14:01:47 INFO - 2015-12-16 14:01:47,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50276/tests/dromaeo/cssquery-ext.html) 14:01:48 INFO - 2015-12-16 14:01:48,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 148201472 14:01:48 INFO - 2015-12-16 14:01:48,795 DEBUG : BROWSER_OUTPUT: 14:04:50 INFO - 2015-12-16 14:04:50,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-ext.html (next: http://localhost:50276/tests/dromaeo/cssquery-jquery.html) 14:04:51 INFO - 2015-12-16 14:04:51,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 144826368 14:04:51 INFO - 2015-12-16 14:04:51,441 DEBUG : BROWSER_OUTPUT: 14:07:53 INFO - 2015-12-16 14:07:53,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50276/tests/dromaeo/cssquery-mootools.html) 14:07:53 INFO - 2015-12-16 14:07:53,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 146423808 14:07:53 INFO - 2015-12-16 14:07:53,857 DEBUG : BROWSER_OUTPUT: 14:10:55 INFO - 2015-12-16 14:10:55,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50276/tests/dromaeo/cssquery-prototype.html) 14:10:56 INFO - 2015-12-16 14:10:56,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 144994304 14:10:56 INFO - 2015-12-16 14:10:56,275 DEBUG : BROWSER_OUTPUT: 14:13:58 INFO - 2015-12-16 14:13:58,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50276/tests/dromaeo/cssquery-yui.html) 14:13:59 INFO - 2015-12-16 14:13:59,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 145870848 14:13:59 INFO - 2015-12-16 14:13:59,530 DEBUG : BROWSER_OUTPUT: 14:17:01 INFO - 2015-12-16 14:17:01,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-yui.html (next: http://localhost:50276/tests/dromaeo/cssquery-dojo.html) 14:17:02 INFO - 2015-12-16 14:17:02,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 147181568 14:17:02 INFO - 2015-12-16 14:17:02,189 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:17:02 INFO - 2015-12-16 14:17:02,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:17:02 INFO - 2015-12-16 14:17:02,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:17:02 INFO - 2015-12-16 14:17:02,190 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:17:02 INFO - 2015-12-16 14:17:02,191 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2691.327168207948;2692.071235423779;2744.451109778045;2755.8897644094236;2765.26720419089;4631.2821512665505;4760.619150467963;4762.357081793957;4763.071201115784;4770.570648641621;4738.857834264969;4775.6418268629905;4785.377900872882;4806.206975848981;4827.686200396972;4383.649308055348;4458.464984201893;4538.115067561826;4549.476810166823;4597.264437689971;242.2306492107347;4533.9546604534025;4546.818127274922;4549.886252843688;4550.408446901914;4418.3151611500425;4435.8225670973125;4488.640908727294;4495.685302028859;4504.684672072956;4506.59440650343;4507.639388848917;4512.684112112153;4519.7740112994215;4549.840755573572;4230.894227644303;4471.3293006049025;4478.149151661174;4499.437570303712;4523.615492683126;4661.743604101773;4688.320193571947;4734.597559207472;4816.397950256218;4854.635902307341;5143.434222235588;5145.897082058338;5168.741562921877;5204.739763011834;5245.26566280721;4954.529319714621;5212.061828870802;5229.137192363255;5238.947610523884;5243.239730239132;4704.341392205094;4779.569838714532;4798.712077275374;4805.13507568634;4852.296417019583;5331.200319952039;5346.705931173745;5351.25082488452;5351.491608297206;5398.082326004589;4832.492588278251;4955.281484184773;5108.591312694975;5115.232715092766;5128.692278463304;5053.67151135175;5109;5132.923006154911;5135.666181698178;5173.663711858792;5093.668911520814;5139.665921715076;5149.562287205555;5153.845384638467;5187.533122018961;4889.315495830587;4996.825111121093;5032.3961124665275;5145.794168233304;5148.099082660519;4255.957440425618;4256.574342565718;4270.7864606769535;4275.87172384829;4310.913781724348;3717.8326975286177;3725.6088110748524;3750.1749615084636;3780.3951367781024;3783.735138540276;4263.893402664896;4349.695521313541;4374.759388233678;4467.441569803775;4469;5186.81846135391;5200.115980283285;5213.661112027706;5223.320968274176;5272.868178295574;4468.128714900563;4475.597196252353;4479.328100784908;4488.4613846338;4540.545945405499;4335.978320108442;4421.513633500313;4440.267355886307;4454.4877339106415;4473.418455600751;4889.095517329234;4922.08941345845;4933.087378834927;4941.901161976669;4944.975275123601;5179.92230116541;5212.661177023481;5213;5218.269442278008;5243.108671525773;4654.743989080633;4794.256890182028;4807.399075115611;4910.508949105204;4938.703677779345;5113.565346945403;5118.104331742004;5126.410462796826;5133.460986596354;5182.170852663556;5184.559312458332;5208.479152084761;5219.269302297757;5231.293775340432;5234.947650523446;4806;4867.1969125093965;4937.7531123444405;4939.975300123477;4974.228994505857;4970;5001.199808030698;5008.373953255843;5021.648484606042;5051.848444546669;4706.10583989041;4909.877253068702;4923.483034281492;4934.284528743384;4946;4906.460289368238;4930.531599498042;4969.577585905094;5006.899862002812;5041.798328066836;4890.80436782539;4906.92639610399;4927.9507204927495;4929.16204245272;4964.304997300453 14:17:02 INFO - 2015-12-16 14:17:02,195 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.6613432738867;566.7676252736378;577.4571902411732;598.2730981857045;622.1942584353262;35100.82449587752;35872;35876;35882.282354352894;35933.46099808505;36297.45553816695;37144.814275928584;37181.442278365845;37190.8140459298;37243.4413483798;7647.7705668829885;7841.137474877759;7855.921440785604;7858.253465920729;7867.8426431471335;7686.231376862325;7757.728479503218;7798.571078590675;7807.921920780776;7814.296713295802;7828.960855195716;7830.747080467127;7856.685732570719;7887.60561971902;7938.682452701885;7784.377249820029;7835.647395867171;7893.723719669784;7903;7929.1277959425;7746.922530774733;7838.059432868093;7861.095973963011;7881.290683838482;7887.290143887078;33749.49375759366;34190;34216;34219.48670769916;34252.314953700785;2930.6922773108945;2956.896508622188;2963.777716671258;3273.1817045738567;3382.729381649462;26819.32951676224;27848.860755696296;27950.44099118006;27977.788291541165;28537.85731071352;3402.1494626343415;3422.1273575238406;3424.229548351626;3460.913477163066;3529.699975502085;204027;204586;204796;204887;205945.97027014918;49687.50312496829;50809.74595127001;54315.72842135764;54903.725481372334;55460.44539554633;47587.762061189474;48140.27789583159;48384.27423588649;48506.757466212446;48510.39151280623;13406.865931340562;13425.0602457827;13475.056746027683;13477.326133693276;13547.66130846717;10378.27352085362;10400.947995259976;10490.842637360445;10526.263161578616;10551.419671918118;17979.550511237063;18394.63210735778;18406.35577754772;18447.631047378978;18533.90733046353;7555.168931417649;7749.651265692944;7771;7774;7805.180456052146;865.1737590600961;878.2798105553512;882.4484697064335;895.4582477600958;899.8875140607424;25817.354566135997;26351.868240658674;26472;26477.47045059088;26488.73511264863;986.5757724178528;1033.8294181460126;1060.671191930504;1069.4385447640052;1140.3443020263383;13656.863431365558;13758.243296618783;13938.930305348611;14478.710425791636;15228.619284517754;370477;378309;378793;380408;381945;42402.78798605987;42900.78549607232;43009;43009;43115.35326970098;1266.4111188297486;1267.15100882409;1273.605182393461;1274.7259339242294;1275.2412314672754;24472.632910506713;25010.37474063163;25324.366890827878;25367.74632253654;25377.87311063433;36577;36848.07879803026;36980;36988.26023479569;37052.258954820216;196280;196918;198341;198634;198855;28369.29076773097;28371;28880.85559572189;28887.855560722903;29079.563806542497;36322.273554528234;36706.63293367032;37115.628843711216;37164.25671486609;38014.80992595019;31815.363692726478;31872.362552748353;32009.359812803148;32659.836700816344;32865.83567082245;31594.842025790644;32737.67262327346;32872;32915.83542082274;32977.67022329746;30483.847580761954;30504.847475763367;30712.232194195323;30789.538156927218;32468.675313246564;25971.22086337413;27589.86205068962;29422.852885735436;29454;29760.851195743882;22768.544629107655;23424.53150937006;23677.289681309587;23767.881160594086;24028 14:17:02 INFO - 2015-12-16 14:17:02,196 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.7638367718113;344.8241396887588;345.157814931567;345.4352134260487;348.02032279134244;14925;15166.469173578913;15887.84112158878;16230.026198428073;16788.664226715457;10683.198760092986;10691.358518488896;10719.678409647704;12704.4918203272;15141.470048548275;4472.239719247719;4602.07958408318;4605.424321959755;4652.953470465302;5107.336046313974;5012.674176178555;5059.2916991621205;5060.569851562622;5060.746962651852;5064.493550644925;4752.572268495835;4928.926066109011;4942.233953737176;5019.171836646949;5022.121128802463;4903.82836600719;4929.186684197103;4946.826861059882;4961.826336078238;5229.320188375525;5103.56619687327;5120.846374608767;5125.923111153335;5133.8203162889495;5136.895567452978;16307.510774676779;17006.82993170065;17320.307187712475;17659.117044147868;17676.204570794343;1841.373932862833;1844.6126313474188;1863.8508919286423;1885.8397036251936;1931.4881556387568;8867.512286824222;8971.506567138806;9006.549672516414;9102.499362535058;9201.309901757328;1753.95615109622;1775.0680892531395;1782.42071326818;1820.1718218210683;1827.972580411295;52161;53942.73028634871;54009.45990540123;54551;54975.72512137414;9747.707568772948;9898.10917017472;9964.850527242097;9989.700308990741;9993.800123997626;12555.811662825065;12670.11309208365;12688.302143382018;12705.110642254953;12716.809247861289;7006.455016448568;7042.471814613822;7156.964215178891;7170.569765814068;7174.210836807947;6719.798406047728;6821.795346139624;6830.282820303796;6869.484788640772;6898.241193468714;4231.2172248133575;4246.787660616957;4256.936145957813;4258.6380157686945;4295.269804133305;1773.5743421578727;1779.5462157150102;1845.4094689699436;1857.517045568162;1874.6906760384384;766.9003029606228;867.8698195270633;889.3241136736127;922.3359181389388;933.3746389918771;14721.26393680333;14767.187804670632;15098.622534436727;15243.3902643893;15654.37382504687;836.782436566497;858.579296144897;869.1873098652779;933.883264591926;959.2853324273322;8937.329700272376;9069.138431848964;9188.816223675489;9244.121808428188;9259.72220833376;318703;327109;437387;437505;441556;73061;73863.63068184625;74349;74353.6282318585;75466.62266688742;1056.155075939261;1069.8181309177457;1100.1858624617726;1129.9378534180698;1139.0488941733745;14659.780103298672;14683.48607798722;14829.925850370679;14873.107613543221;15280.923595381952;33056.952968803715;33155.83422082874;34187;34260.48609270913;34647.4802877952;46579.301310481045;47199.52800471951;47624;47852;47930;8554.700585479479;8586.699465518677;8752.606132723915;8815.647374104963;8825.867611985954;10293.53679084428;11108.222424430212;16369.67260654804;16373.181340933144;16550.337986480405;10073.546690398804;11239.438028098399;12904.612861614167;13277.468901243841;13429.932850335686;12571.811422828849;12686.048546359245;13098.345082746015;13344.733105337644;13358.064935454426;10368.481575921325;14031;14039.227842468354;14215.076020059078;14338.068025578305;8054.194580542134;8524.659013639384;8537.103604121477;8564.74305770828;8764.605592748469;9159.49622770754;11248.550057997916;12690.555830545887;12791.552295669979;13391.799123012968 14:17:02 INFO - 2015-12-16 14:17:02,197 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.5201535508627;1646.135778716174;1728.939487117951;1733.4279687703058;1749.2740512687244;6992.895106573405;7078.823029424267;7200.711971521146;7472.439567032474;7473.215312392195;7422.294881986203;7474.140473845509;7526.209747976466;7528.096628404599;7528.774136775892;2070.9896450517726;2097.8216851567636;2105.2842033708534;2114.1966052899875;2116.3227767114454;2083.9479013024643;2084.049351723171;2119.682047692843;2139.454439118023;2140.882251476176;1711.6234428425726;1760.392664530735;2036.5621391400846;2070.0995067145764;2093.194120263694;2030.0864610925144;2039.7552293724773;2040.6734922412343;2041.9591608167827;2046.887421191834;2000.2099170827441;2027.9493012674654;2065.824404925568;2066.555690526544;2078.147959336665;7082.716691332341;7186.820329491752;7223.566586004857;7225.927740722631;7227.7831665050135;4119.8970025749295;4154.293770059097;4161.750294982311;4185.204811085914;4218.34615634574;2645.4841305945347;2707.0795929384103;2712.755851973312;2770.9445811083865;2774.542200536909;859.8452278589851;871.9346049046284;881.2157180109707;890.6971629645951;921.9446833189963;9616.23070154386;9689.806203875884;9705.223582113485;9736.269779766546;9738.853917191247;3670.247599242149;3697.5378077740284;3740.9625903741157;3766.849326026983;3774.094217387807;7593.126790419062;7598.620068996528;7615.238476152341;7619.504732192389;7624.27569380908;4154.127633197002;4163.39630753539;4165.187788381237;4176.916461670749;4189.91620167601;3815.198808250243;3829.368154254517;3846.11539345952;3854.8843534694006;3855.556610989716;3094.319249765048;3152.1646763607664;3155.684431556872;3169.0968074099233;3191.792533485316;894.7002754077326;895.2435192262528;908.0329449136648;916.0244339778249;916.5508900638639;797.1988151907296;798.0024968789014;921.7049049647537;986.013986013986;1166.2069792541154;6747.696353664097;6799.626020568818;6816.522843401013;6820.863582728417;6840.726370945106;568.7440651706748;580.4282781460258;584.2200662116038;589.1486801571688;725.0248415880632;5264.894702105937;5268.552173065333;5269.394019687785;5315.521603055744;5326.067938110893;8208.835823283502;8720.345974051972;8736.563171841382;8761.693340733043;8783.25342345895;8570.142985701379;8591.09793471689;8599.61301741423;8656.09111043344;8684.044755076937;6600.900986485302;6607.933920660732;6617.371349721769;6723.193216814014;6774.72901083961;6613.768518101843;6630.867382652416;6634.0712300278965;6639.3360663935155;6644.335566443317;7553.093628764584;7702.961485192538;7794.415418843723;7867.881981770163;7885.2114788520685;7832.882506762289;7975.122736499096;8003.59982000886;8021.679132834622;8069.394795390486;6012.338642749207;6026.367231440636;6043.637381757108;6088.452039316483;6131.662758548323;6917;6920.5847649141215;6961.095057642474;6995.440364770908;7019.508634395544;6250.562460627712;6413.35866413355;6420.486361091008;6497.610143391223;6580.901286480803;6317.084022816574;6321.209848768904;6354.809355719336;6410.711517981609;6501.9674901625185;6461.386168314003;6610.2398224204835;6669.633170175687;6683.933160668331;6700.095487109178;5972.163897054329;6004.609700369462;6011.458968692838;6052.606580572248;6063.120847477179;5836.066229403275;5876.676782776988;5891.705414729332;5926.644401335933;5935.0207215808905 14:17:02 INFO - 2015-12-16 14:17:02,199 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.1818907060231;301.505530929276;303.68871906296056;304.5021390027305;305.32980108661485;5608.327000759915;5619.7471113799875;5625.240592520008;5630.352509461408;5776.682282474462;5576.693281869496;5633.971830140844;5655.095184770437;5665.971670141654;5666.320041595004;4140.958590414088;4292.570742925714;4299.957000429987;4311.525732169459;4312.417823593806;4229.34445160999;4235.66114710824;4248.511421186572;4253.978730106345;4257.531671516131;4174.102567947891;4187.350960601112;4188.183304255671;4213.346931225649;4253.638440732541;4253.680973926952;4261.403403523509;4264.315595339855;4265.765382903939;4267.850625228102;3715.1826598148364;3722.4602432647384;3729.1422972716427;3729.8881033569037;3737.3459644562095;5146.382434107931;5201.609879259033;5310.867228319285;5312.379724184122;5342.91985620216;4822;4844.32179494871;4856.951430485685;4863.562279394871;4870.123377791996;5859.912101318484;5872.06047032477;5872.265966754156;5874.647521148745;5884.411558844125;3866.420036994445;3987.760734355948;3989.2221016901717;3990.8027591722366;4001.459802926626;6132.969335153341;6188.040853667689;6207.503399728011;6212.347703491114;6212.4408803207925;4120.670346372283;4132.710710250253;4139;4140.565240649748;4144.109016561454;4195.706300558993;4207.053412982054;4207.158568286355;4208.684348673862;4216.9578304217175;4753;4850.272459131159;4850.296706977539;4854.83008094715;4855.6601037927;5842.532597392198;5842.824715258549;5851.297844258716;5852.7658893643775;5869.207656966255;1475.8007668964767;1494.8280947691155;1494.8579884910916;1496.775483677457;1497.3187199824272;967.274544091931;993.5975929748463;997.3467378866853;1001.8129455177826;1016.501914062119;5130.486951304914;5140.228965655107;5142.845714628567;5147.202183661539;5155.922661160085;6103.176071230416;6104.236970378703;6106.816795496142;6117.174181485531;6119.724612392453;5126.102931986888;5142.202958541432;5144.871378215575;5147.227915812583;5152.484751524892;3243.6594157613113;3280.065181423283;3315.6684331567135;3317.8175200364212;3327.8835240766457;5702.087665973508;5781.53747700183;5782.45066718661;5789.942100579025;5791.82624521265;6343.111964324906;6385.680715964183;6395.712192951329;6396.200474940632;6407.711652975534;5766.654000759884;5850.765969361263;5852.122181672613;5853.678047707417;5860.238169037998;6081.270848628459;6145.66198859067;6167.969160154171;6173.59871608344;6180.134781130555;5990.520758339409;6014.578979471395;6029.51763858899;6033.245844269466;6033.698315084316;5823.650580965155;5824.912626310524;5830.708464576669;5838.532917366685;5849.415058494116;4141.461609990682;4191.580841915906;4195.937060944149;4201.852935147255;4215.430916826189;6059.72731227087;6192.752289908353;6200.627962322275;6203.31763506023;6207.131001659862;5898.498627616529;5908.084246941731;5918.852028699317;5926.496247818984;5926.644401335933;5955.851103722442;5961.731722072604;5964.135200395832;5968.940310597012;5972.64164150135;5610.49505544503;5749.367569567261;5755.165501002248;5790.536757059509;5810.128480727924;6004.279486461653;6008.579399441997;6010.879782404415;6017;6017.247844019497;5842.298924129132;5842.707864606838;5844.912326315194;5850.268716410449;5852.18069470283 14:17:02 INFO - 2015-12-16 14:17:02,199 DEBUG : BROWSER_OUTPUT: |5;yui.html;623.5105442227853;770.1643716567525;778.2140038561051;781.0471225105373;787.9133295337512;12195;12293.569725059624;12305.446254918528;12311.815322770144;12380.814287785679;11458.960965237684;11500.022498087672;11708.473118709657;11804.940975295112;11867.584634537792;796.7649543384701;812.9227723366271;813.1299509524811;814.1776805426503;814.7433558429076;821.256762629818;833.7165363776314;835.5488036460334;835.8662613981764;836.2682652678906;861.4013260783727;873.0832625742976;874.8818909447239;874.9081346458594;876.4697358098355;861.9698310559163;865.126222515261;865.3120768988638;866.6879923227633;867.3538214030525;640.4268179978893;643.0450780590819;643.1189270699125;643.2506130358128;644.912936753537;12448.25310481365;12503.49986000559;12509.061820363419;12531.74936501274;12593.874061259361;10536.683899483029;10601.946990265076;10740.24818262722;10932.398718070503;11126;9233.584488698025;9235.538223088819;9258.814823703555;9443.858342124873;9477.90522094784;3141.952870706941;3156.352947645727;3227.144806626246;3242.0598026572266;3290.0952238134464;38416.23167536633;38513.999999999716;38861.41707874384;39023.804880975695;39199.41200881989;8761.824763504694;8810.691625793066;8906.821863562822;9071.27429805614;9088.863667045;15506.844931550766;15664.138472384127;15763.605909852346;15767.211639418212;15780.60548486297;5849.2103566018895;5902.409759024149;5966.31387390447;6152.230971128609;6189.164462797555;3344.1973926257524;3379.0369744622662;3386.305807309496;3395.4567269236804;3408;2650.748178922999;2728.4543091381406;2738.3975525384385;2743.4101668141448;2745.7803375729895;498.6534358620724;503.79092676539557;505.6334157735686;508.21480812145325;509.24377299709903;532.2575007864008;609.5793902207463;623.2147494157304;625.8967270400424;629.0532748213909;8009.399295052895;8013.599320033975;8026.197380261927;8067.394945379003;8096.230858068474;467.56049313645065;497.04071142694227;501.90212908483227;622.4646803748773;624.1231070346171;3708.2583483302906;3719.20037192005;3808.904777380588;3919.470871432377;3959.5050618672667;46478.76760616243;46967.06065878732;47117.293240601415;47131.764341178074;47958.76020619875;41617;42374.576254237065;42564.36153457701;42596.1480770389;42664.78667606642;38063.04842378907;38375;38399.80800095982;38466.2306753869;39274.607253927665;7770.45606807518;8022.358211343195;8047.758567242992;8048.5170889746805;8088.272055515032;31149.377012459172;31163.37673246477;31400.842995784875;31450.21374465657;31821;35143.47284790679;35163.82418087893;37351.62648373481;39186.21627567376;39273.42906283717;10088.142507886618;10185.185185185315;10238.539265733209;10295.639652612123;10307.484625768531;11020.118390528578;11206.887931120911;11247.718807029562;11266.591676040494;11269.66191014271;10742;10785;10877;10918.890811092106;11067.94466027697;10548.156147508027;10901.563937442414;10907.345559266469;11289.37908415045;11311.038561722016;10498.317609355672;10924.344539327665;11180.273282236954;11265.943670281596;11274.210805243554;9177.053395479857;9427.3400861939;9471.242300615797;9823.26325525574;9926.503674816375;8629.43908645936;8837.955810221165;8939.955300223457;9314.623543042771;9486.810263794823 14:17:02 INFO - 2015-12-16 14:17:02,199 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,339 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1450304222188__endTimestamp 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,200 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4727.65 Median:4889.10 stddev:612.56 (12.5%) stddev-sans-first:593.25 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: Values: 2691.3 2692.1 2744.5 2755.9 2765.3 4631.3 4760.6 4762.4 4763.1 4770.6 4738.9 4775.6 4785.4 4806.2 4827.7 4383.6 4458.5 4538.1 4549.5 4597.3 242.2 4534.0 4546.8 4549.9 4550.4 4418.3 4435.8 4488.6 4495.7 4504.7 4506.6 4507.6 4512.7 4519.8 4549.8 4230.9 4471.3 4478.1 4499.4 4523.6 4661.7 4688.3 4734.6 4816.4 4854.6 5143.4 5145.9 5168.7 5204.7 5245.3 4954.5 5212.1 5229.1 5238.9 5243.2 4704.3 4779.6 4798.7 4805.1 4852.3 5331.2 5346.7 5351.3 5351.5 5398.1 4832.5 4955.3 5108.6 5115.2 5128.7 5053.7 5109.0 5132.9 5135.7 5173.7 5093.7 5139.7 5149.6 5153.8 5187.5 4889.3 4996.8 5032.4 5145.8 5148.1 4256.0 4256.6 4270.8 4275.9 4310.9 3717.8 3725.6 3750.2 3780.4 3783.7 4263.9 4349.7 4374.8 4467.4 4469.0 5186.8 5200.1 5213.7 5223.3 5272.9 4468.1 4475.6 4479.3 4488.5 4540.5 4336.0 4421.5 4440.3 4454.5 4473.4 4889.1 4922.1 4933.1 4941.9 4945.0 5179.9 5212.7 5213.0 5218.3 5243.1 4654.7 4794.3 4807.4 4910.5 4938.7 5113.6 5118.1 5126.4 5133.5 5182.2 5184.6 5208.5 5219.3 5231.3 5234.9 4806.0 4867.2 4937.8 4940.0 4974.2 4970.0 5001.2 5008.4 5021.6 5051.8 4706.1 4909.9 4923.5 4934.3 4946.0 4906.5 4930.5 4969.6 5006.9 5041.8 4890.8 4906.9 4928.0 4929.2 4964.3 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40976.78 Median:18796.07 stddev:72009.96 (383.1%) stddev-sans-first:72148.00 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: Values: 550.7 566.8 577.5 598.3 622.2 35100.8 35872.0 35876.0 35882.3 35933.5 36297.5 37144.8 37181.4 37190.8 37243.4 7647.8 7841.1 7855.9 7858.3 7867.8 7686.2 7757.7 7798.6 7807.9 7814.3 7829.0 7830.7 7856.7 7887.6 7938.7 7784.4 7835.6 7893.7 7903.0 7929.1 7746.9 7838.1 7861.1 7881.3 7887.3 33749.5 34190.0 34216.0 34219.5 34252.3 2930.7 2956.9 2963.8 3273.2 3382.7 26819.3 27848.9 27950.4 27977.8 28537.9 3402.1 3422.1 3424.2 3460.9 3529.7 204027.0 204586.0 204796.0 204887.0 205946.0 49687.5 50809.7 54315.7 54903.7 55460.4 47587.8 48140.3 48384.3 48506.8 48510.4 13406.9 13425.1 13475.1 13477.3 13547.7 10378.3 10400.9 10490.8 10526.3 10551.4 17979.6 18394.6 18406.4 18447.6 18533.9 7555.2 7749.7 7771.0 7774.0 7805.2 865.2 878.3 882.4 895.5 899.9 25817.4 26351.9 26472.0 26477.5 26488.7 986.6 1033.8 1060.7 1069.4 1140.3 13656.9 13758.2 13938.9 14478.7 15228.6 370477.0 378309.0 378793.0 380408.0 381945.0 42402.8 42900.8 43009.0 43009.0 43115.4 1266.4 1267.2 1273.6 1274.7 1275.2 24472.6 25010.4 25324.4 25367.7 25377.9 36577.0 36848.1 36980.0 36988.3 37052.3 196280.0 196918.0 198341.0 198634.0 198855.0 28369.3 28371.0 28880.9 28887.9 29079.6 36322.3 36706.6 37115.6 37164.3 38014.8 31815.4 31872.4 32009.4 32659.8 32865.8 31594.8 32737.7 32872.0 32915.8 32977.7 30483.8 30504.8 30712.2 30789.5 32468.7 25971.2 27589.9 29422.9 29454.0 29760.9 22768.5 23424.5 23677.3 23767.9 24028.0 14:17:02 INFO - 2015-12-16 14:17:02,201 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,202 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23640.95 Median:220841.13 stddev:65109.52 (29.5%) stddev-sans-first:65268.67 14:17:02 INFO - 2015-12-16 14:17:02,202 DEBUG : BROWSER_OUTPUT: Values: 344.8 344.8 345.2 345.4 348.0 14925.0 15166.5 15887.8 16230.0 16788.7 10683.2 10691.4 10719.7 12704.5 15141.5 4472.2 4602.1 4605.4 4653.0 5107.3 5012.7 5059.3 5060.6 5060.7 5064.5 4752.6 4928.9 4942.2 5019.2 5022.1 4903.8 4929.2 4946.8 4961.8 5229.3 5103.6 5120.8 5125.9 5133.8 5136.9 16307.5 17006.8 17320.3 17659.1 17676.2 1841.4 1844.6 1863.9 1885.8 1931.5 8867.5 8971.5 9006.5 9102.5 9201.3 1754.0 1775.1 1782.4 1820.2 1828.0 52161.0 53942.7 54009.5 54551.0 54975.7 9747.7 9898.1 9964.9 9989.7 9993.8 12555.8 12670.1 12688.3 12705.1 12716.8 7006.5 7042.5 7157.0 7170.6 7174.2 6719.8 6821.8 6830.3 6869.5 6898.2 4231.2 4246.8 4256.9 4258.6 4295.3 1773.6 1779.5 1845.4 1857.5 1874.7 766.9 867.9 889.3 922.3 933.4 14721.3 14767.2 15098.6 15243.4 15654.4 836.8 858.6 869.2 933.9 959.3 8937.3 9069.1 9188.8 9244.1 9259.7 318703.0 327109.0 437387.0 437505.0 441556.0 73061.0 73863.6 74349.0 74353.6 75466.6 1056.2 1069.8 1100.2 1129.9 1139.0 14659.8 14683.5 14829.9 14873.1 15280.9 33057.0 33155.8 34187.0 34260.5 34647.5 46579.3 47199.5 47624.0 47852.0 47930.0 8554.7 8586.7 8752.6 8815.6 8825.9 10293.5 11108.2 16369.7 16373.2 16550.3 10073.5 11239.4 12904.6 13277.5 13429.9 12571.8 12686.0 13098.3 13344.7 13358.1 10368.5 14031.0 14039.2 14215.1 14338.1 8054.2 8524.7 8537.1 8564.7 8764.6 9159.5 11248.6 12690.6 12791.6 13391.8 14:17:02 INFO - 2015-12-16 14:17:02,202 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,202 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4973.12 Median:6416.92 stddev:2628.46 (41.0%) stddev-sans-first:2622.87 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: Values: 1499.5 1646.1 1728.9 1733.4 1749.3 6992.9 7078.8 7200.7 7472.4 7473.2 7422.3 7474.1 7526.2 7528.1 7528.8 2071.0 2097.8 2105.3 2114.2 2116.3 2083.9 2084.0 2119.7 2139.5 2140.9 1711.6 1760.4 2036.6 2070.1 2093.2 2030.1 2039.8 2040.7 2042.0 2046.9 2000.2 2027.9 2065.8 2066.6 2078.1 7082.7 7186.8 7223.6 7225.9 7227.8 4119.9 4154.3 4161.8 4185.2 4218.3 2645.5 2707.1 2712.8 2770.9 2774.5 859.8 871.9 881.2 890.7 921.9 9616.2 9689.8 9705.2 9736.3 9738.9 3670.2 3697.5 3741.0 3766.8 3774.1 7593.1 7598.6 7615.2 7619.5 7624.3 4154.1 4163.4 4165.2 4176.9 4189.9 3815.2 3829.4 3846.1 3854.9 3855.6 3094.3 3152.2 3155.7 3169.1 3191.8 894.7 895.2 908.0 916.0 916.6 797.2 798.0 921.7 986.0 1166.2 6747.7 6799.6 6816.5 6820.9 6840.7 568.7 580.4 584.2 589.1 725.0 5264.9 5268.6 5269.4 5315.5 5326.1 8208.8 8720.3 8736.6 8761.7 8783.3 8570.1 8591.1 8599.6 8656.1 8684.0 6600.9 6607.9 6617.4 6723.2 6774.7 6613.8 6630.9 6634.1 6639.3 6644.3 7553.1 7703.0 7794.4 7867.9 7885.2 7832.9 7975.1 8003.6 8021.7 8069.4 6012.3 6026.4 6043.6 6088.5 6131.7 6917.0 6920.6 6961.1 6995.4 7019.5 6250.6 6413.4 6420.5 6497.6 6580.9 6317.1 6321.2 6354.8 6410.7 6502.0 6461.4 6610.2 6669.6 6683.9 6700.1 5972.2 6004.6 6011.5 6052.6 6063.1 5836.1 5876.7 5891.7 5926.6 5935.0 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4874.82 Median:5622.49 stddev:1463.06 (26.0%) stddev-sans-first:1426.16 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: Values: 292.2 301.5 303.7 304.5 305.3 5608.3 5619.7 5625.2 5630.4 5776.7 5576.7 5634.0 5655.1 5666.0 5666.3 4141.0 4292.6 4300.0 4311.5 4312.4 4229.3 4235.7 4248.5 4254.0 4257.5 4174.1 4187.4 4188.2 4213.3 4253.6 4253.7 4261.4 4264.3 4265.8 4267.9 3715.2 3722.5 3729.1 3729.9 3737.3 5146.4 5201.6 5310.9 5312.4 5342.9 4822.0 4844.3 4857.0 4863.6 4870.1 5859.9 5872.1 5872.3 5874.6 5884.4 3866.4 3987.8 3989.2 3990.8 4001.5 6133.0 6188.0 6207.5 6212.3 6212.4 4120.7 4132.7 4139.0 4140.6 4144.1 4195.7 4207.1 4207.2 4208.7 4217.0 4753.0 4850.3 4850.3 4854.8 4855.7 5842.5 5842.8 5851.3 5852.8 5869.2 1475.8 1494.8 1494.9 1496.8 1497.3 967.3 993.6 997.3 1001.8 1016.5 5130.5 5140.2 5142.8 5147.2 5155.9 6103.2 6104.2 6106.8 6117.2 6119.7 5126.1 5142.2 5144.9 5147.2 5152.5 3243.7 3280.1 3315.7 3317.8 3327.9 5702.1 5781.5 5782.5 5789.9 5791.8 6343.1 6385.7 6395.7 6396.2 6407.7 5766.7 5850.8 5852.1 5853.7 5860.2 6081.3 6145.7 6168.0 6173.6 6180.1 5990.5 6014.6 6029.5 6033.2 6033.7 5823.7 5824.9 5830.7 5838.5 5849.4 4141.5 4191.6 4195.9 4201.9 4215.4 6059.7 6192.8 6200.6 6203.3 6207.1 5898.5 5908.1 5918.9 5926.5 5926.6 5955.9 5961.7 5964.1 5968.9 5972.6 5610.5 5749.4 5755.2 5790.5 5810.1 6004.3 6008.6 6010.9 6017.0 6017.2 5842.3 5842.7 5844.9 5850.3 5852.2 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,204 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11977.77 Median:41995.79 stddev:13124.96 (31.3%) stddev-sans-first:13134.07 14:17:02 INFO - 2015-12-16 14:17:02,205 DEBUG : BROWSER_OUTPUT: Values: 623.5 770.2 778.2 781.0 787.9 12195.0 12293.6 12305.4 12311.8 12380.8 11459.0 11500.0 11708.5 11804.9 11867.6 796.8 812.9 813.1 814.2 814.7 821.3 833.7 835.5 835.9 836.3 861.4 873.1 874.9 874.9 876.5 862.0 865.1 865.3 866.7 867.4 640.4 643.0 643.1 643.3 644.9 12448.3 12503.5 12509.1 12531.7 12593.9 10536.7 10601.9 10740.2 10932.4 11126.0 9233.6 9235.5 9258.8 9443.9 9477.9 3142.0 3156.4 3227.1 3242.1 3290.1 38416.2 38514.0 38861.4 39023.8 39199.4 8761.8 8810.7 8906.8 9071.3 9088.9 15506.8 15664.1 15763.6 15767.2 15780.6 5849.2 5902.4 5966.3 6152.2 6189.2 3344.2 3379.0 3386.3 3395.5 3408.0 2650.7 2728.5 2738.4 2743.4 2745.8 498.7 503.8 505.6 508.2 509.2 532.3 609.6 623.2 625.9 629.1 8009.4 8013.6 8026.2 8067.4 8096.2 467.6 497.0 501.9 622.5 624.1 3708.3 3719.2 3808.9 3919.5 3959.5 46478.8 46967.1 47117.3 47131.8 47958.8 41617.0 42374.6 42564.4 42596.1 42664.8 38063.0 38375.0 38399.8 38466.2 39274.6 7770.5 8022.4 8047.8 8048.5 8088.3 31149.4 31163.4 31400.8 31450.2 31821.0 35143.5 35163.8 37351.6 39186.2 39273.4 10088.1 10185.2 10238.5 10295.6 10307.5 11020.1 11206.9 11247.7 11266.6 11269.7 10742.0 10785.0 10877.0 10918.9 11067.9 10548.2 10901.6 10907.3 11289.4 11311.0 10498.3 10924.3 11180.3 11265.9 11274.2 9177.1 9427.3 9471.2 9823.3 9926.5 8629.4 8838.0 8940.0 9314.6 9486.8 14:17:02 INFO - 2015-12-16 14:17:02,205 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:17:02 INFO - 2015-12-16 14:17:02,205 DEBUG : BROWSER_OUTPUT: 14:17:02 INFO - 2015-12-16 14:17:02,989 INFO : Browser exited with error code: 0 14:17:03 INFO - 2015-12-16 14:17:03,008 INFO : Completed test dromaeo_css (00:18:37) 14:17:03 INFO - 2015-12-16 14:17:03,008 INFO : Starting test kraken 14:17:03 INFO - 2015-12-16 14:17:03,008 DEBUG : operating with platform_type : linux_ 14:17:03 INFO - 2015-12-16 14:17:03,008 INFO : Initialising browser for kraken test... 14:17:03 INFO - 2015-12-16 14:17:03,015 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PXEOo/profile http://localhost:50276/getInfo.html 14:17:07 INFO - 2015-12-16 14:17:07,905 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:07 INFO - 2015-12-16 14:17:07,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:07 INFO - 2015-12-16 14:17:07,905 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:17:07 INFO - 2015-12-16 14:17:07,905 DEBUG : BROWSER_OUTPUT: __metrics 14:17:08 INFO - 2015-12-16 14:17:08,046 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:17:08 INFO - 2015-12-16 14:17:08,929 INFO : Browser initialized. 14:17:08 INFO - 2015-12-16 14:17:08,930 INFO : Running cycle 1/1 for kraken test... 14:17:08 INFO - 2015-12-16 14:17:08,930 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PXEOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:20 INFO - 2015-12-16 14:17:20,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 143208448 14:17:20 INFO - 2015-12-16 14:17:20,954 DEBUG : BROWSER_OUTPUT: 14:17:23 INFO - 2015-12-16 14:17:23,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:24 INFO - 2015-12-16 14:17:24,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 143499264 14:17:24 INFO - 2015-12-16 14:17:24,158 DEBUG : BROWSER_OUTPUT: 14:17:26 INFO - 2015-12-16 14:17:26,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-dft) 14:17:27 INFO - 2015-12-16 14:17:27,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 144080896 14:17:27 INFO - 2015-12-16 14:17:27,518 DEBUG : BROWSER_OUTPUT: 14:17:30 INFO - 2015-12-16 14:17:30,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-fft) 14:17:30 INFO - 2015-12-16 14:17:30,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 137707520 14:17:30 INFO - 2015-12-16 14:17:30,990 DEBUG : BROWSER_OUTPUT: 14:17:33 INFO - 2015-12-16 14:17:33,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-oscillator) 14:17:33 INFO - 2015-12-16 14:17:33,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 14:17:33 INFO - 2015-12-16 14:17:33,724 DEBUG : BROWSER_OUTPUT: 14:17:36 INFO - 2015-12-16 14:17:36,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:36 INFO - 2015-12-16 14:17:36,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 14:17:36 INFO - 2015-12-16 14:17:36,597 DEBUG : BROWSER_OUTPUT: 14:17:39 INFO - 2015-12-16 14:17:39,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:40 INFO - 2015-12-16 14:17:40,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 140877824 14:17:40 INFO - 2015-12-16 14:17:40,230 DEBUG : BROWSER_OUTPUT: 14:17:43 INFO - 2015-12-16 14:17:43,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:44 INFO - 2015-12-16 14:17:44,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 137568256 14:17:44 INFO - 2015-12-16 14:17:44,286 DEBUG : BROWSER_OUTPUT: 14:17:47 INFO - 2015-12-16 14:17:47,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50276/tests/kraken/driver.html?testName=json-parse-financial) 14:17:47 INFO - 2015-12-16 14:17:47,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 137707520 14:17:47 INFO - 2015-12-16 14:17:47,786 DEBUG : BROWSER_OUTPUT: 14:17:49 INFO - 2015-12-16 14:17:49,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:50 INFO - 2015-12-16 14:17:50,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 14:17:50 INFO - 2015-12-16 14:17:50,155 DEBUG : BROWSER_OUTPUT: 14:17:52 INFO - 2015-12-16 14:17:52,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:52 INFO - 2015-12-16 14:17:52,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 141344768 14:17:52 INFO - 2015-12-16 14:17:52,666 DEBUG : BROWSER_OUTPUT: 14:17:54 INFO - 2015-12-16 14:17:54,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:55 INFO - 2015-12-16 14:17:55,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 14:17:55 INFO - 2015-12-16 14:17:55,476 DEBUG : BROWSER_OUTPUT: 14:17:58 INFO - 2015-12-16 14:17:58,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:58 INFO - 2015-12-16 14:17:58,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 140636160 14:17:58 INFO - 2015-12-16 14:17:58,617 DEBUG : BROWSER_OUTPUT: 14:18:01 INFO - 2015-12-16 14:18:01,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:01 INFO - 2015-12-16 14:18:01,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 140857344 14:18:01 INFO - 2015-12-16 14:18:01,842 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50276/tests/kraken/driver.html?testName=ai-astar) 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 141516800 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;110;113;113;115;127;113;114;113;116 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;131;160;179;130;157;151;131;171;139 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;162;161;168;166;159;163;163 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;74;72;73;72;133;71;72;74 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;96;140;95;96;95;140;97;99;137 14:18:03 INFO - 2015-12-16 14:18:03,879 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;111;110;110 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;148;147;148;147;148;148;147;147 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;96;98;96;97;96;97 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;74;74;74;75;84;74;75;74 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;67;68;71;69;67;69 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;83;87;86;86;93;88;86;85;88 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;120;133;124;123;126;124;124;124;122 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;154;151;152;157;139;145;152;155;147 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;73;74;71;71;73;70;74;73;72 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:18:03 INFO - 2015-12-16 14:18:03,880 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,800 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: __startTimestamp1450304283874__endTimestamp 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,881 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:4.61 (4.0%) stddev-sans-first:4.83 14:18:03 INFO - 2015-12-16 14:18:03,882 DEBUG : BROWSER_OUTPUT: Values: 117.0 110.0 113.0 113.0 115.0 127.0 113.0 114.0 113.0 116.0 14:18:03 INFO - 2015-12-16 14:18:03,882 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,882 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.00 stddev:17.32 (11.1%) stddev-sans-first:18.29 14:18:03 INFO - 2015-12-16 14:18:03,882 DEBUG : BROWSER_OUTPUT: Values: 155.0 131.0 160.0 179.0 130.0 157.0 151.0 131.0 171.0 139.0 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.65 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 161.0 168.0 166.0 159.0 163.0 163.0 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:72.00 stddev:19.17 (26.6%) stddev-sans-first:20.19 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 74.0 72.0 73.0 72.0 133.0 71.0 72.0 74.0 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:20.61 (21.5%) stddev-sans-first:21.38 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 140.0 95.0 96.0 95.0 140.0 97.0 99.0 137.0 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:18:03 INFO - 2015-12-16 14:18:03,883 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 148.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 96.0 98.0 96.0 97.0 96.0 97.0 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:74.00 stddev:3.12 (4.2%) stddev-sans-first:3.28 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 74.0 74.0 74.0 75.0 84.0 74.0 75.0 74.0 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 14:18:03 INFO - 2015-12-16 14:18:03,884 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 67.0 68.0 71.0 69.0 67.0 69.0 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:3.65 (4.2%) stddev-sans-first:2.76 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: Values: 95.0 83.0 87.0 86.0 86.0 93.0 88.0 86.0 85.0 88.0 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:124.00 stddev:3.49 (2.8%) stddev-sans-first:3.61 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: Values: 122.0 120.0 133.0 124.0 123.0 126.0 124.0 124.0 124.0 122.0 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.00 stddev:5.47 (3.6%) stddev-sans-first:5.63 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: Values: 146.0 154.0 151.0 152.0 157.0 139.0 145.0 152.0 155.0 147.0 14:18:03 INFO - 2015-12-16 14:18:03,885 DEBUG : BROWSER_OUTPUT: 14:18:03 INFO - 2015-12-16 14:18:03,886 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 14:18:03 INFO - 2015-12-16 14:18:03,886 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 74.0 71.0 71.0 73.0 70.0 74.0 73.0 72.0 14:18:03 INFO - 2015-12-16 14:18:03,886 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:18:03 INFO - 2015-12-16 14:18:03,886 DEBUG : BROWSER_OUTPUT: 14:18:04 INFO - 2015-12-16 14:18:04,761 INFO : Browser exited with error code: 0 14:18:04 INFO - 2015-12-16 14:18:04,813 INFO : Completed test kraken (00:01:01) 14:18:04 INFO - 2015-12-16 14:18:04,813 INFO : Starting test v8_7 14:18:04 INFO - 2015-12-16 14:18:04,813 DEBUG : operating with platform_type : linux_ 14:18:04 INFO - 2015-12-16 14:18:04,813 INFO : Initialising browser for v8_7 test... 14:18:04 INFO - 2015-12-16 14:18:04,819 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIUOj4/profile http://localhost:50276/getInfo.html 14:18:09 INFO - 2015-12-16 14:18:09,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:18:09 INFO - 2015-12-16 14:18:09,480 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:18:09 INFO - 2015-12-16 14:18:09,480 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:18:09 INFO - 2015-12-16 14:18:09,480 DEBUG : BROWSER_OUTPUT: __metrics 14:18:09 INFO - 2015-12-16 14:18:09,642 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:18:10 INFO - 2015-12-16 14:18:10,557 INFO : Browser initialized. 14:18:10 INFO - 2015-12-16 14:18:10,557 INFO : Running cycle 1/1 for v8_7 test... 14:18:10 INFO - 2015-12-16 14:18:10,558 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIUOj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:18:22 INFO - 2015-12-16 14:18:22,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 14:18:22 INFO - 2015-12-16 14:18:22,538 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50276/tests/v8_7/run.html (next: http://localhost:50276/tests/v8_7/run.html) 14:18:44 INFO - 2015-12-16 14:18:44,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 14:18:44 INFO - 2015-12-16 14:18:44,300 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,300 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:18:44 INFO - 2015-12-16 14:18:44,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:18:44 INFO - 2015-12-16 14:18:44,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7550140891762 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.39977872026554 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1082.2510822510822 14:18:44 INFO - 2015-12-16 14:18:44,301 DEBUG : BROWSER_OUTPUT: |5;Earley;718.3908045977012 14:18:44 INFO - 2015-12-16 14:18:44,302 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 14:18:44 INFO - 2015-12-16 14:18:44,302 DEBUG : BROWSER_OUTPUT: |7;RegExp;26473.684210526317 14:18:44 INFO - 2015-12-16 14:18:44,302 DEBUG : BROWSER_OUTPUT: |8;Splay;600.9615384615385 14:18:44 INFO - 2015-12-16 14:18:44,302 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:18:44 INFO - 2015-12-16 14:18:44,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: __startTimestamp1450304324297__endTimestamp 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,303 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: Values: 165.8 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.40 Median:184.40 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: Values: 184.4 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,304 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: Values: 279.1 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: Values: 5196.9 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: Values: 1082.3 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: Values: 718.4 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,305 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: Values: 12345.7 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26473.68 Median:26473.68 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: Values: 26473.7 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: Values: 601.0 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:18:44 INFO - 2015-12-16 14:18:44,306 DEBUG : BROWSER_OUTPUT: 14:18:45 INFO - 2015-12-16 14:18:45,217 INFO : Browser exited with error code: 0 14:18:45 INFO - 2015-12-16 14:18:45,231 INFO : Completed test v8_7 (00:00:40) 14:18:45 INFO - 2015-12-16 14:18:45,325 INFO : Completed test suite (00:20:19) 14:18:45 INFO - 2015-12-16 14:18:45,326 DEBUG : Working with test: dromaeo_css 14:18:45 INFO - 2015-12-16 14:18:45,326 DEBUG : Generating results file: dromaeo_css 14:18:45 INFO - 2015-12-16 14:18:45,327 DEBUG : Working with test: kraken 14:18:45 INFO - 2015-12-16 14:18:45,327 DEBUG : Generating results file: kraken 14:18:45 INFO - 2015-12-16 14:18:45,328 INFO : javascript benchmark 14:18:45 INFO - 2015-12-16 14:18:45,328 DEBUG : Working with test: v8_7 14:18:45 INFO - 2015-12-16 14:18:45,328 DEBUG : Generating results file: v8_7 14:18:45 INFO - 2015-12-16 14:18:45,328 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:45 INFO - 2015-12-16 14:18:45,385 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 14:18:45 INFO - 2015-12-16 14:18:45,385 DEBUG : process_Request line: dromaeo_css 6321.23 graph.html#tests=[[72,132,43]] 14:18:45 INFO - 2015-12-16 14:18:45,386 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:45 INFO - 2015-12-16 14:18:45,416 DEBUG : process_Request line: kraken 1547.80 graph.html#tests=[[232,132,43]] 14:18:45 INFO - 2015-12-16 14:18:45,416 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:45 INFO - 2015-12-16 14:18:45,451 DEBUG : process_Request line: v8_7 21281.92 graph.html#tests=[[230,132,43]] 14:18:45 INFO - 2015-12-16 14:18:45,452 INFO : javascript benchmark 14:18:45 INFO - 2015-12-16 14:18:45,456 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2691.327168207948, 2692.071235423779, 2744.451109778045, 2755.8897644094236, 2765.26720419089, 4631.2821512665505, 4760.619150467963, 4762.357081793957, 4763.071201115784, 4770.570648641621, 4738.857834264969, 4775.6418268629905, 4785.377900872882, 4806.206975848981, 4827.686200396972, 4383.649308055348, 4458.464984201893, 4538.115067561826, 4549.476810166823, 4597.264437689971, 242.2306492107347, 4533.9546604534025, 4546.818127274922, 4549.886252843688, 4550.408446901914, 4418.3151611500425, 4435.8225670973125, 4488.640908727294, 4495.685302028859, 4504.684672072956, 4506.59440650343, 4507.639388848917, 4512.684112112153, 4519.7740112994215, 4549.840755573572, 4230.894227644303, 4471.3293006049025, 4478.149151661174, 4499.437570303712, 4523.615492683126, 4661.743604101773, 4688.320193571947, 4734.597559207472, 4816.397950256218, 4854.635902307341, 5143.434222235588, 5145.897082058338, 5168.741562921877, 5204.739763011834, 5245.26566280721, 4954.529319714621, 5212.061828870802, 5229.137192363255, 5238.947610523884, 5243.239730239132, 4704.341392205094, 4779.569838714532, 4798.712077275374, 4805.13507568634, 4852.296417019583, 5331.200319952039, 5346.705931173745, 5351.25082488452, 5351.491608297206, 5398.082326004589, 4832.492588278251, 4955.281484184773, 5108.591312694975, 5115.232715092766, 5128.692278463304, 5053.67151135175, 5109.0, 5132.923006154911, 5135.666181698178, 5173.663711858792, 5093.668911520814, 5139.665921715076, 5149.562287205555, 5153.845384638467, 5187.533122018961, 4889.315495830587, 4996.825111121093, 5032.3961124665275, 5145.794168233304, 5148.099082660519, 4255.957440425618, 4256.574342565718, 4270.7864606769535, 4275.87172384829, 4310.913781724348, 3717.8326975286177, 3725.6088110748524, 3750.1749615084636, 3780.3951367781024, 3783.735138540276, 4263.893402664896, 4349.695521313541, 4374.759388233678, 4467.441569803775, 4469.0, 5186.81846135391, 5200.115980283285, 5213.661112027706, 5223.320968274176, 5272.868178295574, 4468.128714900563, 4475.597196252353, 4479.328100784908, 4488.4613846338, 4540.545945405499, 4335.978320108442, 4421.513633500313, 4440.267355886307, 4454.4877339106415, 4473.418455600751, 4889.095517329234, 4922.08941345845, 4933.087378834927, 4941.901161976669, 4944.975275123601, 5179.92230116541, 5212.661177023481, 5213.0, 5218.269442278008, 5243.108671525773, 4654.743989080633, 4794.256890182028, 4807.399075115611, 4910.508949105204, 4938.703677779345, 5113.565346945403, 5118.104331742004, 5126.410462796826, 5133.460986596354, 5182.170852663556, 5184.559312458332, 5208.479152084761, 5219.269302297757, 5231.293775340432, 5234.947650523446, 4806.0, 4867.1969125093965, 4937.7531123444405, 4939.975300123477, 4974.228994505857, 4970.0, 5001.199808030698, 5008.373953255843, 5021.648484606042, 5051.848444546669, 4706.10583989041, 4909.877253068702, 4923.483034281492, 4934.284528743384, 4946.0, 4906.460289368238, 4930.531599498042, 4969.577585905094, 5006.899862002812, 5041.798328066836, 4890.80436782539, 4906.92639610399, 4927.9507204927495, 4929.16204245272, 4964.304997300453], "unit": "score", "name": "dojo.html", "value": 4692.0823369892905}, {"lowerIsBetter": false, "replicates": [550.6613432738867, 566.7676252736378, 577.4571902411732, 598.2730981857045, 622.1942584353262, 35100.82449587752, 35872.0, 35876.0, 35882.282354352894, 35933.46099808505, 36297.45553816695, 37144.814275928584, 37181.442278365845, 37190.8140459298, 37243.4413483798, 7647.7705668829885, 7841.137474877759, 7855.921440785604, 7858.253465920729, 7867.8426431471335, 7686.231376862325, 7757.728479503218, 7798.571078590675, 7807.921920780776, 7814.296713295802, 7828.960855195716, 7830.747080467127, 7856.685732570719, 7887.60561971902, 7938.682452701885, 7784.377249820029, 7835.647395867171, 7893.723719669784, 7903.0, 7929.1277959425, 7746.922530774733, 7838.059432868093, 7861.095973963011, 7881.290683838482, 7887.290143887078, 33749.49375759366, 34190.0, 34216.0, 34219.48670769916, 34252.314953700785, 2930.6922773108945, 2956.896508622188, 2963.777716671258, 3273.1817045738567, 3382.729381649462, 26819.32951676224, 27848.860755696296, 27950.44099118006, 27977.788291541165, 28537.85731071352, 3402.1494626343415, 3422.1273575238406, 3424.229548351626, 3460.913477163066, 3529.699975502085, 204027.0, 204586.0, 204796.0, 204887.0, 205945.97027014918, 49687.50312496829, 50809.74595127001, 54315.72842135764, 54903.725481372334, 55460.44539554633, 47587.762061189474, 48140.27789583159, 48384.27423588649, 48506.757466212446, 48510.39151280623, 13406.865931340562, 13425.0602457827, 13475.056746027683, 13477.326133693276, 13547.66130846717, 10378.27352085362, 10400.947995259976, 10490.842637360445, 10526.263161578616, 10551.419671918118, 17979.550511237063, 18394.63210735778, 18406.35577754772, 18447.631047378978, 18533.90733046353, 7555.168931417649, 7749.651265692944, 7771.0, 7774.0, 7805.180456052146, 865.1737590600961, 878.2798105553512, 882.4484697064335, 895.4582477600958, 899.8875140607424, 25817.354566135997, 26351.868240658674, 26472.0, 26477.47045059088, 26488.73511264863, 986.5757724178528, 1033.8294181460126, 1060.671191930504, 1069.4385447640052, 1140.3443020263383, 13656.863431365558, 13758.243296618783, 13938.930305348611, 14478.710425791636, 15228.619284517754, 370477.0, 378309.0, 378793.0, 380408.0, 381945.0, 42402.78798605987, 42900.78549607232, 43009.0, 43009.0, 43115.35326970098, 1266.4111188297486, 1267.15100882409, 1273.605182393461, 1274.7259339242294, 1275.2412314672754, 24472.632910506713, 25010.37474063163, 25324.366890827878, 25367.74632253654, 25377.87311063433, 36577.0, 36848.07879803026, 36980.0, 36988.26023479569, 37052.258954820216, 196280.0, 196918.0, 198341.0, 198634.0, 198855.0, 28369.29076773097, 28371.0, 28880.85559572189, 28887.855560722903, 29079.563806542497, 36322.273554528234, 36706.63293367032, 37115.628843711216, 37164.25671486609, 38014.80992595019, 31815.363692726478, 31872.362552748353, 32009.359812803148, 32659.836700816344, 32865.83567082245, 31594.842025790644, 32737.67262327346, 32872.0, 32915.83542082274, 32977.67022329746, 30483.847580761954, 30504.847475763367, 30712.232194195323, 30789.538156927218, 32468.675313246564, 25971.22086337413, 27589.86205068962, 29422.852885735436, 29454.0, 29760.851195743882, 22768.544629107655, 23424.53150937006, 23677.289681309587, 23767.881160594086, 24028.0], "unit": "score", "name": "ext.html", "value": 16546.093168031217}, {"lowerIsBetter": false, "replicates": [344.7638367718113, 344.8241396887588, 345.157814931567, 345.4352134260487, 348.02032279134244, 14925.0, 15166.469173578913, 15887.84112158878, 16230.026198428073, 16788.664226715457, 10683.198760092986, 10691.358518488896, 10719.678409647704, 12704.4918203272, 15141.470048548275, 4472.239719247719, 4602.07958408318, 4605.424321959755, 4652.953470465302, 5107.336046313974, 5012.674176178555, 5059.2916991621205, 5060.569851562622, 5060.746962651852, 5064.493550644925, 4752.572268495835, 4928.926066109011, 4942.233953737176, 5019.171836646949, 5022.121128802463, 4903.82836600719, 4929.186684197103, 4946.826861059882, 4961.826336078238, 5229.320188375525, 5103.56619687327, 5120.846374608767, 5125.923111153335, 5133.8203162889495, 5136.895567452978, 16307.510774676779, 17006.82993170065, 17320.307187712475, 17659.117044147868, 17676.204570794343, 1841.373932862833, 1844.6126313474188, 1863.8508919286423, 1885.8397036251936, 1931.4881556387568, 8867.512286824222, 8971.506567138806, 9006.549672516414, 9102.499362535058, 9201.309901757328, 1753.95615109622, 1775.0680892531395, 1782.42071326818, 1820.1718218210683, 1827.972580411295, 52161.0, 53942.73028634871, 54009.45990540123, 54551.0, 54975.72512137414, 9747.707568772948, 9898.10917017472, 9964.850527242097, 9989.700308990741, 9993.800123997626, 12555.811662825065, 12670.11309208365, 12688.302143382018, 12705.110642254953, 12716.809247861289, 7006.455016448568, 7042.471814613822, 7156.964215178891, 7170.569765814068, 7174.210836807947, 6719.798406047728, 6821.795346139624, 6830.282820303796, 6869.484788640772, 6898.241193468714, 4231.2172248133575, 4246.787660616957, 4256.936145957813, 4258.6380157686945, 4295.269804133305, 1773.5743421578727, 1779.5462157150102, 1845.4094689699436, 1857.517045568162, 1874.6906760384384, 766.9003029606228, 867.8698195270633, 889.3241136736127, 922.3359181389388, 933.3746389918771, 14721.26393680333, 14767.187804670632, 15098.622534436727, 15243.3902643893, 15654.37382504687, 836.782436566497, 858.579296144897, 869.1873098652779, 933.883264591926, 959.2853324273322, 8937.329700272376, 9069.138431848964, 9188.816223675489, 9244.121808428188, 9259.72220833376, 318703.0, 327109.0, 437387.0, 437505.0, 441556.0, 73061.0, 73863.63068184625, 74349.0, 74353.6282318585, 75466.62266688742, 1056.155075939261, 1069.8181309177457, 1100.1858624617726, 1129.9378534180698, 1139.0488941733745, 14659.780103298672, 14683.48607798722, 14829.925850370679, 14873.107613543221, 15280.923595381952, 33056.952968803715, 33155.83422082874, 34187.0, 34260.48609270913, 34647.4802877952, 46579.301310481045, 47199.52800471951, 47624.0, 47852.0, 47930.0, 8554.700585479479, 8586.699465518677, 8752.606132723915, 8815.647374104963, 8825.867611985954, 10293.53679084428, 11108.222424430212, 16369.67260654804, 16373.181340933144, 16550.337986480405, 10073.546690398804, 11239.438028098399, 12904.612861614167, 13277.468901243841, 13429.932850335686, 12571.811422828849, 12686.048546359245, 13098.345082746015, 13344.733105337644, 13358.064935454426, 10368.481575921325, 14031.0, 14039.227842468354, 14215.076020059078, 14338.068025578305, 8054.194580542134, 8524.659013639384, 8537.103604121477, 8564.74305770828, 8764.605592748469, 9159.49622770754, 11248.550057997916, 12690.555830545887, 12791.552295669979, 13391.799123012968], "unit": "score", "name": "jquery.html", "value": 8125.856496781302}, {"lowerIsBetter": false, "replicates": [1499.5201535508627, 1646.135778716174, 1728.939487117951, 1733.4279687703058, 1749.2740512687244, 6992.895106573405, 7078.823029424267, 7200.711971521146, 7472.439567032474, 7473.215312392195, 7422.294881986203, 7474.140473845509, 7526.209747976466, 7528.096628404599, 7528.774136775892, 2070.9896450517726, 2097.8216851567636, 2105.2842033708534, 2114.1966052899875, 2116.3227767114454, 2083.9479013024643, 2084.049351723171, 2119.682047692843, 2139.454439118023, 2140.882251476176, 1711.6234428425726, 1760.392664530735, 2036.5621391400846, 2070.0995067145764, 2093.194120263694, 2030.0864610925144, 2039.7552293724773, 2040.6734922412343, 2041.9591608167827, 2046.887421191834, 2000.2099170827441, 2027.9493012674654, 2065.824404925568, 2066.555690526544, 2078.147959336665, 7082.716691332341, 7186.820329491752, 7223.566586004857, 7225.927740722631, 7227.7831665050135, 4119.8970025749295, 4154.293770059097, 4161.750294982311, 4185.204811085914, 4218.34615634574, 2645.4841305945347, 2707.0795929384103, 2712.755851973312, 2770.9445811083865, 2774.542200536909, 859.8452278589851, 871.9346049046284, 881.2157180109707, 890.6971629645951, 921.9446833189963, 9616.23070154386, 9689.806203875884, 9705.223582113485, 9736.269779766546, 9738.853917191247, 3670.247599242149, 3697.5378077740284, 3740.9625903741157, 3766.849326026983, 3774.094217387807, 7593.126790419062, 7598.620068996528, 7615.238476152341, 7619.504732192389, 7624.27569380908, 4154.127633197002, 4163.39630753539, 4165.187788381237, 4176.916461670749, 4189.91620167601, 3815.198808250243, 3829.368154254517, 3846.11539345952, 3854.8843534694006, 3855.556610989716, 3094.319249765048, 3152.1646763607664, 3155.684431556872, 3169.0968074099233, 3191.792533485316, 894.7002754077326, 895.2435192262528, 908.0329449136648, 916.0244339778249, 916.5508900638639, 797.1988151907296, 798.0024968789014, 921.7049049647537, 986.013986013986, 1166.2069792541154, 6747.696353664097, 6799.626020568818, 6816.522843401013, 6820.863582728417, 6840.726370945106, 568.7440651706748, 580.4282781460258, 584.2200662116038, 589.1486801571688, 725.0248415880632, 5264.894702105937, 5268.552173065333, 5269.394019687785, 5315.521603055744, 5326.067938110893, 8208.835823283502, 8720.345974051972, 8736.563171841382, 8761.693340733043, 8783.25342345895, 8570.142985701379, 8591.09793471689, 8599.61301741423, 8656.09111043344, 8684.044755076937, 6600.900986485302, 6607.933920660732, 6617.371349721769, 6723.193216814014, 6774.72901083961, 6613.768518101843, 6630.867382652416, 6634.0712300278965, 6639.3360663935155, 6644.335566443317, 7553.093628764584, 7702.961485192538, 7794.415418843723, 7867.881981770163, 7885.2114788520685, 7832.882506762289, 7975.122736499096, 8003.59982000886, 8021.679132834622, 8069.394795390486, 6012.338642749207, 6026.367231440636, 6043.637381757108, 6088.452039316483, 6131.662758548323, 6917.0, 6920.5847649141215, 6961.095057642474, 6995.440364770908, 7019.508634395544, 6250.562460627712, 6413.35866413355, 6420.486361091008, 6497.610143391223, 6580.901286480803, 6317.084022816574, 6321.209848768904, 6354.809355719336, 6410.711517981609, 6501.9674901625185, 6461.386168314003, 6610.2398224204835, 6669.633170175687, 6683.933160668331, 6700.095487109178, 5972.163897054329, 6004.609700369462, 6011.458968692838, 6052.606580572248, 6063.120847477179, 5836.066229403275, 5876.676782776988, 5891.705414729332, 5926.644401335933, 5935.0207215808905], "unit": "score", "name": "mootools.html", "value": 4007.5482065060723}, {"lowerIsBetter": false, "replicates": [292.1818907060231, 301.505530929276, 303.68871906296056, 304.5021390027305, 305.32980108661485, 5608.327000759915, 5619.7471113799875, 5625.240592520008, 5630.352509461408, 5776.682282474462, 5576.693281869496, 5633.971830140844, 5655.095184770437, 5665.971670141654, 5666.320041595004, 4140.958590414088, 4292.570742925714, 4299.957000429987, 4311.525732169459, 4312.417823593806, 4229.34445160999, 4235.66114710824, 4248.511421186572, 4253.978730106345, 4257.531671516131, 4174.102567947891, 4187.350960601112, 4188.183304255671, 4213.346931225649, 4253.638440732541, 4253.680973926952, 4261.403403523509, 4264.315595339855, 4265.765382903939, 4267.850625228102, 3715.1826598148364, 3722.4602432647384, 3729.1422972716427, 3729.8881033569037, 3737.3459644562095, 5146.382434107931, 5201.609879259033, 5310.867228319285, 5312.379724184122, 5342.91985620216, 4822.0, 4844.32179494871, 4856.951430485685, 4863.562279394871, 4870.123377791996, 5859.912101318484, 5872.06047032477, 5872.265966754156, 5874.647521148745, 5884.411558844125, 3866.420036994445, 3987.760734355948, 3989.2221016901717, 3990.8027591722366, 4001.459802926626, 6132.969335153341, 6188.040853667689, 6207.503399728011, 6212.347703491114, 6212.4408803207925, 4120.670346372283, 4132.710710250253, 4139.0, 4140.565240649748, 4144.109016561454, 4195.706300558993, 4207.053412982054, 4207.158568286355, 4208.684348673862, 4216.9578304217175, 4753.0, 4850.272459131159, 4850.296706977539, 4854.83008094715, 4855.6601037927, 5842.532597392198, 5842.824715258549, 5851.297844258716, 5852.7658893643775, 5869.207656966255, 1475.8007668964767, 1494.8280947691155, 1494.8579884910916, 1496.775483677457, 1497.3187199824272, 967.274544091931, 993.5975929748463, 997.3467378866853, 1001.8129455177826, 1016.501914062119, 5130.486951304914, 5140.228965655107, 5142.845714628567, 5147.202183661539, 5155.922661160085, 6103.176071230416, 6104.236970378703, 6106.816795496142, 6117.174181485531, 6119.724612392453, 5126.102931986888, 5142.202958541432, 5144.871378215575, 5147.227915812583, 5152.484751524892, 3243.6594157613113, 3280.065181423283, 3315.6684331567135, 3317.8175200364212, 3327.8835240766457, 5702.087665973508, 5781.53747700183, 5782.45066718661, 5789.942100579025, 5791.82624521265, 6343.111964324906, 6385.680715964183, 6395.712192951329, 6396.200474940632, 6407.711652975534, 5766.654000759884, 5850.765969361263, 5852.122181672613, 5853.678047707417, 5860.238169037998, 6081.270848628459, 6145.66198859067, 6167.969160154171, 6173.59871608344, 6180.134781130555, 5990.520758339409, 6014.578979471395, 6029.51763858899, 6033.245844269466, 6033.698315084316, 5823.650580965155, 5824.912626310524, 5830.708464576669, 5838.532917366685, 5849.415058494116, 4141.461609990682, 4191.580841915906, 4195.937060944149, 4201.852935147255, 4215.430916826189, 6059.72731227087, 6192.752289908353, 6200.627962322275, 6203.31763506023, 6207.131001659862, 5898.498627616529, 5908.084246941731, 5918.852028699317, 5926.496247818984, 5926.644401335933, 5955.851103722442, 5961.731722072604, 5964.135200395832, 5968.940310597012, 5972.64164150135, 5610.49505544503, 5749.367569567261, 5755.165501002248, 5790.536757059509, 5810.128480727924, 6004.279486461653, 6008.579399441997, 6010.879782404415, 6017.0, 6017.247844019497, 5842.298924129132, 5842.707864606838, 5844.912326315194, 5850.268716410449, 5852.18069470283], "unit": "score", "name": "prototype.html", "value": 4397.59302562018}, {"lowerIsBetter": false, "replicates": [623.5105442227853, 770.1643716567525, 778.2140038561051, 781.0471225105373, 787.9133295337512, 12195.0, 12293.569725059624, 12305.446254918528, 12311.815322770144, 12380.814287785679, 11458.960965237684, 11500.022498087672, 11708.473118709657, 11804.940975295112, 11867.584634537792, 796.7649543384701, 812.9227723366271, 813.1299509524811, 814.1776805426503, 814.7433558429076, 821.256762629818, 833.7165363776314, 835.5488036460334, 835.8662613981764, 836.2682652678906, 861.4013260783727, 873.0832625742976, 874.8818909447239, 874.9081346458594, 876.4697358098355, 861.9698310559163, 865.126222515261, 865.3120768988638, 866.6879923227633, 867.3538214030525, 640.4268179978893, 643.0450780590819, 643.1189270699125, 643.2506130358128, 644.912936753537, 12448.25310481365, 12503.49986000559, 12509.061820363419, 12531.74936501274, 12593.874061259361, 10536.683899483029, 10601.946990265076, 10740.24818262722, 10932.398718070503, 11126.0, 9233.584488698025, 9235.538223088819, 9258.814823703555, 9443.858342124873, 9477.90522094784, 3141.952870706941, 3156.352947645727, 3227.144806626246, 3242.0598026572266, 3290.0952238134464, 38416.23167536633, 38513.999999999716, 38861.41707874384, 39023.804880975695, 39199.41200881989, 8761.824763504694, 8810.691625793066, 8906.821863562822, 9071.27429805614, 9088.863667045, 15506.844931550766, 15664.138472384127, 15763.605909852346, 15767.211639418212, 15780.60548486297, 5849.2103566018895, 5902.409759024149, 5966.31387390447, 6152.230971128609, 6189.164462797555, 3344.1973926257524, 3379.0369744622662, 3386.305807309496, 3395.4567269236804, 3408.0, 2650.748178922999, 2728.4543091381406, 2738.3975525384385, 2743.4101668141448, 2745.7803375729895, 498.6534358620724, 503.79092676539557, 505.6334157735686, 508.21480812145325, 509.24377299709903, 532.2575007864008, 609.5793902207463, 623.2147494157304, 625.8967270400424, 629.0532748213909, 8009.399295052895, 8013.599320033975, 8026.197380261927, 8067.394945379003, 8096.230858068474, 467.56049313645065, 497.04071142694227, 501.90212908483227, 622.4646803748773, 624.1231070346171, 3708.2583483302906, 3719.20037192005, 3808.904777380588, 3919.470871432377, 3959.5050618672667, 46478.76760616243, 46967.06065878732, 47117.293240601415, 47131.764341178074, 47958.76020619875, 41617.0, 42374.576254237065, 42564.36153457701, 42596.1480770389, 42664.78667606642, 38063.04842378907, 38375.0, 38399.80800095982, 38466.2306753869, 39274.607253927665, 7770.45606807518, 8022.358211343195, 8047.758567242992, 8048.5170889746805, 8088.272055515032, 31149.377012459172, 31163.37673246477, 31400.842995784875, 31450.21374465657, 31821.0, 35143.47284790679, 35163.82418087893, 37351.62648373481, 39186.21627567376, 39273.42906283717, 10088.142507886618, 10185.185185185315, 10238.539265733209, 10295.639652612123, 10307.484625768531, 11020.118390528578, 11206.887931120911, 11247.718807029562, 11266.591676040494, 11269.66191014271, 10742.0, 10785.0, 10877.0, 10918.890811092106, 11067.94466027697, 10548.156147508027, 10901.563937442414, 10907.345559266469, 11289.37908415045, 11311.038561722016, 10498.317609355672, 10924.344539327665, 11180.273282236954, 11265.943670281596, 11274.210805243554, 9177.053395479857, 9427.3400861939, 9471.242300615797, 9823.26325525574, 9926.503674816375, 8629.43908645936, 8837.955810221165, 8939.955300223457, 9314.623543042771, 9486.810263794823], "unit": "score", "name": "yui.html", "value": 5737.7744926376545}], "name": "dromaeo_css", "value": 6321.231894645012}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 113.0, 113.0, 115.0, 127.0, 113.0, 114.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 160.0, 179.0, 130.0, 157.0, 151.0, 131.0, 171.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 168.0, 166.0, 159.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 74.0, 72.0, 73.0, 72.0, 133.0, 71.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 140.0, 95.0, 96.0, 95.0, 140.0, 97.0, 99.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 98.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 74.0, 74.0, 75.0, 84.0, 74.0, 75.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 71.0, 69.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [95.0, 83.0, 87.0, 86.0, 86.0, 93.0, 88.0, 86.0, 85.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 133.0, 124.0, 123.0, 126.0, 124.0, 124.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [146.0, 154.0, 151.0, 152.0, 157.0, 139.0, 145.0, 152.0, 155.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 71.0, 71.0, 73.0, 70.0, 74.0, 73.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1547.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [184.39977872026554], "unit": "score", "name": "DeltaBlue", "value": 358.5579139999999}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [26473.684210526317], "unit": "score", "name": "RegExp", "value": 34.410964214711704}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21281.924760323167}]} 14:18:45 INFO - RETURN: dromaeo_css: 6321.23 14:18:45 INFO - RETURN: kraken: 1547.80 14:18:45 INFO - RETURN: v8_7: 21281.92 14:18:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21281.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6321.23"}}} 14:18:45 INFO - Return code: 0 14:18:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:18:45 INFO - # TBPL SUCCESS # 14:18:45 INFO - Running post-action listener: _resource_record_post_action 14:18:45 INFO - Running post-run listener: _resource_record_post_run 14:18:46 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10645504; Write bytes: 387530752; Read time: 3484; Write time: 347000 14:18:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 909312; Read time: 0; Write time: 76 14:18:46 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8908800; Write bytes: 386621440; Read time: 3400; Write time: 346924 14:18:46 INFO - Running post-run listener: _upload_blobber_files 14:18:46 INFO - Blob upload gear active. 14:18:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:18:46 INFO - Copying logs to upload dir... 14:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.346629 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-16 14:18:46.654677) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 14:18:46.657822) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009890 build_url: 'https://queue.taskcluster.net/v1/task/ECHjxHuIQ8Gh5t1g5OizFw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 14:18:46.709918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 14:18:46.710333) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450303045.572330-29559209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 14:18:46.760542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 14:18:46.760903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 14:18:46.761260) ========= ========= Total master_lag: -0.20 =========