builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1451540489.09 results: success (0) buildid: 20151230211837 builduid: 622b87ddcc02468d8cd07c3824941846 revision: ebaa931f095af094dbccca6c760cf923e2211257 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.089453) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.090157) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.090653) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.122934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.123439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.142991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.143630) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004763 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.194180) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.194529) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.195077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.195429) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 21:41:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-12-30 21:41:29 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.388079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.388417) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014389 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.438808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.439159) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebaa931f095af094dbccca6c760cf923e2211257 --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 ebaa931f095af094dbccca6c760cf923e2211257 --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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 21:41:29,887 truncating revision to first 12 chars 2015-12-30 21:41:29,887 Setting DEBUG logging. 2015-12-30 21:41:29,888 attempt 1/10 2015-12-30 21:41:29,888 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebaa931f095a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 21:41:30,137 unpacking tar archive at: fx-team-ebaa931f095a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.978580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.979001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.986582) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.987026) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 21:41:29.987545) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-12-30 21:41:29.990706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:30 INFO - MultiFileLogger online at 20151230 21:41:30 in /builds/slave/test 21:41:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:41:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:30 INFO - {'append_to_log': False, 21:41:30 INFO - 'base_work_dir': '/builds/slave/test', 21:41:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:41:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:30 INFO - 'branch': 'Fx-Team-Non-PGO', 21:41:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:30 INFO - 'config_files': ('talos/linux_config.py',), 21:41:30 INFO - 'default_actions': ('clobber', 21:41:30 INFO - 'read-buildbot-config', 21:41:30 INFO - 'download-and-extract', 21:41:30 INFO - 'populate-webroot', 21:41:30 INFO - 'create-virtualenv', 21:41:30 INFO - 'install', 21:41:30 INFO - 'run-tests'), 21:41:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:30 INFO - 'download_minidump_stackwalk': True, 21:41:30 INFO - 'download_symbols': 'ondemand', 21:41:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:30 INFO - 'installer_path': 'installer.exe', 21:41:30 INFO - 'log_level': 'info', 21:41:30 INFO - 'log_name': 'talos', 21:41:30 INFO - 'log_to_console': True, 21:41:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:30 INFO - 'opt_config_files': (), 21:41:30 INFO - 'pip_index': False, 21:41:30 INFO - 'sps_profile': False, 21:41:30 INFO - 'sps_profile_interval': 0, 21:41:30 INFO - 'suite': 'dromaeojs', 21:41:30 INFO - 'system_bits': '32', 21:41:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:30 INFO - 'title': 'talos-linux64-ix-054', 21:41:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:30 INFO - 'use_talos_json': True, 21:41:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:30 INFO - 'work_dir': 'build'} 21:41:30 INFO - ##### 21:41:30 INFO - ##### Running clobber step. 21:41:30 INFO - ##### 21:41:30 INFO - Running pre-action listener: _resource_record_pre_action 21:41:30 INFO - Running main action method: clobber 21:41:30 INFO - rmtree: /builds/slave/test/build 21:41:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:30 INFO - Running post-action listener: _resource_record_post_action 21:41:30 INFO - ##### 21:41:30 INFO - ##### Running read-buildbot-config step. 21:41:30 INFO - ##### 21:41:30 INFO - Running pre-action listener: _resource_record_pre_action 21:41:30 INFO - Running main action method: read_buildbot_config 21:41:30 INFO - Using buildbot properties: 21:41:30 INFO - { 21:41:30 INFO - "project": "", 21:41:30 INFO - "product": "firefox", 21:41:30 INFO - "script_repo_revision": "production", 21:41:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:41:30 INFO - "repository": "", 21:41:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:41:30 INFO - "buildid": "20151230211837", 21:41:30 INFO - "pgo_build": "False", 21:41:30 INFO - "basedir": "/builds/slave/test", 21:41:30 INFO - "buildnumber": 1063, 21:41:30 INFO - "slavename": "talos-linux64-ix-054", 21:41:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:41:30 INFO - "platform": "ubuntu64_hw", 21:41:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:41:30 INFO - "branch": "fx-team", 21:41:30 INFO - "repo_path": "integration/fx-team", 21:41:30 INFO - "revision": "ebaa931f095af094dbccca6c760cf923e2211257", 21:41:30 INFO - "stage_platform": "linux64", 21:41:30 INFO - "builduid": "622b87ddcc02468d8cd07c3824941846", 21:41:30 INFO - "slavebuilddir": "test" 21:41:30 INFO - } 21:41:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:41:30 INFO - Running post-action listener: _resource_record_post_action 21:41:30 INFO - ##### 21:41:30 INFO - ##### Running download-and-extract step. 21:41:30 INFO - ##### 21:41:30 INFO - Running pre-action listener: _resource_record_pre_action 21:41:30 INFO - Running main action method: download_and_extract 21:41:30 INFO - mkdir: /builds/slave/test/build/tests 21:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:30 INFO - https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/test_packages.json 21:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/test_packages.json 21:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:41:36 INFO - Downloaded 1302 bytes. 21:41:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:41:36 INFO - Using the following test package requirements: 21:41:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:41:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:41:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'jsshell-linux-x86_64.zip'], 21:41:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:41:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:41:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:41:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:41:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:41:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:41:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:41:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:41:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:41:36 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')]} 21:41:36 INFO - https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:40 INFO - Downloaded 21946243 bytes. 21:41:40 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 21:41:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:40 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 21:41:41 INFO - Return code: 0 21:41:41 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 21:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:41 INFO - https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:42 INFO - Downloaded 21946243 bytes. 21:41:42 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 21:41:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:41:42 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 21:41:43 INFO - Return code: 0 21:41: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')]} 21:41:43 INFO - https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:44 INFO - Downloaded 11132285 bytes. 21:41:44 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 21:41:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:41:44 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 21:41:44 INFO - Return code: 0 21:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:44 INFO - https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UiOTEL5WSnS-LyYavjg5Yw/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 21:41:45 INFO - Downloaded 53367156 bytes. 21:41:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:41:45 INFO - mkdir: /builds/slave/test/properties 21:41:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:41:45 INFO - Writing to file /builds/slave/test/properties/build_url 21:41:45 INFO - Contents: 21:41:45 INFO - build_url:https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:41:45 INFO - Running post-action listener: _resource_record_post_action 21:41:45 INFO - Running post-action listener: set_extra_try_arguments 21:41:45 INFO - ##### 21:41:45 INFO - ##### Running populate-webroot step. 21:41:45 INFO - ##### 21:41:45 INFO - Running pre-action listener: _resource_record_pre_action 21:41:45 INFO - Running main action method: populate_webroot 21:41:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:41:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:41:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:41:45 INFO - '--tppagecycles', 21:41:45 INFO - '7'], 21:41:45 INFO - 'tests': ['tsvgm']}}, 21:41:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:41:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:41:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:41:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:41:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'tests': ['damp', 'tps']}, 21:41:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['damp', 'tps']}, 21:41:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:41:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:41:45 INFO - 'other': {'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'other_l64': {'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'other_nol64': {'tests': ['a11yr', 21:41:45 INFO - 'ts_paint', 21:41:45 INFO - 'tpaint', 21:41:45 INFO - 'sessionrestore', 21:41:45 INFO - 'sessionrestore_no_auto_restore']}, 21:41:45 INFO - 'svgr': {'tests': ['tsvgx', 21:41:45 INFO - 'tsvgr_opacity', 21:41:45 INFO - 'tart', 21:41:45 INFO - 'tscrollx', 21:41:45 INFO - 'cart']}, 21:41:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['tsvgx', 21:41:45 INFO - 'tsvgr_opacity', 21:41:45 INFO - 'tart', 21:41:45 INFO - 'tscrollx', 21:41:45 INFO - 'cart']}, 21:41:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'tests': ['tp5o']}, 21:41:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'talos_options': ['--e10s'], 21:41:45 INFO - 'tests': ['tp5o']}, 21:41:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'talos_options': ['--xperf_path', 21:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:45 INFO - 'tests': ['tp5n']}, 21:41:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:45 INFO - 'talos_options': ['--e10s', 21:41:45 INFO - '--xperf_path', 21:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:45 INFO - 'tests': ['tp5n']}}, 21:41:45 INFO - 'talos.zip': {'path': '', 21:41:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:41:45 INFO - Running post-action listener: _resource_record_post_action 21:41:45 INFO - ##### 21:41:45 INFO - ##### Running create-virtualenv step. 21:41:45 INFO - ##### 21:41:45 INFO - Running pre-action listener: _resource_record_pre_action 21:41:45 INFO - Running main action method: create_virtualenv 21:41:45 INFO - Creating virtualenv /builds/slave/test/build/venv 21:41:45 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 21:41:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:41:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:41:46 INFO - Using real prefix '/usr' 21:41:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:41:46 INFO - Installing distribute.............................................................................................................................................................................................done. 21:41:48 INFO - Installing pip.................done. 21:41:48 INFO - Return code: 0 21:41:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:41:48 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')]} 21:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:48 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')]} 21:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:48 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:48 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 21:41:48 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 21:41:48 INFO - Using env: {'DISPLAY': ':0', 21:41:48 INFO - 'HOME': '/home/cltbld', 21:41:48 INFO - 'LANG': 'en_US.UTF-8', 21:41:48 INFO - 'LANGUAGE': 'en_US:en', 21:41:48 INFO - 'LOGNAME': 'cltbld', 21:41:48 INFO - 'MAIL': '/var/mail/cltbld', 21:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:48 INFO - 'MOZ_NO_REMOTE': '1', 21:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:48 INFO - 'NO_EM_RESTART': '1', 21:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:48 INFO - 'PWD': '/builds/slave/test', 21:41:48 INFO - 'SHELL': '/bin/bash', 21:41:48 INFO - 'SHLVL': '1', 21:41:48 INFO - 'TERM': 'linux', 21:41:48 INFO - 'TMOUT': '86400', 21:41:48 INFO - 'USER': 'cltbld', 21:41:48 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:48 INFO - '_': '/tools/buildbot/bin/python'} 21:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:48 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 21:41:48 INFO - Cleaning up... 21:41:48 INFO - Return code: 0 21:41:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:41:48 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')]} 21:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:48 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')]} 21:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:48 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:48 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 21:41:48 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 21:41:48 INFO - Using env: {'DISPLAY': ':0', 21:41:48 INFO - 'HOME': '/home/cltbld', 21:41:48 INFO - 'LANG': 'en_US.UTF-8', 21:41:48 INFO - 'LANGUAGE': 'en_US:en', 21:41:48 INFO - 'LOGNAME': 'cltbld', 21:41:48 INFO - 'MAIL': '/var/mail/cltbld', 21:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:48 INFO - 'MOZ_NO_REMOTE': '1', 21:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:48 INFO - 'NO_EM_RESTART': '1', 21:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:48 INFO - 'PWD': '/builds/slave/test', 21:41:48 INFO - 'SHELL': '/bin/bash', 21:41:48 INFO - 'SHLVL': '1', 21:41:48 INFO - 'TERM': 'linux', 21:41:48 INFO - 'TMOUT': '86400', 21:41:48 INFO - 'USER': 'cltbld', 21:41:48 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:48 INFO - '_': '/tools/buildbot/bin/python'} 21:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:49 INFO - Downloading/unpacking psutil>=0.7.1 21:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:41:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:50 INFO - Installing collected packages: psutil 21:41:50 INFO - Running setup.py install for psutil 21:41:50 INFO - building 'psutil._psutil_linux' extension 21:41:50 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 21:41: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 21:41:51 INFO - building 'psutil._psutil_posix' extension 21:41: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 21:41: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:41:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:51 INFO - Successfully installed psutil 21:41:51 INFO - Cleaning up... 21:41:51 INFO - Return code: 0 21:41:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:51 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:51 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 21:41:51 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 21:41:51 INFO - Using env: {'DISPLAY': ':0', 21:41:51 INFO - 'HOME': '/home/cltbld', 21:41:51 INFO - 'LANG': 'en_US.UTF-8', 21:41:51 INFO - 'LANGUAGE': 'en_US:en', 21:41:51 INFO - 'LOGNAME': 'cltbld', 21:41:51 INFO - 'MAIL': '/var/mail/cltbld', 21:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:51 INFO - 'MOZ_NO_REMOTE': '1', 21:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:51 INFO - 'NO_EM_RESTART': '1', 21:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:51 INFO - 'PWD': '/builds/slave/test', 21:41:51 INFO - 'SHELL': '/bin/bash', 21:41:51 INFO - 'SHLVL': '1', 21:41:51 INFO - 'TERM': 'linux', 21:41:51 INFO - 'TMOUT': '86400', 21:41:51 INFO - 'USER': 'cltbld', 21:41:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:51 INFO - '_': '/tools/buildbot/bin/python'} 21:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:41:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:41:53 INFO - Installing collected packages: mozsystemmonitor 21:41:53 INFO - Running setup.py install for mozsystemmonitor 21:41:53 INFO - Successfully installed mozsystemmonitor 21:41:53 INFO - Cleaning up... 21:41:53 INFO - Return code: 0 21:41:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:53 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:53 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 21:41:53 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 21:41:53 INFO - Using env: {'DISPLAY': ':0', 21:41:53 INFO - 'HOME': '/home/cltbld', 21:41:53 INFO - 'LANG': 'en_US.UTF-8', 21:41:53 INFO - 'LANGUAGE': 'en_US:en', 21:41:53 INFO - 'LOGNAME': 'cltbld', 21:41:53 INFO - 'MAIL': '/var/mail/cltbld', 21:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:53 INFO - 'MOZ_NO_REMOTE': '1', 21:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:53 INFO - 'NO_EM_RESTART': '1', 21:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:53 INFO - 'PWD': '/builds/slave/test', 21:41:53 INFO - 'SHELL': '/bin/bash', 21:41:53 INFO - 'SHLVL': '1', 21:41:53 INFO - 'TERM': 'linux', 21:41:53 INFO - 'TMOUT': '86400', 21:41:53 INFO - 'USER': 'cltbld', 21:41:53 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:53 INFO - '_': '/tools/buildbot/bin/python'} 21:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:56 INFO - Downloading docopt-0.6.1.tar.gz 21:41:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:56 INFO - Running setup.py install for blobuploader 21:41:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:56 INFO - Running setup.py install for requests 21:41:56 INFO - Running setup.py install for docopt 21:41:56 INFO - Successfully installed blobuploader requests docopt 21:41:56 INFO - Cleaning up... 21:41:56 INFO - Return code: 0 21:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:56 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:56 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 21:41:56 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 21:41:56 INFO - Using env: {'DISPLAY': ':0', 21:41:56 INFO - 'HOME': '/home/cltbld', 21:41:56 INFO - 'LANG': 'en_US.UTF-8', 21:41:56 INFO - 'LANGUAGE': 'en_US:en', 21:41:56 INFO - 'LOGNAME': 'cltbld', 21:41:56 INFO - 'MAIL': '/var/mail/cltbld', 21:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:56 INFO - 'MOZ_NO_REMOTE': '1', 21:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:56 INFO - 'NO_EM_RESTART': '1', 21:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:56 INFO - 'PWD': '/builds/slave/test', 21:41:56 INFO - 'SHELL': '/bin/bash', 21:41:56 INFO - 'SHLVL': '1', 21:41:56 INFO - 'TERM': 'linux', 21:41:56 INFO - 'TMOUT': '86400', 21:41:56 INFO - 'USER': 'cltbld', 21:41:56 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:56 INFO - '_': '/tools/buildbot/bin/python'} 21:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:56 INFO - Running setup.py (path:/tmp/pip-MZ2NUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:57 INFO - Running setup.py (path:/tmp/pip-a7DXb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:57 INFO - Running setup.py (path:/tmp/pip-1AwQ47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:57 INFO - Running setup.py (path:/tmp/pip-FbPN6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:57 INFO - Running setup.py (path:/tmp/pip-H30gEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:57 INFO - Running setup.py (path:/tmp/pip-cUlAT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:57 INFO - Running setup.py (path:/tmp/pip-dtwaaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:57 INFO - Running setup.py (path:/tmp/pip-FeRlPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:57 INFO - Running setup.py (path:/tmp/pip-4jEJwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:57 INFO - Running setup.py (path:/tmp/pip-u0JDgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:57 INFO - Running setup.py (path:/tmp/pip-VG5e23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:57 INFO - Running setup.py (path:/tmp/pip-X2LMek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:57 INFO - Running setup.py (path:/tmp/pip-6Ul2DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:57 INFO - Running setup.py (path:/tmp/pip-MoinKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:57 INFO - Running setup.py (path:/tmp/pip-7T_sLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:58 INFO - Running setup.py (path:/tmp/pip-WK99S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:58 INFO - Running setup.py (path:/tmp/pip-eIQLOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:58 INFO - Running setup.py install for manifestparser 21:41:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Running setup.py install for mozcrash 21:41:58 INFO - Running setup.py install for mozdebug 21:41:58 INFO - Running setup.py install for mozdevice 21:41:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Running setup.py install for mozfile 21:41:58 INFO - Running setup.py install for mozhttpd 21:41:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Running setup.py install for mozinfo 21:41:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Running setup.py install for mozInstall 21:41:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:58 INFO - Running setup.py install for mozleak 21:41:59 INFO - Running setup.py install for mozlog 21:41:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Running setup.py install for moznetwork 21:41:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Running setup.py install for mozprocess 21:41:59 INFO - Running setup.py install for mozprofile 21:41:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Running setup.py install for mozrunner 21:41:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Running setup.py install for mozscreenshot 21:41:59 INFO - Running setup.py install for moztest 21:41:59 INFO - Running setup.py install for mozversion 21:41:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:59 INFO - Cleaning up... 21:41:59 INFO - Return code: 0 21:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:59 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:41:59 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 21:41:59 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 21:41:59 INFO - Using env: {'DISPLAY': ':0', 21:41:59 INFO - 'HOME': '/home/cltbld', 21:41:59 INFO - 'LANG': 'en_US.UTF-8', 21:41:59 INFO - 'LANGUAGE': 'en_US:en', 21:41:59 INFO - 'LOGNAME': 'cltbld', 21:41:59 INFO - 'MAIL': '/var/mail/cltbld', 21:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:59 INFO - 'MOZ_NO_REMOTE': '1', 21:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:59 INFO - 'NO_EM_RESTART': '1', 21:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:59 INFO - 'PWD': '/builds/slave/test', 21:41:59 INFO - 'SHELL': '/bin/bash', 21:41:59 INFO - 'SHLVL': '1', 21:41:59 INFO - 'TERM': 'linux', 21:41:59 INFO - 'TMOUT': '86400', 21:41:59 INFO - 'USER': 'cltbld', 21:41:59 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:59 INFO - '_': '/tools/buildbot/bin/python'} 21:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:00 INFO - Running setup.py (path:/tmp/pip-UphOnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42: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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:00 INFO - Running setup.py (path:/tmp/pip-Mdqj1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:00 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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:00 INFO - Running setup.py (path:/tmp/pip-Mg9zz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:00 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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:00 INFO - Running setup.py (path:/tmp/pip-y9zLuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:00 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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:00 INFO - Running setup.py (path:/tmp/pip-dXhqPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:00 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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:00 INFO - Running setup.py (path:/tmp/pip-3y_IXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:00 INFO - Running setup.py (path:/tmp/pip-DYRhnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:00 INFO - Running setup.py (path:/tmp/pip-lIF4M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:00 INFO - Running setup.py (path:/tmp/pip-xMULoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:00 INFO - Running setup.py (path:/tmp/pip-PDQNvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:00 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)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:00 INFO - Running setup.py (path:/tmp/pip-Ca7fCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:01 INFO - Running setup.py (path:/tmp/pip-lTkV7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42: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)) 21:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:01 INFO - Running setup.py (path:/tmp/pip-lAHSmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:01 INFO - Running setup.py (path:/tmp/pip-ubhiQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42: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)) 21:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:01 INFO - Running setup.py (path:/tmp/pip-JA4Xfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42: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)) 21:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:01 INFO - Running setup.py (path:/tmp/pip-0VzwJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:01 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)) 21:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:01 INFO - Running setup.py (path:/tmp/pip-J7FGaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:01 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)) 21:42:01 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)) 21:42:01 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)) 21:42:01 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)) 21:42:01 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)) 21:42:01 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)) 21:42:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42:01 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 21:42:01 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 21:42:01 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 21:42:01 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 21:42:01 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 21:42:01 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 21:42:03 INFO - Downloading blessings-1.5.1.tar.gz 21:42: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 21:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:42:03 INFO - Installing collected packages: blessings 21:42:03 INFO - Running setup.py install for blessings 21:42:03 INFO - Successfully installed blessings 21:42:03 INFO - Cleaning up... 21:42:03 INFO - Return code: 0 21:42:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:03 INFO - Reading from file tmpfile_stdout 21:42:03 INFO - Current package versions: 21:42:03 INFO - argparse == 1.2.1 21:42:03 INFO - blessings == 1.5.1 21:42:03 INFO - blobuploader == 1.2.4 21:42:03 INFO - docopt == 0.6.1 21:42:03 INFO - manifestparser == 1.1 21:42:03 INFO - mozInstall == 1.12 21:42:03 INFO - mozcrash == 0.16 21:42:03 INFO - mozdebug == 0.1 21:42:03 INFO - mozdevice == 0.47 21:42:03 INFO - mozfile == 1.2 21:42:03 INFO - mozhttpd == 0.7 21:42:03 INFO - mozinfo == 0.9 21:42:03 INFO - mozleak == 0.1 21:42:03 INFO - mozlog == 3.1 21:42:03 INFO - moznetwork == 0.27 21:42:03 INFO - mozprocess == 0.22 21:42:03 INFO - mozprofile == 0.28 21:42:03 INFO - mozrunner == 6.11 21:42:03 INFO - mozscreenshot == 0.1 21:42:03 INFO - mozsystemmonitor == 0.0 21:42:03 INFO - moztest == 0.7 21:42:03 INFO - mozversion == 1.4 21:42:03 INFO - psutil == 3.1.1 21:42:03 INFO - requests == 1.2.3 21:42:03 INFO - wsgiref == 0.1.2 21:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:03 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:42:03 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 21:42:03 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 21:42:03 INFO - Using env: {'DISPLAY': ':0', 21:42:03 INFO - 'HOME': '/home/cltbld', 21:42:03 INFO - 'LANG': 'en_US.UTF-8', 21:42:03 INFO - 'LANGUAGE': 'en_US:en', 21:42:03 INFO - 'LOGNAME': 'cltbld', 21:42:03 INFO - 'MAIL': '/var/mail/cltbld', 21:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:03 INFO - 'MOZ_NO_REMOTE': '1', 21:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:03 INFO - 'NO_EM_RESTART': '1', 21:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:03 INFO - 'PWD': '/builds/slave/test', 21:42:03 INFO - 'SHELL': '/bin/bash', 21:42:03 INFO - 'SHLVL': '1', 21:42:03 INFO - 'TERM': 'linux', 21:42:03 INFO - 'TMOUT': '86400', 21:42:03 INFO - 'USER': 'cltbld', 21:42:03 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:03 INFO - '_': '/tools/buildbot/bin/python'} 21:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:42:03 INFO - Cleaning up... 21:42:03 INFO - Return code: 0 21:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:03 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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:42:03 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 21:42:03 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 21:42:03 INFO - Using env: {'DISPLAY': ':0', 21:42:03 INFO - 'HOME': '/home/cltbld', 21:42:03 INFO - 'LANG': 'en_US.UTF-8', 21:42:03 INFO - 'LANGUAGE': 'en_US:en', 21:42:03 INFO - 'LOGNAME': 'cltbld', 21:42:03 INFO - 'MAIL': '/var/mail/cltbld', 21:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:03 INFO - 'MOZ_NO_REMOTE': '1', 21:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:03 INFO - 'NO_EM_RESTART': '1', 21:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:03 INFO - 'PWD': '/builds/slave/test', 21:42:03 INFO - 'SHELL': '/bin/bash', 21:42:03 INFO - 'SHLVL': '1', 21:42:03 INFO - 'TERM': 'linux', 21:42:03 INFO - 'TMOUT': '86400', 21:42:03 INFO - 'USER': 'cltbld', 21:42:03 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:03 INFO - '_': '/tools/buildbot/bin/python'} 21:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:04 INFO - Downloading/unpacking jsonschema 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:42:05 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 21:42:05 INFO - Downloading/unpacking functools32 (from jsonschema) 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 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 21:42:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:42:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:42:05 INFO - warning: no files found matching '*.txt' 21:42:05 INFO - no previously-included directories found matching 'build' 21:42:05 INFO - no previously-included directories found matching 'dist' 21:42:05 INFO - no previously-included directories found matching '.git*' 21:42:05 INFO - Installing collected packages: jsonschema, functools32 21:42:06 INFO - Running setup.py install for functools32 21:42:06 INFO - warning: no files found matching '*.txt' 21:42:06 INFO - no previously-included directories found matching 'build' 21:42:06 INFO - no previously-included directories found matching 'dist' 21:42:06 INFO - no previously-included directories found matching '.git*' 21:42:06 INFO - Successfully installed jsonschema functools32 21:42:06 INFO - Cleaning up... 21:42:06 INFO - Return code: 0 21:42:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42: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')]} 21:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42: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 0x7f12dd84df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2755dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', '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 21:42: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 21:42: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 21:42:06 INFO - Using env: {'DISPLAY': ':0', 21:42:06 INFO - 'HOME': '/home/cltbld', 21:42:06 INFO - 'LANG': 'en_US.UTF-8', 21:42:06 INFO - 'LANGUAGE': 'en_US:en', 21:42:06 INFO - 'LOGNAME': 'cltbld', 21:42:06 INFO - 'MAIL': '/var/mail/cltbld', 21:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:06 INFO - 'MOZ_NO_REMOTE': '1', 21:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:06 INFO - 'NO_EM_RESTART': '1', 21:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:06 INFO - 'PWD': '/builds/slave/test', 21:42:06 INFO - 'SHELL': '/bin/bash', 21:42:06 INFO - 'SHLVL': '1', 21:42:06 INFO - 'TERM': 'linux', 21:42:06 INFO - 'TMOUT': '86400', 21:42:06 INFO - 'USER': 'cltbld', 21:42:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:06 INFO - '_': '/tools/buildbot/bin/python'} 21:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:06 INFO - Downloading/unpacking flake8 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:42: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 21:42:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:42: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 21:42:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:08 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 21:42:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:42:08 INFO - no previously-included directories found matching 'docs/_build' 21:42:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:42:08 INFO - Running setup.py install for pep8 21:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:42:08 INFO - no previously-included directories found matching 'docs/_build' 21:42:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:42:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:42:08 INFO - Cleaning up... 21:42:08 INFO - Return code: 0 21:42:08 INFO - Running post-action listener: _resource_record_post_action 21:42:08 INFO - Running post-action listener: _start_resource_monitoring 21:42:08 INFO - Starting resource monitoring. 21:42:08 INFO - ##### 21:42:08 INFO - ##### Running install step. 21:42:08 INFO - ##### 21:42:08 INFO - Running pre-action listener: _resource_record_pre_action 21:42:08 INFO - Running main action method: install 21:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:09 INFO - Reading from file tmpfile_stdout 21:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 21:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:42:09 INFO - Reading from file tmpfile_stdout 21:42:09 INFO - Output received: 21:42:09 INFO - Usage: mozinstall [options] installer 21:42:09 INFO - Options: 21:42:09 INFO - -h, --help show this help message and exit 21:42:09 INFO - -d DEST, --destination=DEST 21:42:09 INFO - Directory to install application into. [default: 21:42:09 INFO - "/builds/slave/test"] 21:42:09 INFO - --app=APP Application being installed. [default: firefox] 21:42:09 INFO - mkdir: /builds/slave/test/build/application 21:42:09 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'] 21:42:09 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 21:42:24 INFO - Reading from file tmpfile_stdout 21:42:24 INFO - Output received: 21:42:24 INFO - /builds/slave/test/build/application/firefox/firefox 21:42:24 INFO - Running post-action listener: _resource_record_post_action 21:42:24 INFO - ##### 21:42:24 INFO - ##### Running run-tests step. 21:42:24 INFO - ##### 21:42:24 INFO - Running pre-action listener: _resource_record_pre_action 21:42:24 INFO - Running main action method: run_tests 21:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:24 INFO - Python 2.7.3 21:42:24 INFO - Return code: 0 21:42:24 INFO - grabbing minidump binary from tooltool 21:42: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')]} 21:42: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 0x27e83d0>, '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 0x2753ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2754360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42: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 21:42: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 21:42:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:24 INFO - Return code: 0 21:42:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:42:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:42:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:42:25 INFO - Return code: 0 21:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:42:25 INFO - Using env: {'DISPLAY': ':0', 21:42:25 INFO - 'HOME': '/home/cltbld', 21:42:25 INFO - 'LANG': 'en_US.UTF-8', 21:42:25 INFO - 'LANGUAGE': 'en_US:en', 21:42:25 INFO - 'LOGNAME': 'cltbld', 21:42:25 INFO - 'MAIL': '/var/mail/cltbld', 21:42:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:25 INFO - 'MOZ_NO_REMOTE': '1', 21:42:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:25 INFO - 'NO_EM_RESTART': '1', 21:42:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:25 INFO - 'PWD': '/builds/slave/test', 21:42:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:25 INFO - 'SHELL': '/bin/bash', 21:42:25 INFO - 'SHLVL': '1', 21:42:25 INFO - 'TERM': 'linux', 21:42:25 INFO - 'TMOUT': '86400', 21:42:25 INFO - 'USER': 'cltbld', 21:42:25 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865', 21:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:25 INFO - '_': '/tools/buildbot/bin/python'} 21:42:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:42:25 INFO - mozversion application_buildid: 20151230211837 21:42:25 INFO - mozversion application_changeset: ebaa931f095af094dbccca6c760cf923e2211257 21:42:25 INFO - mozversion application_display_name: Nightly 21:42:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:25 INFO - mozversion application_name: Firefox 21:42:25 INFO - mozversion application_remotingname: firefox 21:42:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:42:25 INFO - mozversion application_vendor: Mozilla 21:42:25 INFO - mozversion application_version: 46.0a1 21:42:25 INFO - mozversion platform_buildid: 20151230211837 21:42:25 INFO - mozversion platform_changeset: ebaa931f095af094dbccca6c760cf923e2211257 21:42:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:42:25 INFO - mozversion platform_version: 46.0a1 21:42:25 INFO - using testdate: 1451540545 21:42:25 INFO - actual date: 1451540545 21:42:25 INFO - starting webserver on 'localhost:37631' 21:42:25 INFO - SUITE-START | Running 3 tests 21:42:25 INFO - TEST-START | dromaeo_css 21:42:25 INFO - operating with platform_type : linux_ 21:42:25 INFO - Initialising browser for dromaeo_css test... 21:42:25 INFO - TEST-INFO | started process 1107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqXN_Rx/profile http://localhost:37631/getInfo.html) 21:42:30 INFO - PROCESS | 1107 | __metrics Screen width/height:1600/1200 21:42:30 INFO - PROCESS | 1107 | colorDepth:24 21:42:30 INFO - PROCESS | 1107 | Browser inner width/height: 1024/697 21:42:30 INFO - PROCESS | 1107 | __metrics 21:42:30 INFO - PROCESS | 1107 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:42:30 INFO - PROCESS | 1107 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:31 INFO - TEST-INFO | 1107: exit 0 21:42:31 INFO - Browser initialized. 21:42:31 INFO - Running cycle 1/1 for dromaeo_css test... 21:42:31 INFO - TEST-INFO | started process 1260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqXN_Rx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:43 INFO - PROCESS | 1260 | RSS: Main: 149975040 21:42:43 INFO - PROCESS | 1260 | 21:43:34 INFO - PROCESS | 1260 | 1451540614980 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] 21:45:46 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37631/tests/dromaeo/cssquery-ext.html) 21:45:47 INFO - PROCESS | 1260 | RSS: Main: 268120064 21:45:47 INFO - PROCESS | 1260 | 21:48:50 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-ext.html (next: http://localhost:37631/tests/dromaeo/cssquery-jquery.html) 21:48:51 INFO - PROCESS | 1260 | RSS: Main: 234242048 21:48:51 INFO - PROCESS | 1260 | 21:51:53 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37631/tests/dromaeo/cssquery-mootools.html) 21:51:53 INFO - PROCESS | 1260 | RSS: Main: 230199296 21:51:53 INFO - PROCESS | 1260 | 21:54:55 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37631/tests/dromaeo/cssquery-prototype.html) 21:54:56 INFO - PROCESS | 1260 | RSS: Main: 214515712 21:54:56 INFO - PROCESS | 1260 | 21:57:59 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37631/tests/dromaeo/cssquery-yui.html) 21:58:00 INFO - PROCESS | 1260 | RSS: Main: 208965632 21:58:00 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | Cycle 1(1): loaded http://localhost:37631/tests/dromaeo/cssquery-yui.html (next: http://localhost:37631/tests/dromaeo/cssquery-dojo.html) 22:01:02 INFO - PROCESS | 1260 | RSS: Main: 262111232 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | __start_tp_report 22:01:02 INFO - PROCESS | 1260 | _x_x_mozilla_page_load 22:01:02 INFO - PROCESS | 1260 | _x_x_mozilla_page_load_details 22:01:02 INFO - PROCESS | 1260 | |i|pagename|runs| 22:01:02 INFO - PROCESS | 1260 | |0;dojo.html;2590.637310776491;2687.754125807223;2694.9461010779773;2701.9324516887077;2719.619253304537;4427.977860110695;4519.322101684749;4551.6358691304695;4607.539246075391;4625.537446255377;4487.080148569544;4545.909081818361;4569.702969306993;4571.679982401233;4576.222042252817;4231.724937879043;4238.279492486285;4244.27847265964;4256.659467242621;4256.765877876715;4129.194807012634;4326.286162783153;4327.4374331336885;4351.630111440531;4380.233459144637;4159.958400416018;4173.791310434482;4201.306784380574;4248.022954720432;4249.2563801334645;4243.321068629005;4245.936310955338;4269.829206831723;4277.700560960734;4279.293916503773;4199.139176468817;4211.663066954637;4219.641330486912;4265.146970605861;4270.188664153801;4350.477942646871;4478.865634030984;4489.9448629572025;4490.416245888014;4577.931331030038;4801.687890287155;4834.371531700892;4834.468208497063;4837.637177211724;4841.491643377465;4823.831165909176;4846.39420072491;4865.3675022247235;4886.413630364344;4938.4814594467425;4543.591076803071;4554.339620754972;4559.17934771741;4560.338750881104;4600.7929643166135;4835.44392394872;4999.625028122905;5028.974855125774;5034.647574669738;5073.619478539124;4745.572898439157;4769.403824521934;4850.684705494202;4871.634627402888;4878.609711223094;4852.527565522549;4887.853364399074;4901.656884018156;4904.705717656952;4944.55499005084;4801.639877009238;4855.757212139379;4857.344258525054;4858.514148585114;4900.754962251945;4726.19654658702;4766.094442055998;4834.226523756182;4834.975825120922;4882.365292512021;4049.190161967618;4052;4054.0878302382316;4063.6952228582973;4091.4272001919753;3539.309834582232;3540.6636369544854;3541.468779683068;3564.0733409313766;3580.0154957386926;4122.2579935611875;4158.189153115113;4212;4212.304969679968;4216.262154123077;4903.779329930162;4927.137750893651;4929.038837426668;4930.309756634074;4950.455449900508;4230.598093181143;4232.238197124486;4232.640225580799;4263.914721705549;4267.103908179255;4225.408442818008;4288.2281189385585;4322.502912165079;4325.589069038437;4364.323529852878;4672;4700.153972285021;4703.388559487382;4719.150552900443;4741.075490279362;4924.384451943507;4926.531979461945;4929.309896614549;4935.851924442272;4962.875928101682;4482.686211965131;4605.424321959755;4606.0097079128145;4660.044690838302;4676.018036212434;4841.733704646278;4868;4876.756162191948;4886.242632391985;4914.434839993303;4935.259711043373;4936.136176169228;4937.9012419752125;4939.580135688507;4939.629527785502;4548.272276435887;4599.44806623194;4642.489326174051;4655.208614535605;4821.228603423436;4797.40032495938;4811.4707382188635;4811.542903424169;4815.398075240595;4862.7325497098;4706.1528924793865;4721.763911804327;4730.881727956828;4730.905381892412;4778.402699662543;4615.23848564983;4729.69256998294;4738.691985020962;4745.596624286836;4832.178529649897;4683.625309975262;4697.13103075932;4708;4715.127701375257;4748.691335063209 22:01:02 INFO - PROCESS | 1260 | |1;ext.html;502.9864822382899;525.5559052600553;526.4288247251732;531.6039550534853;545.8362491252625;23795.286141415763;24476.632850507234;32292.838535807317;32324.83837580809;32403.67596324036;36000;36547.63452365482;36549;36574.26851462969;36671.816640916826;6919.757808476705;7739.148693643709;7932.8810067848735;7938;7939.04731432229;7007.124109486314;7111.431085513173;7113.7906555885365;7114.679839407213;9882.555285012191;9848.409095454295;10002.9499852501;10009.349392289514;10014;10015.248856335767;9558.522073896313;9725.319227654067;9729.124378805906;9734.561944712505;9741.951290243504;7099.467539934525;7267.382272506843;9643.90356096437;9904.306698531105;10095.899041009643;33675.49486757701;34171;34176.6582334176;34206.14484637879;34208.48687269693;2655.097266929234;2815.1132393296048;3314.9005529834144;3431.742619303562;3476.3047390521997;26737.73262267372;27027.51348675822;27092.187234382804;27560.17319480419;27998;3348.8995330140133;3389.4237979543536;3401.48977653354;3431.9828400858087;3498.982505087484;228165;229039;229231;229262;229288;42044.36933446001;56310.43689563052;56944;56949.14576281359;57107.428925710214;40313;60142;60654.696726516086;60978.69510652418;60980.695096524236;12632.178908370926;12661.810072848915;12767.361631918553;12772.489100436065;12783.105182637311;9816.852747208797;9843.064908833649;9844.901550984541;9846;9852.901470985342;19189.712154317698;19392.321268755524;19406.805931940784;19408.708869366972;19446.416607501797;6027.8794424111275;6103.969480152571;6105.9694701526205;6107;6130.724117414727;768.6886810841618;783.4750717019497;827.8013276813642;847.8643417053241;889.1863944490718;23216;23492.882535587214;23516.176933807234;23655.29034128979;23683.407914801923;910.0990019880271;918.7473444802599;935.9812803743887;972.8783902012249;1015.8882522922472;12484.625461236177;12740.171888827383;13979.860201397856;14666.63333416673;14797;276541;277786;281204;281313;282580;46486.76756616195;46710.53289467062;46874;46921.53078469171;46975.765121174176;1040.8178568750438;1049.4123290957089;1057.984130238047;1062.9096526795308;1069.7860427914447;23429.648555272026;25827;26432.339191520365;27426.725732742416;27788.44423111486;36532.45201321929;36901.815490922374;36959;36982;36999.63000369962;165243;166864;167169;167271;167452;24658.383540411633;25148.371290717878;27367.726322737315;29366.412671746017;30235.546466803455;34072.1481962943;34139;34169;34957.126071848405;35132.47301290432;30856.845715771276;31239.84380078085;31402.21494462657;31640.367192655558;31970.6802931977;27544.72455275502;30130.24674383158;31771.523427149074;31895.36209275755;32147.35705285928;31454.370912581162;31620.525692115098;31781.9341742786;31830.204244894063;31871.521927171576;28387.858060709565;29876.402471950874;30053.248668783457;30326.69673303327;30683.386332273676;23128.306150815504;23456.051679277774;23881.283561493183;25150.11974580881;25303.620445693698 22:01:02 INFO - PROCESS | 1260 | |2;jquery.html;327.6068717538954;332.06358070241913;333.4448143840506;334.65864817885756;336.806336356595;12224;12558.18371805832;14724.92637536812;14997.5500734978;15207.163606001666;11983.940080299608;12324;12431.564895228668;12726.36368181592;12748.490060397597;4733.763311834412;4774.307725379809;4891.657583969123;4904.558589726924;4912.115819152551;3422.3668621305014;3516;4838.177509823321;4954.2568614707725;5116.232565115244;5072.26452164436;5081.771320290577;5083.389993200821;5102.489751024905;5104.515071068243;5075.137226671456;5080.441151473335;5371.221172929922;5540.168974653794;5548.250986116863;4755.5719985201495;4928.753562321869;4937.333459982929;4937.432195297551;4941.654084214107;10784.975427334391;11005.339679619168;11006.229563930528;11016.724581885437;11026.614068507644;1674.7655328254054;1751.5270876863303;1777.7688900442988;1796.6855800234907;1913.579012617222;8196.795080122985;8701.521416322099;8742.781430464225;10126.746831329203;12062.517499300018;1630.2012014113118;1672.6571052934119;1675.8240384759547;1709.2052195728922;1728.8962662240306;49323.50676493225;49419.752901235624;49649.50350496485;50147.247791282796;50191.24713129306;9244.537773111317;9295.349325547282;9304.30217733659;9311.72064838056;9362.719118426457;11704.590339338083;11776.58781942645;11801.52793888252;11820.763584728258;11843.348615826213;6749.797506074826;6821.1814582250445;6828.078209441761;6832.0776695146515;6878.38094571491;6497.577657452251;6521.771737989243;6545.280019197884;6552.770653027121;6583.341665833378;4069.2471892699946;4129.91740165201;4133.441985331941;4167.687423443193;4177.456930599003;1588.833172516892;1628.9755653665204;1637.9754303685454;1645.2596331650566;1659.8506134447957;834.3158609939791;923.4828496042238;930.4928813796497;970.2286682087757;971;14448.349824257723;14791.408343666133;14793.260336983109;14960.70078598422;15195;801.7394346837301;808.8058865872148;842.309306368784;884.0187391994881;908.42315129893;8686.869696954423;9031.36780425377;9091;9142.76667639657;9224.677136300197;443028;443167;460016;462976;465960;69312.96030559445;69979.30020699727;71501.6424917872;71560.2843971564;72591;908.986480074712;919.4988731141544;922.262190247799;929.8000929800126;931.2596485793811;12873.678158046123;13070.80393794113;13283.601491955256;13495.527656531975;13508.392122354715;31690.683093168773;31962;32110;32471.025869223962;32636.510452342758;42212.366814497196;42342.36486452767;42634;43722;46007.07985840331;8213.425060245965;8344.958275208584;8544.18830211129;8551;8622.525761083201;9794.559244833858;9803.16673082796;9804.264680148875;12804.487820487077;15485.458008969632;13074.215547067206;13091.607251782461;13192.538261160813;13286.269255191057;13464.326783660974;12722.363881806057;12892.548760793326;13233.933830331172;13559.457621695416;13624.386902589209;11244.550217991517;11439.59961401347;13523.256220907551;13696.726065478833;14523;8340.249377556049;8392.958035209786;8591.140885911358;8601.956990215009;8606.956965215133;8941.195292423454;9006.964199117185;12780.936095319465;13818.585442436743;14072.226027568582 22:01:02 INFO - PROCESS | 1260 | |3;mootools.html;1165.3939951225368;1217.634709587124;1256.440883806706;1262.2363470100588;1446.9943389344403;5882.441168089035;6599.802005939823;6721.865562688743;6725.764598239062;6739.3597608227265;6708.530402871788;6826.078479405279;6898.65506724663;6899.172099348085;6906.067680863082;2023.4536675097715;2074.077035719098;2075.4915045813796;2076.7923207679264;2077.4702450875006;2062.9484262893397;2092.571022940301;2102;2111.4721319670084;2113.418809827302;2046.0792643310494;2050.077465140685;2074.087401543316;2076.190285788544;2076.24217160736;2046.1713006232426;2091.780363061872;2099.32821497121;2099.6955441460977;2099.9265025724103;2040.897955102239;2063.515073957619;2107.2097963263777;2112.493001679601;2113.0913707105938;6703.865922681519;6710.6644667766905;6780.050792888999;6787.355201255873;6791.558548694319;3964.32606456903;3990.4812374391145;4019.0354314964197;4026.4966879139815;4035.475388199545;2572.4340645058055;2600.5709058005405;2614.16346769034;2620.4104076582807;2659.4016346322114;797.4178849439942;799.4084377560622;800.6077022259109;812.9478992260655;822.1490757066467;9237.676681316121;9245.029271926485;9248.121428464285;9255.398399104037;9272.814543709088;3792;3800.7339486235696;3811.485449464287;3888.4556162137324;3892.649661530419;7862.921370786334;7905.56519391439;7909.644066016928;7913.841723165619;7917.208279172037;3982.7212095153063;4000.439938408625;4029.7582145070805;4042.939355909664;4044.51465824103;3074;3138.5606015157896;3496.475528670669;3647.0335361129323;3652.671259586597;3132.4831402818736;3134.467140586106;3164.746820254374;3168.7781855270373;3177.698118678722;1045.7594753206804;1051.1538211739623;1059.4120263253815;1060.5174645536263;1071.266182664877;944.4239014201331;944.4899754132691;944.9007854175212;1060.5333653192724;1127.3968426891574;6127.509799216052;6294.590851594632;6303.149074874925;6304.180456540712;6326.240851097898;376.57823237973645;401.1255463090433;403.0548364086213;403.6548750818008;405.9817308221137;5012.548870601663;5033.949660503421;5052.520010598987;5052.646314757932;5053.36832895888;7765.951596534395;7988.640511177011;8299.336053115736;8522.147785221552;8532.744017679479;7895.486793358414;7897.802554936057;7913.762587122281;7915.366770658334;7937.880931786028;6206.441420272197;6249.500039996789;6294.685265736694;6354.936450635527;6359.427651511386;6283.528735344776;6358.650274234961;6364.395382438661;6370.6814659267775;6378.075179098912;7414.073240844895;7469.813254668677;7480.887786683095;7608.467407281437;7610.238976102345;7577.734779282699;7689.730859419893;7700.191479894755;7766.5728384939375;7796.298333150044;5223.21651752225;5285.709285989307;6073;6121.84695382619;6138.294096178996;6404.871902562016;6506.674666266573;6551.672416379257;6556.606603603799;6557.278699342973;5949.077892926603;6073.362296958756;6102.908456373247;6255.906161407674;6273.37266273369;6044.184035155374;6122.357152498924;6142.6314421134875;6190.102435146789;6235.594686345555;6181.907271390843;6229.3770622937345;6252.749890004349;6255.218097737783;6256.155419018556;5664.37691853904;5701.372848986691;5704;5711.171880077449;5724.8282551523525;5794.362620111869;5808.128780682931;5813.128030795415;5864.736086876186;5865.5600829937075 22:01:02 INFO - PROCESS | 1260 | |4;prototype.html;291.9562065690146;293.6901568844868;300.61821486711864;302.1856097816385;302.62625657313214;5245.79016839326;5268.86827829304;5304.946950530493;5402.91895621565;5449.618526703132;5288.2596436498925;5298.602604804636;5344.358676958761;5349.893002139965;5363.329583802025;3840.327942610046;4029.9395509067385;4030.415589739486;4041.312976793937;4043.4945631796027;3925.3523168677275;3944.349182384903;4030.3954406838916;4039.131586708857;4040.878773636781;3965.048388386781;3980.3233450313373;3982.0443093657605;3984.3625019996807;3995.06116062725;3774.641409066134;3855.267499175176;3915.4126880967797;3981.5819338969427;3982.5220973483224;3481;3482;3487.930241395183;3499.265154317596;3509.298140371936;5074.923876141824;5085.338905942241;5092.134337162654;5093;5095.057414378315;4613.8154473821005;4623.329617205486;4628.583427491542;4629.51390104041;4631.073785242965;5358.517733404013;5521.613487055908;5531.502164805147;5534.972325138348;5538.944610553924;3826.349520581508;3829.157585331223;3829.5787463379006;3833.674137698299;3835.9232815343817;5818.389069147764;5889.293284805851;5891.263592050994;5897.705114744289;5899.7050147492455;3922.5096862892137;3923.136909879822;3923.509561304837;3928.9607103929166;3929.4891664084057;3755.6432138946757;3777.376732839051;4006.419069234945;4007.3788562772816;4008.7995600219874;4133.6693064554765;4396.494403143615;4486.730796152176;4498.820047198075;4500.887477813081;5405.108157154104;5461.290032295776;5462.918056229159;5558.249636299048;5561.9710353583905;1355.959321220365;1357.9660508487366;1398.5245016694168;1400.0199860097973;1400.4748219417718;915.8122584870085;931.4364809290282;932.6828878181451;933.0529512544772;936.2229349639782;4851.223804191312;4852.8786780330065;4856.562909338177;4864.197407427806;4880.780364883589;5732.3121225453215;5744.540436765049;5753.88492230153;5756.524694381373;5763.250777398911;4823.710577365369;4840.056189043103;4841.588464980516;4841.757912104381;4842.201036828954;2974.3456439583256;3046.1470788179345;3059.1740230138184;3087.81473111614;3089.0269565086924;4790.281457781361;5499.587530935196;5520.585956053312;5561.221428999943;5568.693721845257;5982.73077711504;6012.729427175787;6014.398560143951;6016.669083200379;6018.518518518508;5566.35986861508;5578.079616863172;5587.469190426903;5624.746886390204;5628.493435590816;5725.141228815544;5859.355470898283;5866.2960444746905;5872.618279811799;5874.206982057368;5710.086386178192;5713.600047996767;5715.8856822864145;5718.857028574319;5721.370649228665;5566.888662226814;5567.63810352342;5568.415316391721;5570.498655121059;5571.052921003358;3883.9611603884728;3920.2355540670437;3920.353141731582;3925.7644541327613;3927.8821635350987;5623.2408624835125;5759.94240057594;5764.279465066867;5837.211976383134;5851.502622276984;5461.808836690697;5469.56243500511;5539.612227144061;5583.302087239095;5634.070378387521;5627.268455100811;5628.465295796893;5628.718564071862;5631.6902570359025;5632.746526406403;5365.356157261153;5487.5609951203005;5499.780008799763;5511.58663100261;5522.530584900329;5667.121596152603;5668.03643380618;5669.291338582677;5674.092145256739;5678.290213723285;5483.75323110469;5487.4238204987905;5489.478499542537;5491.505764481216;5493.2034854946605 22:01:02 INFO - PROCESS | 1260 | |5;yui.html;704.918934322553;736.9424875303938;749.9662515186819;752.5898385379967;754.1402800807077;10456;10616.946915265422;10625.46872656366;10628.893711062887;10657.413842238673;10635.042846143846;10755.731106722336;10775.676729698102;10783.730406739836;10791.298565593232;612.3447910735515;613.3130893399399;613.8127870999343;764.545095668078;765.6784150656738;788.6805843633309;796.410656114474;796.5300472721093;797.1669605262485;797.3461761355691;826.099551488877;840.8150206954491;840.9495430274203;841.6927821345196;842.2672275120653;640.4908098062028;645.9031145328238;814.8003739083903;835.2607941971338;836.3058661311097;610.1640752169557;610.7679081948831;611.1596554737237;611.5138464920354;612.1582823617526;9876.061774131445;9956.452395118265;9968.601255949754;9972.70081897537;9980.600775968953;10009.29934904557;11390.71523211918;11610.88389116115;11731.413429328499;11756.177067605271;8526.31789456842;8569.914300856974;8644.733110780566;8656.740297791077;8754.86867696985;3128.765342599291;3144.119646498984;3184.50640150777;3185.5062465317915;3225.645179030305;37806.243875122345;37818;37864.24271514582;37935;37983.43024854629;8142.267195952392;8375.246227839523;8432.620532076071;8458.957705211435;8754.824903501894;14228.715425691427;14228.786568201485;14235.85764142366;14242.359093840802;14243.715125697428;6035.275766907911;6071.696415179224;6086.756529738849;6196.8760624787255;6227.626342419469;3353.161709572607;3419.965800341965;3432.467967465047;3452.9827350863084;3477.8608855646;2535.1380530619676;2553.8467691938545;2576.75520825525;2577.1624222127884;2577.1881857214917;410.0834634591685;412.1365738777257;420.1869382744399;422.0482811260649;422.1788621131869;534.318743601903;552.6214543038031;577.2755192233803;582.1064665738156;607.1742430294795;7374.889376659355;7406.370458510979;7612.3148916596665;7728.343090837229;7748.7675369739;472.41892472259315;500.5570070487572;508.336620709977;515.6416290678018;519.8544407565888;3498.4052711039185;3672.57765356982;3673.669369756735;3701.4632878232505;3707.3697471429923;49751.75124124356;50181.74909125504;50412;50423.74788126036;50630.74684626553;43453.565464345585;43796.82936383957;44423.22402595751;45092;45108.54891451109;37712.24575508475;37836;37935;39178.608213918065;40510.392344114865;7352.301531354513;7374.963125184339;7448.478606497493;7541.396688265036;7590.316871481593;29278.268043298234;29566.704332956397;29568.408631827675;30285.394292114474;30640.540391894585;35077.64922350744;35613.287734245685;38998.4150237741;39139.02152446098;39139.41290880582;9248.768780780534;9521.904780952102;9533.761655958378;9587.472689002172;9607.56765945548;9595.616175352907;9741.707748767549;9886.258530610377;10183.43991080468;10463.267571269938;8934.86597701022;9125.17873391398;9195.172434480928;9302.627894884128;9364.719058428258;9260.722178334661;9287.72136835896;9310.162085412345;9371.34400591952;9399.765005874908;9295.256379489489;9436.52817359143;9521.571529281338;9534.523273836141;9544.141027307576;8062.314703250289;8191.139870582379;8264.628091736007;8287.378446616649;8470.57647117654;7372.336489715952;8382.958085209535;8458.111898250596;8611.149951061832;9101 22:01:02 INFO - PROCESS | 1260 | __end_tp_report 22:01:02 INFO - PROCESS | 1260 | __start_cc_report 22:01:02 INFO - PROCESS | 1260 | _x_x_mozilla_cycle_collect,1043 22:01:02 INFO - PROCESS | 1260 | __end_cc_report 22:01:02 INFO - PROCESS | 1260 | __startTimestamp1451541662819__endTimestamp 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | ------- Summary: start ------- 22:01:02 INFO - PROCESS | 1260 | Number of tests: 6 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#0] dojo.html Cycles:165 Average:4519.43 Median:4655.21 stddev:462.07 (9.9%) stddev-sans-first:438.01 22:01:02 INFO - PROCESS | 1260 | Values: 2590.6 2687.8 2694.9 2701.9 2719.6 4428.0 4519.3 4551.6 4607.5 4625.5 4487.1 4545.9 4569.7 4571.7 4576.2 4231.7 4238.3 4244.3 4256.7 4256.8 4129.2 4326.3 4327.4 4351.6 4380.2 4160.0 4173.8 4201.3 4248.0 4249.3 4243.3 4245.9 4269.8 4277.7 4279.3 4199.1 4211.7 4219.6 4265.1 4270.2 4350.5 4478.9 4489.9 4490.4 4577.9 4801.7 4834.4 4834.5 4837.6 4841.5 4823.8 4846.4 4865.4 4886.4 4938.5 4543.6 4554.3 4559.2 4560.3 4600.8 4835.4 4999.6 5029.0 5034.6 5073.6 4745.6 4769.4 4850.7 4871.6 4878.6 4852.5 4887.9 4901.7 4904.7 4944.6 4801.6 4855.8 4857.3 4858.5 4900.8 4726.2 4766.1 4834.2 4835.0 4882.4 4049.2 4052.0 4054.1 4063.7 4091.4 3539.3 3540.7 3541.5 3564.1 3580.0 4122.3 4158.2 4212.0 4212.3 4216.3 4903.8 4927.1 4929.0 4930.3 4950.5 4230.6 4232.2 4232.6 4263.9 4267.1 4225.4 4288.2 4322.5 4325.6 4364.3 4672.0 4700.2 4703.4 4719.2 4741.1 4924.4 4926.5 4929.3 4935.9 4962.9 4482.7 4605.4 4606.0 4660.0 4676.0 4841.7 4868.0 4876.8 4886.2 4914.4 4935.3 4936.1 4937.9 4939.6 4939.6 4548.3 4599.4 4642.5 4655.2 4821.2 4797.4 4811.5 4811.5 4815.4 4862.7 4706.2 4721.8 4730.9 4730.9 4778.4 4615.2 4729.7 4738.7 4745.6 4832.2 4683.6 4697.1 4708.0 4715.1 4748.7 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#1] ext.html Cycles:180 Average:38101.27 Median:32308.84 stddev:60045.42 (185.8%) stddev-sans-first:60147.50 22:01:02 INFO - PROCESS | 1260 | Values: 503.0 525.6 526.4 531.6 545.8 23795.3 24476.6 32292.8 32324.8 32403.7 36000.0 36547.6 36549.0 36574.3 36671.8 6919.8 7739.1 7932.9 7938.0 7939.0 7007.1 7111.4 7113.8 7114.7 9882.6 9848.4 10002.9 10009.3 10014.0 10015.2 9558.5 9725.3 9729.1 9734.6 9742.0 7099.5 7267.4 9643.9 9904.3 10095.9 33675.5 34171.0 34176.7 34206.1 34208.5 2655.1 2815.1 3314.9 3431.7 3476.3 26737.7 27027.5 27092.2 27560.2 27998.0 3348.9 3389.4 3401.5 3432.0 3499.0 228165.0 229039.0 229231.0 229262.0 229288.0 42044.4 56310.4 56944.0 56949.1 57107.4 40313.0 60142.0 60654.7 60978.7 60980.7 12632.2 12661.8 12767.4 12772.5 12783.1 9816.9 9843.1 9844.9 9846.0 9852.9 19189.7 19392.3 19406.8 19408.7 19446.4 6027.9 6104.0 6106.0 6107.0 6130.7 768.7 783.5 827.8 847.9 889.2 23216.0 23492.9 23516.2 23655.3 23683.4 910.1 918.7 936.0 972.9 1015.9 12484.6 12740.2 13979.9 14666.6 14797.0 276541.0 277786.0 281204.0 281313.0 282580.0 46486.8 46710.5 46874.0 46921.5 46975.8 1040.8 1049.4 1058.0 1062.9 1069.8 23429.6 25827.0 26432.3 27426.7 27788.4 36532.5 36901.8 36959.0 36982.0 36999.6 165243.0 166864.0 167169.0 167271.0 167452.0 24658.4 25148.4 27367.7 29366.4 30235.5 34072.1 34139.0 34169.0 34957.1 35132.5 30856.8 31239.8 31402.2 31640.4 31970.7 27544.7 30130.2 31771.5 31895.4 32147.4 31454.4 31620.5 31781.9 31830.2 31871.5 28387.9 29876.4 30053.2 30326.7 30683.4 23128.3 23456.1 23881.3 25150.1 25303.6 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#2] jquery.html Cycles:180 Average:24615.09 Median:253011.54 stddev:74410.46 (29.4%) stddev-sans-first:74596.85 22:01:02 INFO - PROCESS | 1260 | Values: 327.6 332.1 333.4 334.7 336.8 12224.0 12558.2 14724.9 14997.6 15207.2 11983.9 12324.0 12431.6 12726.4 12748.5 4733.8 4774.3 4891.7 4904.6 4912.1 3422.4 3516.0 4838.2 4954.3 5116.2 5072.3 5081.8 5083.4 5102.5 5104.5 5075.1 5080.4 5371.2 5540.2 5548.3 4755.6 4928.8 4937.3 4937.4 4941.7 10785.0 11005.3 11006.2 11016.7 11026.6 1674.8 1751.5 1777.8 1796.7 1913.6 8196.8 8701.5 8742.8 10126.7 12062.5 1630.2 1672.7 1675.8 1709.2 1728.9 49323.5 49419.8 49649.5 50147.2 50191.2 9244.5 9295.3 9304.3 9311.7 9362.7 11704.6 11776.6 11801.5 11820.8 11843.3 6749.8 6821.2 6828.1 6832.1 6878.4 6497.6 6521.8 6545.3 6552.8 6583.3 4069.2 4129.9 4133.4 4167.7 4177.5 1588.8 1629.0 1638.0 1645.3 1659.9 834.3 923.5 930.5 970.2 971.0 14448.3 14791.4 14793.3 14960.7 15195.0 801.7 808.8 842.3 884.0 908.4 8686.9 9031.4 9091.0 9142.8 9224.7 443028.0 443167.0 460016.0 462976.0 465960.0 69313.0 69979.3 71501.6 71560.3 72591.0 909.0 919.5 922.3 929.8 931.3 12873.7 13070.8 13283.6 13495.5 13508.4 31690.7 31962.0 32110.0 32471.0 32636.5 42212.4 42342.4 42634.0 43722.0 46007.1 8213.4 8345.0 8544.2 8551.0 8622.5 9794.6 9803.2 9804.3 12804.5 15485.5 13074.2 13091.6 13192.5 13286.3 13464.3 12722.4 12892.5 13233.9 13559.5 13624.4 11244.6 11439.6 13523.3 13696.7 14523.0 8340.2 8393.0 8591.1 8602.0 8607.0 8941.2 9007.0 12780.9 13818.6 14072.2 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#3] mootools.html Cycles:180 Average:4747.29 Median:5996.63 stddev:2485.37 (41.4%) stddev-sans-first:2477.75 22:01:02 INFO - PROCESS | 1260 | Values: 1165.4 1217.6 1256.4 1262.2 1447.0 5882.4 6599.8 6721.9 6725.8 6739.4 6708.5 6826.1 6898.7 6899.2 6906.1 2023.5 2074.1 2075.5 2076.8 2077.5 2062.9 2092.6 2102.0 2111.5 2113.4 2046.1 2050.1 2074.1 2076.2 2076.2 2046.2 2091.8 2099.3 2099.7 2099.9 2040.9 2063.5 2107.2 2112.5 2113.1 6703.9 6710.7 6780.1 6787.4 6791.6 3964.3 3990.5 4019.0 4026.5 4035.5 2572.4 2600.6 2614.2 2620.4 2659.4 797.4 799.4 800.6 812.9 822.1 9237.7 9245.0 9248.1 9255.4 9272.8 3792.0 3800.7 3811.5 3888.5 3892.6 7862.9 7905.6 7909.6 7913.8 7917.2 3982.7 4000.4 4029.8 4042.9 4044.5 3074.0 3138.6 3496.5 3647.0 3652.7 3132.5 3134.5 3164.7 3168.8 3177.7 1045.8 1051.2 1059.4 1060.5 1071.3 944.4 944.5 944.9 1060.5 1127.4 6127.5 6294.6 6303.1 6304.2 6326.2 376.6 401.1 403.1 403.7 406.0 5012.5 5033.9 5052.5 5052.6 5053.4 7766.0 7988.6 8299.3 8522.1 8532.7 7895.5 7897.8 7913.8 7915.4 7937.9 6206.4 6249.5 6294.7 6354.9 6359.4 6283.5 6358.7 6364.4 6370.7 6378.1 7414.1 7469.8 7480.9 7608.5 7610.2 7577.7 7689.7 7700.2 7766.6 7796.3 5223.2 5285.7 6073.0 6121.8 6138.3 6404.9 6506.7 6551.7 6556.6 6557.3 5949.1 6073.4 6102.9 6255.9 6273.4 6044.2 6122.4 6142.6 6190.1 6235.6 6181.9 6229.4 6252.7 6255.2 6256.2 5664.4 5701.4 5704.0 5711.2 5724.8 5794.4 5808.1 5813.1 5864.7 5865.6 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#4] prototype.html Cycles:180 Average:4594.44 Median:5324.65 stddev:1389.07 (26.1%) stddev-sans-first:1354.91 22:01:02 INFO - PROCESS | 1260 | Values: 292.0 293.7 300.6 302.2 302.6 5245.8 5268.9 5304.9 5402.9 5449.6 5288.3 5298.6 5344.4 5349.9 5363.3 3840.3 4029.9 4030.4 4041.3 4043.5 3925.4 3944.3 4030.4 4039.1 4040.9 3965.0 3980.3 3982.0 3984.4 3995.1 3774.6 3855.3 3915.4 3981.6 3982.5 3481.0 3482.0 3487.9 3499.3 3509.3 5074.9 5085.3 5092.1 5093.0 5095.1 4613.8 4623.3 4628.6 4629.5 4631.1 5358.5 5521.6 5531.5 5535.0 5538.9 3826.3 3829.2 3829.6 3833.7 3835.9 5818.4 5889.3 5891.3 5897.7 5899.7 3922.5 3923.1 3923.5 3929.0 3929.5 3755.6 3777.4 4006.4 4007.4 4008.8 4133.7 4396.5 4486.7 4498.8 4500.9 5405.1 5461.3 5462.9 5558.2 5562.0 1356.0 1358.0 1398.5 1400.0 1400.5 915.8 931.4 932.7 933.1 936.2 4851.2 4852.9 4856.6 4864.2 4880.8 5732.3 5744.5 5753.9 5756.5 5763.3 4823.7 4840.1 4841.6 4841.8 4842.2 2974.3 3046.1 3059.2 3087.8 3089.0 4790.3 5499.6 5520.6 5561.2 5568.7 5982.7 6012.7 6014.4 6016.7 6018.5 5566.4 5578.1 5587.5 5624.7 5628.5 5725.1 5859.4 5866.3 5872.6 5874.2 5710.1 5713.6 5715.9 5718.9 5721.4 5566.9 5567.6 5568.4 5570.5 5571.1 3884.0 3920.2 3920.4 3925.8 3927.9 5623.2 5759.9 5764.3 5837.2 5851.5 5461.8 5469.6 5539.6 5583.3 5634.1 5627.3 5628.5 5628.7 5631.7 5632.7 5365.4 5487.6 5499.8 5511.6 5522.5 5667.1 5668.0 5669.3 5674.1 5678.3 5483.8 5487.4 5489.5 5491.5 5493.2 22:01:02 INFO - PROCESS | 1260 | 22:01:02 INFO - PROCESS | 1260 | [#5] yui.html Cycles:180 Average:11569.38 Median:610.47 stddev:13480.98 (2208.3%) stddev-sans-first:13494.11 22:01:02 INFO - PROCESS | 1260 | Values: 704.9 736.9 750.0 752.6 754.1 10456.0 10616.9 10625.5 10628.9 10657.4 10635.0 10755.7 10775.7 10783.7 10791.3 612.3 613.3 613.8 764.5 765.7 788.7 796.4 796.5 797.2 797.3 826.1 840.8 840.9 841.7 842.3 640.5 645.9 814.8 835.3 836.3 610.2 610.8 611.2 611.5 612.2 9876.1 9956.5 9968.6 9972.7 9980.6 10009.3 11390.7 11610.9 11731.4 11756.2 8526.3 8569.9 8644.7 8656.7 8754.9 3128.8 3144.1 3184.5 3185.5 3225.6 37806.2 37818.0 37864.2 37935.0 37983.4 8142.3 8375.2 8432.6 8459.0 8754.8 14228.7 14228.8 14235.9 14242.4 14243.7 6035.3 6071.7 6086.8 6196.9 6227.6 3353.2 3420.0 3432.5 3453.0 3477.9 2535.1 2553.8 2576.8 2577.2 2577.2 410.1 412.1 420.2 422.0 422.2 534.3 552.6 577.3 582.1 607.2 7374.9 7406.4 7612.3 7728.3 7748.8 472.4 500.6 508.3 515.6 519.9 3498.4 3672.6 3673.7 3701.5 3707.4 49751.8 50181.7 50412.0 50423.7 50630.7 43453.6 43796.8 44423.2 45092.0 45108.5 37712.2 37836.0 37935.0 39178.6 40510.4 7352.3 7375.0 7448.5 7541.4 7590.3 29278.3 29566.7 29568.4 30285.4 30640.5 35077.6 35613.3 38998.4 39139.0 39139.4 9248.8 9521.9 9533.8 9587.5 9607.6 9595.6 9741.7 9886.3 10183.4 10463.3 8934.9 9125.2 9195.2 9302.6 9364.7 9260.7 9287.7 9310.2 9371.3 9399.8 9295.3 9436.5 9521.6 9534.5 9544.1 8062.3 8191.1 8264.6 8287.4 8470.6 7372.3 8383.0 8458.1 8611.1 9101.0 22:01:02 INFO - PROCESS | 1260 | -------- Summary: end -------- 22:01:02 INFO - PROCESS | 1260 | 22:01:03 INFO - TEST-INFO | 1260: exit 0 22:01:03 INFO - TEST-OK | dromaeo_css | took 1117623ms 22:01:03 INFO - TEST-START | kraken 22:01:03 INFO - operating with platform_type : linux_ 22:01:03 INFO - Initialising browser for kraken test... 22:01:03 INFO - TEST-INFO | started process 1465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgWbrqF/profile http://localhost:37631/getInfo.html) 22:01:08 INFO - PROCESS | 1465 | __metrics Screen width/height:1600/1200 22:01:08 INFO - PROCESS | 1465 | colorDepth:24 22:01:08 INFO - PROCESS | 1465 | Browser inner width/height: 1024/697 22:01:08 INFO - PROCESS | 1465 | __metrics 22:01:08 INFO - PROCESS | 1465 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:01:08 INFO - PROCESS | 1465 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:09 INFO - TEST-INFO | 1465: exit 0 22:01:09 INFO - Browser initialized. 22:01:09 INFO - Running cycle 1/1 for kraken test... 22:01:09 INFO - TEST-INFO | started process 1550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgWbrqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:21 INFO - PROCESS | 1550 | RSS: Main: 149569536 22:01:21 INFO - PROCESS | 1550 | 22:01:23 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37631/tests/kraken/driver.html?testName=audio-beat-detection) 22:01:24 INFO - PROCESS | 1550 | RSS: Main: 184946688 22:01:24 INFO - PROCESS | 1550 | 22:01:27 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37631/tests/kraken/driver.html?testName=audio-dft) 22:01:27 INFO - PROCESS | 1550 | RSS: Main: 174100480 22:01:27 INFO - PROCESS | 1550 | 22:01:30 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37631/tests/kraken/driver.html?testName=audio-fft) 22:01:31 INFO - PROCESS | 1550 | RSS: Main: 161898496 22:01:31 INFO - PROCESS | 1550 | 22:01:33 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37631/tests/kraken/driver.html?testName=audio-oscillator) 22:01:34 INFO - PROCESS | 1550 | RSS: Main: 162308096 22:01:34 INFO - PROCESS | 1550 | 22:01:36 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:36 INFO - PROCESS | 1550 | RSS: Main: 164179968 22:01:36 INFO - PROCESS | 1550 | 22:01:39 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37631/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:40 INFO - PROCESS | 1550 | RSS: Main: 165978112 22:01:40 INFO - PROCESS | 1550 | 22:01:43 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37631/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:44 INFO - PROCESS | 1550 | RSS: Main: 166350848 22:01:44 INFO - PROCESS | 1550 | 22:01:47 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37631/tests/kraken/driver.html?testName=json-parse-financial) 22:01:47 INFO - PROCESS | 1550 | RSS: Main: 164077568 22:01:47 INFO - PROCESS | 1550 | 22:01:49 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:50 INFO - PROCESS | 1550 | RSS: Main: 173658112 22:01:50 INFO - PROCESS | 1550 | 22:01:52 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:52 INFO - PROCESS | 1550 | RSS: Main: 171450368 22:01:52 INFO - PROCESS | 1550 | 22:01:54 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:55 INFO - PROCESS | 1550 | RSS: Main: 186986496 22:01:55 INFO - PROCESS | 1550 | 22:01:58 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:58 INFO - PROCESS | 1550 | RSS: Main: 187998208 22:01:58 INFO - PROCESS | 1550 | 22:02:01 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:02:01 INFO - PROCESS | 1550 | RSS: Main: 186994688 22:02:01 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | Cycle 1(1): loaded http://localhost:37631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37631/tests/kraken/driver.html?testName=ai-astar) 22:02:03 INFO - PROCESS | 1550 | RSS: Main: 245882880 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | __start_tp_report 22:02:03 INFO - PROCESS | 1550 | _x_x_mozilla_page_load 22:02:03 INFO - PROCESS | 1550 | _x_x_mozilla_page_load_details 22:02:03 INFO - PROCESS | 1550 | |i|pagename|runs| 22:02:03 INFO - PROCESS | 1550 | |0;ai-astar;111;115;108;112;111;112;101;113;113;107 22:02:03 INFO - PROCESS | 1550 | |1;audio-beat-detection;154;134;167;170;132;165;156;133;172;133 22:02:03 INFO - PROCESS | 1550 | |2;audio-dft;160;161;162;161;164;163;161;162;171;162 22:02:03 INFO - PROCESS | 1550 | |3;audio-fft;74;72;79;94;73;75;74;100;90;76 22:02:03 INFO - PROCESS | 1550 | |4;audio-oscillator;99;97;138;99;99;98;137;99;98;151 22:02:03 INFO - PROCESS | 1550 | |5;imaging-gaussian-blur;110;110;110;110;109;110;109;109;110;110 22:02:03 INFO - PROCESS | 1550 | |6;imaging-darkroom;148;147;147;147;147;146;146;146;146;147 22:02:03 INFO - PROCESS | 1550 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 22:02:03 INFO - PROCESS | 1550 | |8;json-parse-financial;71;72;72;72;72;72;71;81;69;69 22:02:03 INFO - PROCESS | 1550 | |9;json-stringify-tinderbox;68;68;77;68;68;68;69;69;69;69 22:02:03 INFO - PROCESS | 1550 | |10;stanford-crypto-aes;85;87;91;85;85;86;86;85;87;88 22:02:03 INFO - PROCESS | 1550 | |11;stanford-crypto-ccm;129;123;129;124;132;126;122;135;139;123 22:02:03 INFO - PROCESS | 1550 | |12;stanford-crypto-pbkdf2;140;150;153;151;151;141;150;150;149;150 22:02:03 INFO - PROCESS | 1550 | |13;stanford-crypto-sha256-iterative;73;72;74;72;71;69;70;71;70;70 22:02:03 INFO - PROCESS | 1550 | __end_tp_report 22:02:03 INFO - PROCESS | 1550 | __start_cc_report 22:02:03 INFO - PROCESS | 1550 | _x_x_mozilla_cycle_collect,973 22:02:03 INFO - PROCESS | 1550 | __end_cc_report 22:02:03 INFO - PROCESS | 1550 | __startTimestamp1451541723877__endTimestamp 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | ------- Summary: start ------- 22:02:03 INFO - PROCESS | 1550 | Number of tests: 14 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 22:02:03 INFO - PROCESS | 1550 | Values: 111.0 115.0 108.0 112.0 111.0 112.0 101.0 113.0 113.0 107.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:160.50 stddev:16.94 (10.6%) stddev-sans-first:17.94 22:02:03 INFO - PROCESS | 1550 | Values: 154.0 134.0 167.0 170.0 132.0 165.0 156.0 133.0 172.0 133.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:3.13 (1.9%) stddev-sans-first:3.16 22:02:03 INFO - PROCESS | 1550 | Values: 160.0 161.0 162.0 161.0 164.0 163.0 161.0 162.0 171.0 162.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.50 stddev:10.10 (13.4%) stddev-sans-first:10.42 22:02:03 INFO - PROCESS | 1550 | Values: 74.0 72.0 79.0 94.0 73.0 75.0 74.0 100.0 90.0 76.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:98.50 stddev:21.38 (21.7%) stddev-sans-first:22.19 22:02:03 INFO - PROCESS | 1550 | Values: 99.0 97.0 138.0 99.0 99.0 98.0 137.0 99.0 98.0 151.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:02:03 INFO - PROCESS | 1550 | Values: 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 22:02:03 INFO - PROCESS | 1550 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:02:03 INFO - PROCESS | 1550 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:3.35 (4.7%) stddev-sans-first:3.53 22:02:03 INFO - PROCESS | 1550 | Values: 71.0 72.0 72.0 72.0 72.0 72.0 71.0 81.0 69.0 69.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:2.75 (4.0%) stddev-sans-first:2.88 22:02:03 INFO - PROCESS | 1550 | Values: 68.0 68.0 77.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:1.90 (2.2%) stddev-sans-first:1.94 22:02:03 INFO - PROCESS | 1550 | Values: 85.0 87.0 91.0 85.0 85.0 86.0 86.0 85.0 87.0 88.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.00 stddev:5.71 (4.4%) stddev-sans-first:6.05 22:02:03 INFO - PROCESS | 1550 | Values: 129.0 123.0 129.0 124.0 132.0 126.0 122.0 135.0 139.0 123.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:150.00 stddev:4.35 (2.9%) stddev-sans-first:3.36 22:02:03 INFO - PROCESS | 1550 | Values: 140.0 150.0 153.0 151.0 151.0 141.0 150.0 150.0 149.0 150.0 22:02:03 INFO - PROCESS | 1550 | 22:02:03 INFO - PROCESS | 1550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.55 (2.2%) stddev-sans-first:1.50 22:02:03 INFO - PROCESS | 1550 | Values: 73.0 72.0 74.0 72.0 71.0 69.0 70.0 71.0 70.0 70.0 22:02:03 INFO - PROCESS | 1550 | -------- Summary: end -------- 22:02:03 INFO - PROCESS | 1550 | 22:02:04 INFO - TEST-INFO | 1550: exit 0 22:02:04 INFO - TEST-OK | kraken | took 61355ms 22:02:04 INFO - TEST-START | v8_7 22:02:04 INFO - operating with platform_type : linux_ 22:02:04 INFO - Initialising browser for v8_7 test... 22:02:04 INFO - TEST-INFO | started process 1798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMV5RzS/profile http://localhost:37631/getInfo.html) 22:02:09 INFO - PROCESS | 1798 | __metrics Screen width/height:1600/1200 22:02:09 INFO - PROCESS | 1798 | colorDepth:24 22:02:09 INFO - PROCESS | 1798 | Browser inner width/height: 1024/697 22:02:09 INFO - PROCESS | 1798 | __metrics 22:02:09 INFO - PROCESS | 1798 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:02:10 INFO - PROCESS | 1798 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:02:11 INFO - TEST-INFO | 1798: exit 0 22:02:11 INFO - Browser initialized. 22:02:11 INFO - Running cycle 1/1 for v8_7 test... 22:02:11 INFO - TEST-INFO | started process 1880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMV5RzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:22 INFO - PROCESS | 1880 | RSS: Main: 149610496 22:02:22 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:37631/tests/v8_7/run.html (next: http://localhost:37631/tests/v8_7/run.html) 22:02:44 INFO - PROCESS | 1880 | RSS: Main: 447877120 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | __start_tp_report 22:02:44 INFO - PROCESS | 1880 | _x_x_mozilla_page_load 22:02:44 INFO - PROCESS | 1880 | _x_x_mozilla_page_load_details 22:02:44 INFO - PROCESS | 1880 | |i|pagename|runs| 22:02:44 INFO - PROCESS | 1880 | |0;Richards;168.32183134152498 22:02:44 INFO - PROCESS | 1880 | |1;DeltaBlue;186.9508319312021 22:02:44 INFO - PROCESS | 1880 | |2;Encrypt;280.1120448179272 22:02:44 INFO - PROCESS | 1880 | |3;Decrypt;5202.072538860104 22:02:44 INFO - PROCESS | 1880 | |4;RayTrace;1990.0596421471173 22:02:44 INFO - PROCESS | 1880 | |5;Earley;808.4074373484236 22:02:44 INFO - PROCESS | 1880 | |6;Boyer;12084.33734939759 22:02:44 INFO - PROCESS | 1880 | |7;RegExp;28472.222222222223 22:02:44 INFO - PROCESS | 1880 | |8;Splay;621.8905472636816 22:02:44 INFO - PROCESS | 1880 | |9;NavierStokes;4830.917874396136 22:02:44 INFO - PROCESS | 1880 | __end_tp_report 22:02:44 INFO - PROCESS | 1880 | __startTimestamp1451541764664__endTimestamp 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | ------- Summary: start ------- 22:02:44 INFO - PROCESS | 1880 | Number of tests: 10 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#0] Richards Cycles:1 Average:168.32 Median:168.32 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 168.3 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#1] DeltaBlue Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 187.0 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 280.1 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 5202.1 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 1990.1 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#5] Earley Cycles:1 Average:808.41 Median:808.41 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 808.4 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 12084.3 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#7] RegExp Cycles:1 Average:28472.22 Median:28472.22 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 28472.2 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 621.9 22:02:44 INFO - PROCESS | 1880 | 22:02:44 INFO - PROCESS | 1880 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:02:44 INFO - PROCESS | 1880 | Values: 4830.9 22:02:44 INFO - PROCESS | 1880 | -------- Summary: end -------- 22:02:44 INFO - PROCESS | 1880 | 22:02:45 INFO - TEST-INFO | 1880: exit 0 22:02:45 INFO - TEST-OK | v8_7 | took 40670ms 22:02:45 INFO - SUITE-END | took 1219s 22:02:45 INFO - Completed test suite (00:20:19) 22:02:45 INFO - Working with test: dromaeo_css 22:02:45 INFO - Generating results file: dromaeo_css 22:02:45 INFO - Working with test: kraken 22:02:45 INFO - Generating results file: kraken 22:02:45 INFO - javascript benchmark 22:02:45 INFO - Working with test: v8_7 22:02:45 INFO - Generating results file: v8_7 22:02:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:02:45 INFO - process_Request line: dromaeo_css 6024.84 graph.html#tests=[[72,132,35]] 22:02:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:45 INFO - process_Request line: kraken 1544.20 graph.html#tests=[[232,132,35]] 22:02:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:45 INFO - process_Request line: v8_7 19555.20 graph.html#tests=[[230,132,35]] 22:02:45 INFO - RETURN: dromaeo_css: 6024.84 22:02:45 INFO - RETURN: kraken: 1544.20 22:02:45 INFO - RETURN: v8_7: 19555.20 22:02:45 INFO - javascript benchmark 22:02:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2590.637310776491, 2687.754125807223, 2694.9461010779773, 2701.9324516887077, 2719.619253304537, 4427.977860110695, 4519.322101684749, 4551.6358691304695, 4607.539246075391, 4625.537446255377, 4487.080148569544, 4545.909081818361, 4569.702969306993, 4571.679982401233, 4576.222042252817, 4231.724937879043, 4238.279492486285, 4244.27847265964, 4256.659467242621, 4256.765877876715, 4129.194807012634, 4326.286162783153, 4327.4374331336885, 4351.630111440531, 4380.233459144637, 4159.958400416018, 4173.791310434482, 4201.306784380574, 4248.022954720432, 4249.2563801334645, 4243.321068629005, 4245.936310955338, 4269.829206831723, 4277.700560960734, 4279.293916503773, 4199.139176468817, 4211.663066954637, 4219.641330486912, 4265.146970605861, 4270.188664153801, 4350.477942646871, 4478.865634030984, 4489.9448629572025, 4490.416245888014, 4577.931331030038, 4801.687890287155, 4834.371531700892, 4834.468208497063, 4837.637177211724, 4841.491643377465, 4823.831165909176, 4846.39420072491, 4865.3675022247235, 4886.413630364344, 4938.4814594467425, 4543.591076803071, 4554.339620754972, 4559.17934771741, 4560.338750881104, 4600.7929643166135, 4835.44392394872, 4999.625028122905, 5028.974855125774, 5034.647574669738, 5073.619478539124, 4745.572898439157, 4769.403824521934, 4850.684705494202, 4871.634627402888, 4878.609711223094, 4852.527565522549, 4887.853364399074, 4901.656884018156, 4904.705717656952, 4944.55499005084, 4801.639877009238, 4855.757212139379, 4857.344258525054, 4858.514148585114, 4900.754962251945, 4726.19654658702, 4766.094442055998, 4834.226523756182, 4834.975825120922, 4882.365292512021, 4049.190161967618, 4052.0, 4054.0878302382316, 4063.6952228582973, 4091.4272001919753, 3539.309834582232, 3540.6636369544854, 3541.468779683068, 3564.0733409313766, 3580.0154957386926, 4122.2579935611875, 4158.189153115113, 4212.0, 4212.304969679968, 4216.262154123077, 4903.779329930162, 4927.137750893651, 4929.038837426668, 4930.309756634074, 4950.455449900508, 4230.598093181143, 4232.238197124486, 4232.640225580799, 4263.914721705549, 4267.103908179255, 4225.408442818008, 4288.2281189385585, 4322.502912165079, 4325.589069038437, 4364.323529852878, 4672.0, 4700.153972285021, 4703.388559487382, 4719.150552900443, 4741.075490279362, 4924.384451943507, 4926.531979461945, 4929.309896614549, 4935.851924442272, 4962.875928101682, 4482.686211965131, 4605.424321959755, 4606.0097079128145, 4660.044690838302, 4676.018036212434, 4841.733704646278, 4868.0, 4876.756162191948, 4886.242632391985, 4914.434839993303, 4935.259711043373, 4936.136176169228, 4937.9012419752125, 4939.580135688507, 4939.629527785502, 4548.272276435887, 4599.44806623194, 4642.489326174051, 4655.208614535605, 4821.228603423436, 4797.40032495938, 4811.4707382188635, 4811.542903424169, 4815.398075240595, 4862.7325497098, 4706.1528924793865, 4721.763911804327, 4730.881727956828, 4730.905381892412, 4778.402699662543, 4615.23848564983, 4729.69256998294, 4738.691985020962, 4745.596624286836, 4832.178529649897, 4683.625309975262, 4697.13103075932, 4708.0, 4715.127701375257, 4748.691335063209], "unit": "score", "name": "dojo.html", "value": 4491.404559541766}, {"lowerIsBetter": false, "replicates": [502.9864822382899, 525.5559052600553, 526.4288247251732, 531.6039550534853, 545.8362491252625, 23795.286141415763, 24476.632850507234, 32292.838535807317, 32324.83837580809, 32403.67596324036, 36000.0, 36547.63452365482, 36549.0, 36574.26851462969, 36671.816640916826, 6919.757808476705, 7739.148693643709, 7932.8810067848735, 7938.0, 7939.04731432229, 7007.124109486314, 7111.431085513173, 7113.7906555885365, 7114.679839407213, 9882.555285012191, 9848.409095454295, 10002.9499852501, 10009.349392289514, 10014.0, 10015.248856335767, 9558.522073896313, 9725.319227654067, 9729.124378805906, 9734.561944712505, 9741.951290243504, 7099.467539934525, 7267.382272506843, 9643.90356096437, 9904.306698531105, 10095.899041009643, 33675.49486757701, 34171.0, 34176.6582334176, 34206.14484637879, 34208.48687269693, 2655.097266929234, 2815.1132393296048, 3314.9005529834144, 3431.742619303562, 3476.3047390521997, 26737.73262267372, 27027.51348675822, 27092.187234382804, 27560.17319480419, 27998.0, 3348.8995330140133, 3389.4237979543536, 3401.48977653354, 3431.9828400858087, 3498.982505087484, 228165.0, 229039.0, 229231.0, 229262.0, 229288.0, 42044.36933446001, 56310.43689563052, 56944.0, 56949.14576281359, 57107.428925710214, 40313.0, 60142.0, 60654.696726516086, 60978.69510652418, 60980.695096524236, 12632.178908370926, 12661.810072848915, 12767.361631918553, 12772.489100436065, 12783.105182637311, 9816.852747208797, 9843.064908833649, 9844.901550984541, 9846.0, 9852.901470985342, 19189.712154317698, 19392.321268755524, 19406.805931940784, 19408.708869366972, 19446.416607501797, 6027.8794424111275, 6103.969480152571, 6105.9694701526205, 6107.0, 6130.724117414727, 768.6886810841618, 783.4750717019497, 827.8013276813642, 847.8643417053241, 889.1863944490718, 23216.0, 23492.882535587214, 23516.176933807234, 23655.29034128979, 23683.407914801923, 910.0990019880271, 918.7473444802599, 935.9812803743887, 972.8783902012249, 1015.8882522922472, 12484.625461236177, 12740.171888827383, 13979.860201397856, 14666.63333416673, 14797.0, 276541.0, 277786.0, 281204.0, 281313.0, 282580.0, 46486.76756616195, 46710.53289467062, 46874.0, 46921.53078469171, 46975.765121174176, 1040.8178568750438, 1049.4123290957089, 1057.984130238047, 1062.9096526795308, 1069.7860427914447, 23429.648555272026, 25827.0, 26432.339191520365, 27426.725732742416, 27788.44423111486, 36532.45201321929, 36901.815490922374, 36959.0, 36982.0, 36999.63000369962, 165243.0, 166864.0, 167169.0, 167271.0, 167452.0, 24658.383540411633, 25148.371290717878, 27367.726322737315, 29366.412671746017, 30235.546466803455, 34072.1481962943, 34139.0, 34169.0, 34957.126071848405, 35132.47301290432, 30856.845715771276, 31239.84380078085, 31402.21494462657, 31640.367192655558, 31970.6802931977, 27544.72455275502, 30130.24674383158, 31771.523427149074, 31895.36209275755, 32147.35705285928, 31454.370912581162, 31620.525692115098, 31781.9341742786, 31830.204244894063, 31871.521927171576, 28387.858060709565, 29876.402471950874, 30053.248668783457, 30326.69673303327, 30683.386332273676, 23128.306150815504, 23456.051679277774, 23881.283561493183, 25150.11974580881, 25303.620445693698], "unit": "score", "name": "ext.html", "value": 16187.648009187684}, {"lowerIsBetter": false, "replicates": [327.6068717538954, 332.06358070241913, 333.4448143840506, 334.65864817885756, 336.806336356595, 12224.0, 12558.18371805832, 14724.92637536812, 14997.5500734978, 15207.163606001666, 11983.940080299608, 12324.0, 12431.564895228668, 12726.36368181592, 12748.490060397597, 4733.763311834412, 4774.307725379809, 4891.657583969123, 4904.558589726924, 4912.115819152551, 3422.3668621305014, 3516.0, 4838.177509823321, 4954.2568614707725, 5116.232565115244, 5072.26452164436, 5081.771320290577, 5083.389993200821, 5102.489751024905, 5104.515071068243, 5075.137226671456, 5080.441151473335, 5371.221172929922, 5540.168974653794, 5548.250986116863, 4755.5719985201495, 4928.753562321869, 4937.333459982929, 4937.432195297551, 4941.654084214107, 10784.975427334391, 11005.339679619168, 11006.229563930528, 11016.724581885437, 11026.614068507644, 1674.7655328254054, 1751.5270876863303, 1777.7688900442988, 1796.6855800234907, 1913.579012617222, 8196.795080122985, 8701.521416322099, 8742.781430464225, 10126.746831329203, 12062.517499300018, 1630.2012014113118, 1672.6571052934119, 1675.8240384759547, 1709.2052195728922, 1728.8962662240306, 49323.50676493225, 49419.752901235624, 49649.50350496485, 50147.247791282796, 50191.24713129306, 9244.537773111317, 9295.349325547282, 9304.30217733659, 9311.72064838056, 9362.719118426457, 11704.590339338083, 11776.58781942645, 11801.52793888252, 11820.763584728258, 11843.348615826213, 6749.797506074826, 6821.1814582250445, 6828.078209441761, 6832.0776695146515, 6878.38094571491, 6497.577657452251, 6521.771737989243, 6545.280019197884, 6552.770653027121, 6583.341665833378, 4069.2471892699946, 4129.91740165201, 4133.441985331941, 4167.687423443193, 4177.456930599003, 1588.833172516892, 1628.9755653665204, 1637.9754303685454, 1645.2596331650566, 1659.8506134447957, 834.3158609939791, 923.4828496042238, 930.4928813796497, 970.2286682087757, 971.0, 14448.349824257723, 14791.408343666133, 14793.260336983109, 14960.70078598422, 15195.0, 801.7394346837301, 808.8058865872148, 842.309306368784, 884.0187391994881, 908.42315129893, 8686.869696954423, 9031.36780425377, 9091.0, 9142.76667639657, 9224.677136300197, 443028.0, 443167.0, 460016.0, 462976.0, 465960.0, 69312.96030559445, 69979.30020699727, 71501.6424917872, 71560.2843971564, 72591.0, 908.986480074712, 919.4988731141544, 922.262190247799, 929.8000929800126, 931.2596485793811, 12873.678158046123, 13070.80393794113, 13283.601491955256, 13495.527656531975, 13508.392122354715, 31690.683093168773, 31962.0, 32110.0, 32471.025869223962, 32636.510452342758, 42212.366814497196, 42342.36486452767, 42634.0, 43722.0, 46007.07985840331, 8213.425060245965, 8344.958275208584, 8544.18830211129, 8551.0, 8622.525761083201, 9794.559244833858, 9803.16673082796, 9804.264680148875, 12804.487820487077, 15485.458008969632, 13074.215547067206, 13091.607251782461, 13192.538261160813, 13286.269255191057, 13464.326783660974, 12722.363881806057, 12892.548760793326, 13233.933830331172, 13559.457621695416, 13624.386902589209, 11244.550217991517, 11439.59961401347, 13523.256220907551, 13696.726065478833, 14523.0, 8340.249377556049, 8392.958035209786, 8591.140885911358, 8601.956990215009, 8606.956965215133, 8941.195292423454, 9006.964199117185, 12780.936095319465, 13818.585442436743, 14072.226027568582], "unit": "score", "name": "jquery.html", "value": 7758.007483002729}, {"lowerIsBetter": false, "replicates": [1165.3939951225368, 1217.634709587124, 1256.440883806706, 1262.2363470100588, 1446.9943389344403, 5882.441168089035, 6599.802005939823, 6721.865562688743, 6725.764598239062, 6739.3597608227265, 6708.530402871788, 6826.078479405279, 6898.65506724663, 6899.172099348085, 6906.067680863082, 2023.4536675097715, 2074.077035719098, 2075.4915045813796, 2076.7923207679264, 2077.4702450875006, 2062.9484262893397, 2092.571022940301, 2102.0, 2111.4721319670084, 2113.418809827302, 2046.0792643310494, 2050.077465140685, 2074.087401543316, 2076.190285788544, 2076.24217160736, 2046.1713006232426, 2091.780363061872, 2099.32821497121, 2099.6955441460977, 2099.9265025724103, 2040.897955102239, 2063.515073957619, 2107.2097963263777, 2112.493001679601, 2113.0913707105938, 6703.865922681519, 6710.6644667766905, 6780.050792888999, 6787.355201255873, 6791.558548694319, 3964.32606456903, 3990.4812374391145, 4019.0354314964197, 4026.4966879139815, 4035.475388199545, 2572.4340645058055, 2600.5709058005405, 2614.16346769034, 2620.4104076582807, 2659.4016346322114, 797.4178849439942, 799.4084377560622, 800.6077022259109, 812.9478992260655, 822.1490757066467, 9237.676681316121, 9245.029271926485, 9248.121428464285, 9255.398399104037, 9272.814543709088, 3792.0, 3800.7339486235696, 3811.485449464287, 3888.4556162137324, 3892.649661530419, 7862.921370786334, 7905.56519391439, 7909.644066016928, 7913.841723165619, 7917.208279172037, 3982.7212095153063, 4000.439938408625, 4029.7582145070805, 4042.939355909664, 4044.51465824103, 3074.0, 3138.5606015157896, 3496.475528670669, 3647.0335361129323, 3652.671259586597, 3132.4831402818736, 3134.467140586106, 3164.746820254374, 3168.7781855270373, 3177.698118678722, 1045.7594753206804, 1051.1538211739623, 1059.4120263253815, 1060.5174645536263, 1071.266182664877, 944.4239014201331, 944.4899754132691, 944.9007854175212, 1060.5333653192724, 1127.3968426891574, 6127.509799216052, 6294.590851594632, 6303.149074874925, 6304.180456540712, 6326.240851097898, 376.57823237973645, 401.1255463090433, 403.0548364086213, 403.6548750818008, 405.9817308221137, 5012.548870601663, 5033.949660503421, 5052.520010598987, 5052.646314757932, 5053.36832895888, 7765.951596534395, 7988.640511177011, 8299.336053115736, 8522.147785221552, 8532.744017679479, 7895.486793358414, 7897.802554936057, 7913.762587122281, 7915.366770658334, 7937.880931786028, 6206.441420272197, 6249.500039996789, 6294.685265736694, 6354.936450635527, 6359.427651511386, 6283.528735344776, 6358.650274234961, 6364.395382438661, 6370.6814659267775, 6378.075179098912, 7414.073240844895, 7469.813254668677, 7480.887786683095, 7608.467407281437, 7610.238976102345, 7577.734779282699, 7689.730859419893, 7700.191479894755, 7766.5728384939375, 7796.298333150044, 5223.21651752225, 5285.709285989307, 6073.0, 6121.84695382619, 6138.294096178996, 6404.871902562016, 6506.674666266573, 6551.672416379257, 6556.606603603799, 6557.278699342973, 5949.077892926603, 6073.362296958756, 6102.908456373247, 6255.906161407674, 6273.37266273369, 6044.184035155374, 6122.357152498924, 6142.6314421134875, 6190.102435146789, 6235.594686345555, 6181.907271390843, 6229.3770622937345, 6252.749890004349, 6255.218097737783, 6256.155419018556, 5664.37691853904, 5701.372848986691, 5704.0, 5711.171880077449, 5724.8282551523525, 5794.362620111869, 5808.128780682931, 5813.128030795415, 5864.736086876186, 5865.5600829937075], "unit": "score", "name": "mootools.html", "value": 3820.78990500369}, {"lowerIsBetter": false, "replicates": [291.9562065690146, 293.6901568844868, 300.61821486711864, 302.1856097816385, 302.62625657313214, 5245.79016839326, 5268.86827829304, 5304.946950530493, 5402.91895621565, 5449.618526703132, 5288.2596436498925, 5298.602604804636, 5344.358676958761, 5349.893002139965, 5363.329583802025, 3840.327942610046, 4029.9395509067385, 4030.415589739486, 4041.312976793937, 4043.4945631796027, 3925.3523168677275, 3944.349182384903, 4030.3954406838916, 4039.131586708857, 4040.878773636781, 3965.048388386781, 3980.3233450313373, 3982.0443093657605, 3984.3625019996807, 3995.06116062725, 3774.641409066134, 3855.267499175176, 3915.4126880967797, 3981.5819338969427, 3982.5220973483224, 3481.0, 3482.0, 3487.930241395183, 3499.265154317596, 3509.298140371936, 5074.923876141824, 5085.338905942241, 5092.134337162654, 5093.0, 5095.057414378315, 4613.8154473821005, 4623.329617205486, 4628.583427491542, 4629.51390104041, 4631.073785242965, 5358.517733404013, 5521.613487055908, 5531.502164805147, 5534.972325138348, 5538.944610553924, 3826.349520581508, 3829.157585331223, 3829.5787463379006, 3833.674137698299, 3835.9232815343817, 5818.389069147764, 5889.293284805851, 5891.263592050994, 5897.705114744289, 5899.7050147492455, 3922.5096862892137, 3923.136909879822, 3923.509561304837, 3928.9607103929166, 3929.4891664084057, 3755.6432138946757, 3777.376732839051, 4006.419069234945, 4007.3788562772816, 4008.7995600219874, 4133.6693064554765, 4396.494403143615, 4486.730796152176, 4498.820047198075, 4500.887477813081, 5405.108157154104, 5461.290032295776, 5462.918056229159, 5558.249636299048, 5561.9710353583905, 1355.959321220365, 1357.9660508487366, 1398.5245016694168, 1400.0199860097973, 1400.4748219417718, 915.8122584870085, 931.4364809290282, 932.6828878181451, 933.0529512544772, 936.2229349639782, 4851.223804191312, 4852.8786780330065, 4856.562909338177, 4864.197407427806, 4880.780364883589, 5732.3121225453215, 5744.540436765049, 5753.88492230153, 5756.524694381373, 5763.250777398911, 4823.710577365369, 4840.056189043103, 4841.588464980516, 4841.757912104381, 4842.201036828954, 2974.3456439583256, 3046.1470788179345, 3059.1740230138184, 3087.81473111614, 3089.0269565086924, 4790.281457781361, 5499.587530935196, 5520.585956053312, 5561.221428999943, 5568.693721845257, 5982.73077711504, 6012.729427175787, 6014.398560143951, 6016.669083200379, 6018.518518518508, 5566.35986861508, 5578.079616863172, 5587.469190426903, 5624.746886390204, 5628.493435590816, 5725.141228815544, 5859.355470898283, 5866.2960444746905, 5872.618279811799, 5874.206982057368, 5710.086386178192, 5713.600047996767, 5715.8856822864145, 5718.857028574319, 5721.370649228665, 5566.888662226814, 5567.63810352342, 5568.415316391721, 5570.498655121059, 5571.052921003358, 3883.9611603884728, 3920.2355540670437, 3920.353141731582, 3925.7644541327613, 3927.8821635350987, 5623.2408624835125, 5759.94240057594, 5764.279465066867, 5837.211976383134, 5851.502622276984, 5461.808836690697, 5469.56243500511, 5539.612227144061, 5583.302087239095, 5634.070378387521, 5627.268455100811, 5628.465295796893, 5628.718564071862, 5631.6902570359025, 5632.746526406403, 5365.356157261153, 5487.5609951203005, 5499.780008799763, 5511.58663100261, 5522.530584900329, 5667.121596152603, 5668.03643380618, 5669.291338582677, 5674.092145256739, 5678.290213723285, 5483.75323110469, 5487.4238204987905, 5489.478499542537, 5491.505764481216, 5493.2034854946605], "unit": "score", "name": "prototype.html", "value": 4145.5320827604}, {"lowerIsBetter": false, "replicates": [704.918934322553, 736.9424875303938, 749.9662515186819, 752.5898385379967, 754.1402800807077, 10456.0, 10616.946915265422, 10625.46872656366, 10628.893711062887, 10657.413842238673, 10635.042846143846, 10755.731106722336, 10775.676729698102, 10783.730406739836, 10791.298565593232, 612.3447910735515, 613.3130893399399, 613.8127870999343, 764.545095668078, 765.6784150656738, 788.6805843633309, 796.410656114474, 796.5300472721093, 797.1669605262485, 797.3461761355691, 826.099551488877, 840.8150206954491, 840.9495430274203, 841.6927821345196, 842.2672275120653, 640.4908098062028, 645.9031145328238, 814.8003739083903, 835.2607941971338, 836.3058661311097, 610.1640752169557, 610.7679081948831, 611.1596554737237, 611.5138464920354, 612.1582823617526, 9876.061774131445, 9956.452395118265, 9968.601255949754, 9972.70081897537, 9980.600775968953, 10009.29934904557, 11390.71523211918, 11610.88389116115, 11731.413429328499, 11756.177067605271, 8526.31789456842, 8569.914300856974, 8644.733110780566, 8656.740297791077, 8754.86867696985, 3128.765342599291, 3144.119646498984, 3184.50640150777, 3185.5062465317915, 3225.645179030305, 37806.243875122345, 37818.0, 37864.24271514582, 37935.0, 37983.43024854629, 8142.267195952392, 8375.246227839523, 8432.620532076071, 8458.957705211435, 8754.824903501894, 14228.715425691427, 14228.786568201485, 14235.85764142366, 14242.359093840802, 14243.715125697428, 6035.275766907911, 6071.696415179224, 6086.756529738849, 6196.8760624787255, 6227.626342419469, 3353.161709572607, 3419.965800341965, 3432.467967465047, 3452.9827350863084, 3477.8608855646, 2535.1380530619676, 2553.8467691938545, 2576.75520825525, 2577.1624222127884, 2577.1881857214917, 410.0834634591685, 412.1365738777257, 420.1869382744399, 422.0482811260649, 422.1788621131869, 534.318743601903, 552.6214543038031, 577.2755192233803, 582.1064665738156, 607.1742430294795, 7374.889376659355, 7406.370458510979, 7612.3148916596665, 7728.343090837229, 7748.7675369739, 472.41892472259315, 500.5570070487572, 508.336620709977, 515.6416290678018, 519.8544407565888, 3498.4052711039185, 3672.57765356982, 3673.669369756735, 3701.4632878232505, 3707.3697471429923, 49751.75124124356, 50181.74909125504, 50412.0, 50423.74788126036, 50630.74684626553, 43453.565464345585, 43796.82936383957, 44423.22402595751, 45092.0, 45108.54891451109, 37712.24575508475, 37836.0, 37935.0, 39178.608213918065, 40510.392344114865, 7352.301531354513, 7374.963125184339, 7448.478606497493, 7541.396688265036, 7590.316871481593, 29278.268043298234, 29566.704332956397, 29568.408631827675, 30285.394292114474, 30640.540391894585, 35077.64922350744, 35613.287734245685, 38998.4150237741, 39139.02152446098, 39139.41290880582, 9248.768780780534, 9521.904780952102, 9533.761655958378, 9587.472689002172, 9607.56765945548, 9595.616175352907, 9741.707748767549, 9886.258530610377, 10183.43991080468, 10463.267571269938, 8934.86597701022, 9125.17873391398, 9195.172434480928, 9302.627894884128, 9364.719058428258, 9260.722178334661, 9287.72136835896, 9310.162085412345, 9371.34400591952, 9399.765005874908, 9295.256379489489, 9436.52817359143, 9521.571529281338, 9534.523273836141, 9544.141027307576, 8062.314703250289, 8191.139870582379, 8264.628091736007, 8287.378446616649, 8470.57647117654, 7372.336489715952, 8382.958085209535, 8458.111898250596, 8611.149951061832, 9101.0], "unit": "score", "name": "yui.html", "value": 5352.760370762625}], "name": "dromaeo_css", "value": 6024.841854938141}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 108.0, 112.0, 111.0, 112.0, 101.0, 113.0, 113.0, 107.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 167.0, 170.0, 132.0, 165.0, 156.0, 133.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 161.0, 164.0, 163.0, 161.0, 162.0, 171.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 79.0, 94.0, 73.0, 75.0, 74.0, 100.0, 90.0, 76.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 138.0, 99.0, 99.0, 98.0, 137.0, 99.0, 98.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 72.0, 72.0, 71.0, 81.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 77.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 91.0, 85.0, 85.0, 86.0, 86.0, 85.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 129.0, 124.0, 132.0, 126.0, 122.0, 135.0, 139.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 153.0, 151.0, 151.0, 141.0, 150.0, 150.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 72.0, 71.0, 69.0, 70.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1544.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.32183134152498], "unit": "score", "name": "Richards", "value": 209.72918199999998}, {"lowerIsBetter": false, "replicates": [186.9508319312021], "unit": "score", "name": "DeltaBlue", "value": 353.66518199999996}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [808.4074373484236], "unit": "score", "name": "Earley", "value": 824.4147309999997}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [28472.222222222223], "unit": "score", "name": "RegExp", "value": 31.99557073170733}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19555.203633276968}]} 22:02:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19555.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1544.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6024.84"}}} 22:02:45 INFO - Return code: 0 22:02:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:02:45 INFO - # TBPL SUCCESS # 22:02:45 INFO - Running post-action listener: _resource_record_post_action 22:02:45 INFO - Running post-run listener: _resource_record_post_run 22:02:46 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550719488; Read time: 12; Write time: 517756 22:02:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235446272; Read time: 0; Write time: 283808 22:02:46 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314408960; Read time: 12; Write time: 233908 22:02:46 INFO - Running post-run listener: _upload_blobber_files 22:02:46 INFO - Blob upload gear active. 22:02:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:02:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:02:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:02:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:48 INFO - (blobuploader) - INFO - Done attempting. 22:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:49 INFO - (blobuploader) - INFO - Done attempting. 22:02:49 INFO - (blobuploader) - INFO - Iteration through files over. 22:02:49 INFO - Return code: 0 22:02:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:02:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:02:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc88f4540a487ef2806f777e0910f9e8ac6290f397a6b71f6edcc9200d9c5f86c496587ad6ff42d2bdc406db567d2014760d7711beb7135736894f0da0883e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd30d68465423b22453b13ee80c0cc73677c6986505ca1d212a3ef40072dc9d74b2662ed999fd109d60d1904770aefd0953fa1052cb8c50c566b88ca21bd4070"} 22:02:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:02:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:02:49 INFO - Contents: 22:02:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc88f4540a487ef2806f777e0910f9e8ac6290f397a6b71f6edcc9200d9c5f86c496587ad6ff42d2bdc406db567d2014760d7711beb7135736894f0da0883e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd30d68465423b22453b13ee80c0cc73677c6986505ca1d212a3ef40072dc9d74b2662ed999fd109d60d1904770aefd0953fa1052cb8c50c566b88ca21bd4070"} 22:02:49 INFO - Copying logs to upload dir... 22:02:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.746209 ========= master_lag: 38.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-12-30 22:03:26.788350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 22:03:26.792138) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc88f4540a487ef2806f777e0910f9e8ac6290f397a6b71f6edcc9200d9c5f86c496587ad6ff42d2bdc406db567d2014760d7711beb7135736894f0da0883e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd30d68465423b22453b13ee80c0cc73677c6986505ca1d212a3ef40072dc9d74b2662ed999fd109d60d1904770aefd0953fa1052cb8c50c566b88ca21bd4070"} build_url:https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/UiOTEL5WSnS-LyYavjg5Yw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc88f4540a487ef2806f777e0910f9e8ac6290f397a6b71f6edcc9200d9c5f86c496587ad6ff42d2bdc406db567d2014760d7711beb7135736894f0da0883e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd30d68465423b22453b13ee80c0cc73677c6986505ca1d212a3ef40072dc9d74b2662ed999fd109d60d1904770aefd0953fa1052cb8c50c566b88ca21bd4070"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 22:03:27.150028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-12-30 22:03:27.150328) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451540468.47924-1732083865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 4.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-12-30 22:03:32.053107) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-12-30 22:03:32.053506) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-12-30 22:03:35.337201) ========= ========= Total master_lag: 43.43 =========