builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1450372824.49 results: success (0) buildid: 20151217075729 builduid: 6befe0d091dd475b9112a01e174edd4a revision: 81e696a6c8ea2256096021d42a0e24f4386d045f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.494148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.494596) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.494879) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.563250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.563543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.606365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.606636) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.659377) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.659689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.662478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.662768) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 09:20:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-17 09:20:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.802446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.802723) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016520 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.856407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:24.856803) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81e696a6c8ea2256096021d42a0e24f4386d045f --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 81e696a6c8ea2256096021d42a0e24f4386d045f --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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 09:20:25,436 truncating revision to first 12 chars 2015-12-17 09:20:25,436 Setting DEBUG logging. 2015-12-17 09:20:25,436 attempt 1/10 2015-12-17 09:20:25,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81e696a6c8ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 09:20:25,672 unpacking tar archive at: fx-team-81e696a6c8ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:25.377018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:25.377312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:25.388875) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:25.389190) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 09:20:25.389623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 09:20:25.389931) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:20:26 INFO - MultiFileLogger online at 20151217 09:20:26 in /builds/slave/test 09:20:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:26 INFO - {'append_to_log': False, 09:20:26 INFO - 'base_work_dir': '/builds/slave/test', 09:20:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:26 INFO - 'branch': 'Fx-Team-Non-PGO', 09:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:26 INFO - 'config_files': ('talos/linux_config.py',), 09:20:26 INFO - 'default_actions': ('clobber', 09:20:26 INFO - 'read-buildbot-config', 09:20:26 INFO - 'download-and-extract', 09:20:26 INFO - 'populate-webroot', 09:20:26 INFO - 'create-virtualenv', 09:20:26 INFO - 'install', 09:20:26 INFO - 'run-tests'), 09:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:26 INFO - 'download_minidump_stackwalk': True, 09:20:26 INFO - 'download_symbols': 'ondemand', 09:20:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:26 INFO - 'installer_path': 'installer.exe', 09:20:26 INFO - 'log_level': 'info', 09:20:26 INFO - 'log_name': 'talos', 09:20:26 INFO - 'log_to_console': True, 09:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:20:26 INFO - 'opt_config_files': (), 09:20:26 INFO - 'pip_index': False, 09:20:26 INFO - 'sps_profile': False, 09:20:26 INFO - 'sps_profile_interval': 0, 09:20:26 INFO - 'suite': 'dromaeojs', 09:20:26 INFO - 'system_bits': '64', 09:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:26 INFO - 'title': 'talos-linux64-ix-034', 09:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:26 INFO - 'use_talos_json': True, 09:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:26 INFO - 'work_dir': 'build'} 09:20:26 INFO - ##### 09:20:26 INFO - ##### Running clobber step. 09:20:26 INFO - ##### 09:20:26 INFO - Running pre-action listener: _resource_record_pre_action 09:20:26 INFO - Running main action method: clobber 09:20:26 INFO - rmtree: /builds/slave/test/build 09:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:26 INFO - Running post-action listener: _resource_record_post_action 09:20:26 INFO - ##### 09:20:26 INFO - ##### Running read-buildbot-config step. 09:20:26 INFO - ##### 09:20:26 INFO - Running pre-action listener: _resource_record_pre_action 09:20:26 INFO - Running main action method: read_buildbot_config 09:20:26 INFO - Using buildbot properties: 09:20:26 INFO - { 09:20:26 INFO - "project": "", 09:20:26 INFO - "product": "firefox", 09:20:26 INFO - "script_repo_revision": "production", 09:20:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:20:26 INFO - "repository": "", 09:20:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:20:26 INFO - "buildid": "20151217075729", 09:20:26 INFO - "pgo_build": "False", 09:20:26 INFO - "basedir": "/builds/slave/test", 09:20:26 INFO - "buildnumber": 1201, 09:20:26 INFO - "slavename": "talos-linux64-ix-034", 09:20:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:20:26 INFO - "platform": "ubuntu64_hw", 09:20:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:20:26 INFO - "branch": "fx-team", 09:20:26 INFO - "repo_path": "integration/fx-team", 09:20:26 INFO - "revision": "81e696a6c8ea2256096021d42a0e24f4386d045f", 09:20:26 INFO - "stage_platform": "linux64", 09:20:26 INFO - "builduid": "6befe0d091dd475b9112a01e174edd4a", 09:20:26 INFO - "slavebuilddir": "test" 09:20:26 INFO - } 09:20:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:20:26 INFO - Running post-action listener: _resource_record_post_action 09:20:26 INFO - ##### 09:20:26 INFO - ##### Running download-and-extract step. 09:20:26 INFO - ##### 09:20:26 INFO - Running pre-action listener: _resource_record_pre_action 09:20:26 INFO - Running main action method: download_and_extract 09:20:26 INFO - mkdir: /builds/slave/test/build/tests 09:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:26 INFO - https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/test_packages.json 09:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/test_packages.json 09:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:20:27 INFO - Downloaded 1302 bytes. 09:20:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:20:27 INFO - Using the following test package requirements: 09:20:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:20:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'jsshell-linux-x86_64.zip'], 09:20:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:20:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:20:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:20:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:20:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:20:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:27 INFO - https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:28 INFO - Downloaded 21870957 bytes. 09:20:28 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 09:20:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:28 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 09:20:29 INFO - Return code: 0 09:20:29 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 09:20:29 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')]} 09:20:29 INFO - https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:20:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:33 INFO - Downloaded 21870957 bytes. 09:20:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:20:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:20:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:20:34 INFO - Return code: 0 09:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:34 INFO - https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:35 INFO - Downloaded 11132039 bytes. 09:20:35 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 09:20:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:20:35 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 09:20:35 INFO - Return code: 0 09:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:35 INFO - https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-xBxCxAR2yXPnbI9c9yYg/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 09:20:37 INFO - Downloaded 53018241 bytes. 09:20:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:20:37 INFO - mkdir: /builds/slave/test/properties 09:20:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:37 INFO - Contents: 09:20:37 INFO - build_url:https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:20:37 INFO - Running post-action listener: _resource_record_post_action 09:20:37 INFO - Running post-action listener: set_extra_try_arguments 09:20:37 INFO - ##### 09:20:37 INFO - ##### Running populate-webroot step. 09:20:37 INFO - ##### 09:20:37 INFO - Running pre-action listener: _resource_record_pre_action 09:20:37 INFO - Running main action method: populate_webroot 09:20:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:37 INFO - '--tppagecycles', 09:20:37 INFO - '7'], 09:20:37 INFO - 'tests': ['tsvgm']}}, 09:20:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:20:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:20:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:20:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'tests': ['damp', 'tps']}, 09:20:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['damp', 'tps']}, 09:20:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:20:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:37 INFO - 'other': {'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'other_l64': {'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:20:37 INFO - 'ts_paint', 09:20:37 INFO - 'tpaint', 09:20:37 INFO - 'sessionrestore', 09:20:37 INFO - 'sessionrestore_no_auto_restore']}, 09:20:37 INFO - 'svgr': {'tests': ['tsvgx', 09:20:37 INFO - 'tsvgr_opacity', 09:20:37 INFO - 'tart', 09:20:37 INFO - 'tscrollx', 09:20:37 INFO - 'cart']}, 09:20:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['tsvgx', 09:20:37 INFO - 'tsvgr_opacity', 09:20:37 INFO - 'tart', 09:20:37 INFO - 'tscrollx', 09:20:37 INFO - 'cart']}, 09:20:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'tests': ['tp5o']}, 09:20:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'talos_options': ['--e10s'], 09:20:37 INFO - 'tests': ['tp5o']}, 09:20:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'talos_options': ['--xperf_path', 09:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:37 INFO - 'tests': ['tp5n']}, 09:20:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:37 INFO - 'talos_options': ['--e10s', 09:20:37 INFO - '--xperf_path', 09:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:37 INFO - 'tests': ['tp5n']}}, 09:20:37 INFO - 'talos.zip': {'path': '', 09:20:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:37 INFO - Running post-action listener: _resource_record_post_action 09:20:37 INFO - ##### 09:20:37 INFO - ##### Running create-virtualenv step. 09:20:37 INFO - ##### 09:20:37 INFO - Running pre-action listener: _resource_record_pre_action 09:20:37 INFO - Running main action method: create_virtualenv 09:20:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:37 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 09:20:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:37 INFO - Using real prefix '/usr' 09:20:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:39 INFO - Installing pip.................done. 09:20:39 INFO - Return code: 0 09:20:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:39 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 09:20:39 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 09:20:39 INFO - Using env: {'DISPLAY': ':0', 09:20:39 INFO - 'HOME': '/home/cltbld', 09:20:39 INFO - 'LANG': 'en_US.UTF-8', 09:20:39 INFO - 'LANGUAGE': 'en_US:en', 09:20:39 INFO - 'LOGNAME': 'cltbld', 09:20:39 INFO - 'MAIL': '/var/mail/cltbld', 09:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:39 INFO - 'MOZ_NO_REMOTE': '1', 09:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:39 INFO - 'NO_EM_RESTART': '1', 09:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:39 INFO - 'PWD': '/builds/slave/test', 09:20:39 INFO - 'SHELL': '/bin/bash', 09:20:39 INFO - 'SHLVL': '1', 09:20:39 INFO - 'TERM': 'linux', 09:20:39 INFO - 'TMOUT': '86400', 09:20:39 INFO - 'USER': 'cltbld', 09:20:39 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:39 INFO - '_': '/tools/buildbot/bin/python'} 09:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:20:39 INFO - Cleaning up... 09:20:39 INFO - Return code: 0 09:20:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:39 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 09:20:39 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 09:20:39 INFO - Using env: {'DISPLAY': ':0', 09:20:39 INFO - 'HOME': '/home/cltbld', 09:20:39 INFO - 'LANG': 'en_US.UTF-8', 09:20:39 INFO - 'LANGUAGE': 'en_US:en', 09:20:39 INFO - 'LOGNAME': 'cltbld', 09:20:39 INFO - 'MAIL': '/var/mail/cltbld', 09:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:39 INFO - 'MOZ_NO_REMOTE': '1', 09:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:39 INFO - 'NO_EM_RESTART': '1', 09:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:39 INFO - 'PWD': '/builds/slave/test', 09:20:39 INFO - 'SHELL': '/bin/bash', 09:20:39 INFO - 'SHLVL': '1', 09:20:39 INFO - 'TERM': 'linux', 09:20:39 INFO - 'TMOUT': '86400', 09:20:39 INFO - 'USER': 'cltbld', 09:20:39 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:39 INFO - '_': '/tools/buildbot/bin/python'} 09:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:40 INFO - Downloading/unpacking psutil>=0.7.1 09:20:40 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 09:20:40 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 09:20:40 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 09:20:40 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 09:20:40 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 09:20:40 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 09:20:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:20:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:41 INFO - Installing collected packages: psutil 09:20:41 INFO - Running setup.py install for psutil 09:20:42 INFO - building 'psutil._psutil_linux' extension 09:20:42 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 09:20:42 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 09:20:42 INFO - building 'psutil._psutil_posix' extension 09:20:42 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 09:20:42 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 09:20:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:42 INFO - Successfully installed psutil 09:20:42 INFO - Cleaning up... 09:20:42 INFO - Return code: 0 09:20:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:42 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:42 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 09:20:42 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 09:20:42 INFO - Using env: {'DISPLAY': ':0', 09:20:42 INFO - 'HOME': '/home/cltbld', 09:20:42 INFO - 'LANG': 'en_US.UTF-8', 09:20:42 INFO - 'LANGUAGE': 'en_US:en', 09:20:42 INFO - 'LOGNAME': 'cltbld', 09:20:42 INFO - 'MAIL': '/var/mail/cltbld', 09:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:42 INFO - 'MOZ_NO_REMOTE': '1', 09:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:42 INFO - 'NO_EM_RESTART': '1', 09:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:42 INFO - 'PWD': '/builds/slave/test', 09:20:42 INFO - 'SHELL': '/bin/bash', 09:20:42 INFO - 'SHLVL': '1', 09:20:42 INFO - 'TERM': 'linux', 09:20:42 INFO - 'TMOUT': '86400', 09:20:42 INFO - 'USER': 'cltbld', 09:20:42 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:42 INFO - '_': '/tools/buildbot/bin/python'} 09:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:20:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:20:44 INFO - Installing collected packages: mozsystemmonitor 09:20:44 INFO - Running setup.py install for mozsystemmonitor 09:20:44 INFO - Successfully installed mozsystemmonitor 09:20:44 INFO - Cleaning up... 09:20:44 INFO - Return code: 0 09:20:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:44 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:44 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 09:20:44 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 09:20:44 INFO - Using env: {'DISPLAY': ':0', 09:20:44 INFO - 'HOME': '/home/cltbld', 09:20:44 INFO - 'LANG': 'en_US.UTF-8', 09:20:44 INFO - 'LANGUAGE': 'en_US:en', 09:20:44 INFO - 'LOGNAME': 'cltbld', 09:20:44 INFO - 'MAIL': '/var/mail/cltbld', 09:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:44 INFO - 'MOZ_NO_REMOTE': '1', 09:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:44 INFO - 'NO_EM_RESTART': '1', 09:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:44 INFO - 'PWD': '/builds/slave/test', 09:20:44 INFO - 'SHELL': '/bin/bash', 09:20:44 INFO - 'SHLVL': '1', 09:20:44 INFO - 'TERM': 'linux', 09:20:44 INFO - 'TMOUT': '86400', 09:20:44 INFO - 'USER': 'cltbld', 09:20:44 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:44 INFO - '_': '/tools/buildbot/bin/python'} 09:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:47 INFO - Downloading docopt-0.6.1.tar.gz 09:20:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:47 INFO - Running setup.py install for blobuploader 09:20:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:47 INFO - Running setup.py install for requests 09:20:47 INFO - Running setup.py install for docopt 09:20:47 INFO - Successfully installed blobuploader requests docopt 09:20:47 INFO - Cleaning up... 09:20:47 INFO - Return code: 0 09:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:47 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 09:20:47 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 09:20:47 INFO - Using env: {'DISPLAY': ':0', 09:20:47 INFO - 'HOME': '/home/cltbld', 09:20:47 INFO - 'LANG': 'en_US.UTF-8', 09:20:47 INFO - 'LANGUAGE': 'en_US:en', 09:20:47 INFO - 'LOGNAME': 'cltbld', 09:20:47 INFO - 'MAIL': '/var/mail/cltbld', 09:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:47 INFO - 'MOZ_NO_REMOTE': '1', 09:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:47 INFO - 'NO_EM_RESTART': '1', 09:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:47 INFO - 'PWD': '/builds/slave/test', 09:20:47 INFO - 'SHELL': '/bin/bash', 09:20:47 INFO - 'SHLVL': '1', 09:20:47 INFO - 'TERM': 'linux', 09:20:47 INFO - 'TMOUT': '86400', 09:20:47 INFO - 'USER': 'cltbld', 09:20:47 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:47 INFO - '_': '/tools/buildbot/bin/python'} 09:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:48 INFO - Running setup.py (path:/tmp/pip-1fl7xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:48 INFO - Running setup.py (path:/tmp/pip-rJa61M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:48 INFO - Running setup.py (path:/tmp/pip-kq71Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:48 INFO - Running setup.py (path:/tmp/pip-eIE5Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:48 INFO - Running setup.py (path:/tmp/pip-MO5tWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:48 INFO - Running setup.py (path:/tmp/pip-dA9t9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:48 INFO - Running setup.py (path:/tmp/pip-Tzzakn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:48 INFO - Running setup.py (path:/tmp/pip-BSIyLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:48 INFO - Running setup.py (path:/tmp/pip-xTtUve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:48 INFO - Running setup.py (path:/tmp/pip-1y1MUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:48 INFO - Running setup.py (path:/tmp/pip-a1cKh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:48 INFO - Running setup.py (path:/tmp/pip-QnEeqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:48 INFO - Running setup.py (path:/tmp/pip-Yo7Pz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:48 INFO - Running setup.py (path:/tmp/pip-jifefq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:49 INFO - Running setup.py (path:/tmp/pip-qrT24D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:49 INFO - Running setup.py (path:/tmp/pip-EhJi_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:49 INFO - Running setup.py (path:/tmp/pip-N4hiJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:49 INFO - Running setup.py install for manifestparser 09:20:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:49 INFO - Running setup.py install for mozcrash 09:20:49 INFO - Running setup.py install for mozdebug 09:20:49 INFO - Running setup.py install for mozdevice 09:20:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:20:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:49 INFO - Running setup.py install for mozfile 09:20:49 INFO - Running setup.py install for mozhttpd 09:20:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:49 INFO - Running setup.py install for mozinfo 09:20:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:49 INFO - Running setup.py install for mozInstall 09:20:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Running setup.py install for mozleak 09:20:50 INFO - Running setup.py install for mozlog 09:20:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Running setup.py install for moznetwork 09:20:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Running setup.py install for mozprocess 09:20:50 INFO - Running setup.py install for mozprofile 09:20:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Running setup.py install for mozrunner 09:20:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Running setup.py install for mozscreenshot 09:20:50 INFO - Running setup.py install for moztest 09:20:50 INFO - Running setup.py install for mozversion 09:20:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:50 INFO - Cleaning up... 09:20:51 INFO - Return code: 0 09:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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', '-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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:51 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 09:20:51 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 09:20:51 INFO - Using env: {'DISPLAY': ':0', 09:20:51 INFO - 'HOME': '/home/cltbld', 09:20:51 INFO - 'LANG': 'en_US.UTF-8', 09:20:51 INFO - 'LANGUAGE': 'en_US:en', 09:20:51 INFO - 'LOGNAME': 'cltbld', 09:20:51 INFO - 'MAIL': '/var/mail/cltbld', 09:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:51 INFO - 'MOZ_NO_REMOTE': '1', 09:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:51 INFO - 'NO_EM_RESTART': '1', 09:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:51 INFO - 'PWD': '/builds/slave/test', 09:20:51 INFO - 'SHELL': '/bin/bash', 09:20:51 INFO - 'SHLVL': '1', 09:20:51 INFO - 'TERM': 'linux', 09:20:51 INFO - 'TMOUT': '86400', 09:20:51 INFO - 'USER': 'cltbld', 09:20:51 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:51 INFO - '_': '/tools/buildbot/bin/python'} 09:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:51 INFO - Running setup.py (path:/tmp/pip-tGVTSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:51 INFO - Running setup.py (path:/tmp/pip-8KbJRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:51 INFO - Running setup.py (path:/tmp/pip-TLf9kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:51 INFO - Running setup.py (path:/tmp/pip-golUZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:51 INFO - Running setup.py (path:/tmp/pip-kG0u_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:51 INFO - Running setup.py (path:/tmp/pip-vgUokP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:51 INFO - Running setup.py (path:/tmp/pip-ZkF0gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:51 INFO - Running setup.py (path:/tmp/pip-oQmZsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:51 INFO - Running setup.py (path:/tmp/pip-jwLudG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:51 INFO - Running setup.py (path:/tmp/pip-X9aD5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:51 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)) 09:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:51 INFO - Running setup.py (path:/tmp/pip-CnQjmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:52 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)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:52 INFO - Running setup.py (path:/tmp/pip-jU8Mx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:52 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)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:52 INFO - Running setup.py (path:/tmp/pip-0K_EOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:52 INFO - Running setup.py (path:/tmp/pip-hwpezJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:52 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)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:52 INFO - Running setup.py (path:/tmp/pip-XPjDxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:52 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)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:52 INFO - Running setup.py (path:/tmp/pip-amQXJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:52 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)) 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:52 INFO - Running setup.py (path:/tmp/pip-P8GF_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:52 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)) 09:20:52 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)) 09:20:52 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)) 09:20:52 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)) 09:20:52 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)) 09:20:52 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)) 09:20:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:54 INFO - Downloading blessings-1.5.1.tar.gz 09:20:54 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 09:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:54 INFO - Installing collected packages: blessings 09:20:54 INFO - Running setup.py install for blessings 09:20:54 INFO - Successfully installed blessings 09:20:54 INFO - Cleaning up... 09:20:54 INFO - Return code: 0 09:20:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:54 INFO - Reading from file tmpfile_stdout 09:20:54 INFO - Current package versions: 09:20:54 INFO - argparse == 1.2.1 09:20:54 INFO - blessings == 1.5.1 09:20:54 INFO - blobuploader == 1.2.4 09:20:54 INFO - docopt == 0.6.1 09:20:54 INFO - manifestparser == 1.1 09:20:54 INFO - mozInstall == 1.12 09:20:54 INFO - mozcrash == 0.16 09:20:54 INFO - mozdebug == 0.1 09:20:54 INFO - mozdevice == 0.47 09:20:54 INFO - mozfile == 1.2 09:20:54 INFO - mozhttpd == 0.7 09:20:54 INFO - mozinfo == 0.9 09:20:54 INFO - mozleak == 0.1 09:20:54 INFO - mozlog == 3.1 09:20:54 INFO - moznetwork == 0.27 09:20:54 INFO - mozprocess == 0.22 09:20:54 INFO - mozprofile == 0.27 09:20:54 INFO - mozrunner == 6.11 09:20:54 INFO - mozscreenshot == 0.1 09:20:54 INFO - mozsystemmonitor == 0.0 09:20:54 INFO - moztest == 0.7 09:20:54 INFO - mozversion == 1.4 09:20:54 INFO - psutil == 3.1.1 09:20:54 INFO - requests == 1.2.3 09:20:54 INFO - wsgiref == 0.1.2 09:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:54 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 09:20:54 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 09:20:54 INFO - Using env: {'DISPLAY': ':0', 09:20:54 INFO - 'HOME': '/home/cltbld', 09:20:54 INFO - 'LANG': 'en_US.UTF-8', 09:20:54 INFO - 'LANGUAGE': 'en_US:en', 09:20:54 INFO - 'LOGNAME': 'cltbld', 09:20:54 INFO - 'MAIL': '/var/mail/cltbld', 09:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:54 INFO - 'MOZ_NO_REMOTE': '1', 09:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:54 INFO - 'NO_EM_RESTART': '1', 09:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:54 INFO - 'PWD': '/builds/slave/test', 09:20:54 INFO - 'SHELL': '/bin/bash', 09:20:54 INFO - 'SHLVL': '1', 09:20:54 INFO - 'TERM': 'linux', 09:20:54 INFO - 'TMOUT': '86400', 09:20:54 INFO - 'USER': 'cltbld', 09:20:54 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:54 INFO - '_': '/tools/buildbot/bin/python'} 09:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:20:54 INFO - Cleaning up... 09:20:54 INFO - Return code: 0 09:20:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:20:54 INFO - Using env: {'DISPLAY': ':0', 09:20:54 INFO - 'HOME': '/home/cltbld', 09:20:54 INFO - 'LANG': 'en_US.UTF-8', 09:20:54 INFO - 'LANGUAGE': 'en_US:en', 09:20:54 INFO - 'LOGNAME': 'cltbld', 09:20:54 INFO - 'MAIL': '/var/mail/cltbld', 09:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:54 INFO - 'MOZ_NO_REMOTE': '1', 09:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:54 INFO - 'NO_EM_RESTART': '1', 09:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:54 INFO - 'PWD': '/builds/slave/test', 09:20:54 INFO - 'SHELL': '/bin/bash', 09:20:54 INFO - 'SHLVL': '1', 09:20:54 INFO - 'TERM': 'linux', 09:20:54 INFO - 'TMOUT': '86400', 09:20:54 INFO - 'USER': 'cltbld', 09:20:54 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:54 INFO - '_': '/tools/buildbot/bin/python'} 09:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:55 INFO - Downloading/unpacking jsonschema 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:56 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 09:20:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:56 INFO - warning: no files found matching '*.txt' 09:20:56 INFO - no previously-included directories found matching 'build' 09:20:56 INFO - no previously-included directories found matching 'dist' 09:20:56 INFO - no previously-included directories found matching '.git*' 09:20:56 INFO - Installing collected packages: jsonschema, functools32 09:20:56 INFO - Running setup.py install for functools32 09:20:57 INFO - warning: no files found matching '*.txt' 09:20:57 INFO - no previously-included directories found matching 'build' 09:20:57 INFO - no previously-included directories found matching 'dist' 09:20:57 INFO - no previously-included directories found matching '.git*' 09:20:57 INFO - Successfully installed jsonschema functools32 09:20:57 INFO - Cleaning up... 09:20:57 INFO - Return code: 0 09:20:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 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 0x7f862d83af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2049240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', '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 09:20:57 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 09:20:57 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 09:20:57 INFO - Using env: {'DISPLAY': ':0', 09:20:57 INFO - 'HOME': '/home/cltbld', 09:20:57 INFO - 'LANG': 'en_US.UTF-8', 09:20:57 INFO - 'LANGUAGE': 'en_US:en', 09:20:57 INFO - 'LOGNAME': 'cltbld', 09:20:57 INFO - 'MAIL': '/var/mail/cltbld', 09:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:57 INFO - 'MOZ_NO_REMOTE': '1', 09:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:57 INFO - 'NO_EM_RESTART': '1', 09:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:57 INFO - 'PWD': '/builds/slave/test', 09:20:57 INFO - 'SHELL': '/bin/bash', 09:20:57 INFO - 'SHLVL': '1', 09:20:57 INFO - 'TERM': 'linux', 09:20:57 INFO - 'TMOUT': '86400', 09:20:57 INFO - 'USER': 'cltbld', 09:20:57 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:57 INFO - '_': '/tools/buildbot/bin/python'} 09:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:57 INFO - Downloading/unpacking flake8 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:20:59 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 09:20:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:20:59 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 09:20:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 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 09:20:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:20:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:20:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:20:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:20:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:20:59 INFO - no previously-included directories found matching 'docs/_build' 09:20:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:20:59 INFO - Running setup.py install for pep8 09:20:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:20:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:20:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:20:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:20:59 INFO - no previously-included directories found matching 'docs/_build' 09:20:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:20:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:20:59 INFO - Cleaning up... 09:20:59 INFO - Return code: 0 09:20:59 INFO - Running post-action listener: _resource_record_post_action 09:20:59 INFO - Running post-action listener: _start_resource_monitoring 09:20:59 INFO - Starting resource monitoring. 09:20:59 INFO - ##### 09:20:59 INFO - ##### Running install step. 09:20:59 INFO - ##### 09:20:59 INFO - Running pre-action listener: _resource_record_pre_action 09:20:59 INFO - Running main action method: install 09:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:00 INFO - Reading from file tmpfile_stdout 09:21:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:00 INFO - Reading from file tmpfile_stdout 09:21:00 INFO - Output received: 09:21:00 INFO - Usage: mozinstall [options] installer 09:21:00 INFO - Options: 09:21:00 INFO - -h, --help show this help message and exit 09:21:00 INFO - -d DEST, --destination=DEST 09:21:00 INFO - Directory to install application into. [default: 09:21:00 INFO - "/builds/slave/test"] 09:21:00 INFO - --app=APP Application being installed. [default: firefox] 09:21:00 INFO - mkdir: /builds/slave/test/build/application 09:21:00 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'] 09:21:00 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 09:21:15 INFO - Reading from file tmpfile_stdout 09:21:15 INFO - Output received: 09:21:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:21:15 INFO - Running post-action listener: _resource_record_post_action 09:21:15 INFO - ##### 09:21:15 INFO - ##### Running run-tests step. 09:21:15 INFO - ##### 09:21:15 INFO - Running pre-action listener: _resource_record_pre_action 09:21:15 INFO - Running main action method: run_tests 09:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:15 INFO - Python 2.7.3 09:21:15 INFO - Return code: 0 09:21:15 INFO - grabbing minidump binary from tooltool 09:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:21:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d80b0>, '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 0x20d8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:21:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:21:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:15 INFO - Return code: 0 09:21:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:21:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:21:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:21:16 INFO - Return code: 0 09:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 09:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 09:21:16 INFO - Using env: {'DISPLAY': ':0', 09:21:16 INFO - 'HOME': '/home/cltbld', 09:21:16 INFO - 'LANG': 'en_US.UTF-8', 09:21:16 INFO - 'LANGUAGE': 'en_US:en', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MAIL': '/var/mail/cltbld', 09:21:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SHLVL': '1', 09:21:16 INFO - 'TERM': 'linux', 09:21:16 INFO - 'TMOUT': '86400', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - '_': '/tools/buildbot/bin/python'} 09:21:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 09:21:16 INFO - mozversion INFO | application_buildid: 20151217075729 09:21:16 INFO - mozversion INFO | application_changeset: 81e696a6c8ea2256096021d42a0e24f4386d045f 09:21:16 INFO - mozversion INFO | application_display_name: Nightly 09:21:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:16 INFO - mozversion INFO | application_name: Firefox 09:21:16 INFO - mozversion INFO | application_remotingname: firefox 09:21:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:21:16 INFO - mozversion INFO | application_vendor: Mozilla 09:21:16 INFO - mozversion INFO | application_version: 46.0a1 09:21:16 INFO - mozversion INFO | platform_buildid: 20151217075729 09:21:16 INFO - mozversion INFO | platform_changeset: 81e696a6c8ea2256096021d42a0e24f4386d045f 09:21:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:21:16 INFO - mozversion INFO | platform_version: 46.0a1 09:21:16 INFO - 2015-12-17 09:21:16,818 DEBUG : using testdate: 1450372876 09:21:16 INFO - 2015-12-17 09:21:16,818 DEBUG : actual date: 1450372876 09:21:16 INFO - 2015-12-17 09:21:16,826 INFO : starting webserver on 'localhost:34051' 09:21:16 INFO - 2015-12-17 09:21:16,827 INFO : Starting test suite talos-linux64-ix-034 09:21:16 INFO - 2015-12-17 09:21:16,827 INFO : Starting test dromaeo_css 09:21:16 INFO - 2015-12-17 09:21:16,827 DEBUG : operating with platform_type : linux_ 09:21:16 INFO - 2015-12-17 09:21:16,828 INFO : Initialising browser for dromaeo_css test... 09:21:16 INFO - 2015-12-17 09:21:16,840 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wM1Mh/profile http://localhost:34051/getInfo.html 09:21:21 INFO - 2015-12-17 09:21:21,968 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:21:21 INFO - 2015-12-17 09:21:21,968 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:21:21 INFO - 2015-12-17 09:21:21,968 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:21:21 INFO - 2015-12-17 09:21:21,969 DEBUG : BROWSER_OUTPUT: __metrics 09:21:22 INFO - 2015-12-17 09:21:22,073 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:21:22 INFO - 2015-12-17 09:21:22,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:22 INFO - 2015-12-17 09:21:22,460 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:21:23 INFO - 2015-12-17 09:21:23,209 INFO : Browser initialized. 09:21:23 INFO - 2015-12-17 09:21:23,210 INFO : Running cycle 1/1 for dromaeo_css test... 09:21:23 INFO - 2015-12-17 09:21:23,210 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wM1Mh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:21:35 INFO - 2015-12-17 09:21:35,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 147902464 09:21:35 INFO - 2015-12-17 09:21:35,255 DEBUG : BROWSER_OUTPUT: 09:22:26 INFO - 2015-12-17 09:22:26,759 DEBUG : BROWSER_OUTPUT: 1450372946752 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] 09:24:38 INFO - 2015-12-17 09:24:38,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34051/tests/dromaeo/cssquery-ext.html) 09:24:39 INFO - 2015-12-17 09:24:39,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 235978752 09:24:39 INFO - 2015-12-17 09:24:39,992 DEBUG : BROWSER_OUTPUT: 09:27:42 INFO - 2015-12-17 09:27:42,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-ext.html (next: http://localhost:34051/tests/dromaeo/cssquery-jquery.html) 09:27:42 INFO - 2015-12-17 09:27:42,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 225759232 09:27:42 INFO - 2015-12-17 09:27:42,992 DEBUG : BROWSER_OUTPUT: 09:30:44 INFO - 2015-12-17 09:30:44,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34051/tests/dromaeo/cssquery-mootools.html) 09:30:45 INFO - 2015-12-17 09:30:45,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 218152960 09:30:45 INFO - 2015-12-17 09:30:45,488 DEBUG : BROWSER_OUTPUT: 09:33:47 INFO - 2015-12-17 09:33:47,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34051/tests/dromaeo/cssquery-prototype.html) 09:33:48 INFO - 2015-12-17 09:33:48,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 207519744 09:33:48 INFO - 2015-12-17 09:33:48,015 DEBUG : BROWSER_OUTPUT: 09:36:50 INFO - 2015-12-17 09:36:50,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34051/tests/dromaeo/cssquery-yui.html) 09:36:51 INFO - 2015-12-17 09:36:51,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 216231936 09:36:51 INFO - 2015-12-17 09:36:51,265 DEBUG : BROWSER_OUTPUT: 09:39:53 INFO - 2015-12-17 09:39:53,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/dromaeo/cssquery-yui.html (next: http://localhost:34051/tests/dromaeo/cssquery-dojo.html) 09:39:54 INFO - 2015-12-17 09:39:54,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 279076864 09:39:54 INFO - 2015-12-17 09:39:54,135 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,135 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:39:54 INFO - 2015-12-17 09:39:54,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:39:54 INFO - 2015-12-17 09:39:54,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:39:54 INFO - 2015-12-17 09:39:54,136 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:39:54 INFO - 2015-12-17 09:39:54,136 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.1478019643614;2696.501147287751;2699.500592390407;2705.8105932584726;2747.6565429321336;4497.887552811173;4608.055348653526;4630.62954963603;4704.129735998838;4753.786079626417;4641.25739881619;4708.034852855165;4730.9053818923685;4731.290306454033;4879.146149423846;4348.608625223745;4354.127725078215;4395.978020109895;4487.080148569552;4532.342810292505;4444.822207111728;4504.662150338721;4507.526709695484;4517.344984977176;4547.545245475442;4210.936835947463;4269.893252668677;4330.761808100553;4374.562543745632;4406.449193850769;4369.563043695637;4418.072204836956;4445.622122119624;4446.221911165566;4473.731576105444;4186.0581369192;4397.780110994469;4417.425734654475;4434.201843668138;4468.061707041526;4603.378543896564;4610.216263235258;4611.123886461562;4736;4754.1917873961165;5140.537351638333;5141.30592370029;5145.614078944094;5146.794128234867;5177.948220517785;5149.974250128763;5162.870928226786;5163.40620828602;5163.793448262065;5201.479852014768;4608.400907882021;4716.716996980193;4724.905501889943;4725.810967561328;4768.237082066853;5170.819021334235;5313.787448502017;5325.733713314319;5326.041312563698;5328.6802791832615;4991.4758950310425;4993.176125939252;4993.650444468853;5040.092783298968;5058.317127187856;5022.8196373852115;5092.083424983464;5097.796088156507;5101.489851014869;5146.742662866842;4709.95290047102;4828.758562071883;4842.903141937141;4879.097366987048;4990.675606085593;5069.695818250917;5075.923861142086;5103.209002604603;5104.2343648453025;5145.61407894402;4265.637420819203;4272.957270427318;4275.03811642378;4281.807318670667;4325.048489332342;3585.408407612767;3624.5650521937537;3681.7975011374097;3700.9074773130887;3707.1844194277214;4379.824807007684;4386.18855511725;4406.030673251879;4414.602685758233;4453.042595841845;5166.349478383035;5166.896662066738;5170.8190213343105;5176.7152806596;5181.844544663666;4115.588441155861;4216.51510076339;4220.662347012231;4278.058827058042;4348.043430445297;4492.618127459203;4493.820247190141;4497.550244975476;4503.121891231244;4557.886052848706;4825.083234185494;4830.516948305141;4839.080574690797;4849.2968519565175;4894.094592500399;4844.176489996779;4955.306257123933;4958.45456999737;4959.330490383896;5104.183330667224;4737.170995075779;4842.15262329098;4863.683860549053;4863.805447782049;4889.608831293559;5025.924611130909;5048.3941926969;5060.342155519759;5079.822206222764;5118.38579370478;4806.951930480651;4926.211806111005;5145.382554093533;5157.329547158845;5163.6127290454115;4852.2479015752615;4873.610111191026;4951.183054796063;4954.380702412199;5000.724960127228;4942.75286235694;4959.553640172402;4961.08219979305;4963.70217786934;5006.07387633289;4668;4801.303810947324;4852.296417019583;4873.171560834738;4921.557059864629;4852.393450818648;4870.853874383774;4876.024795040935;4931.556159945622;4961.7271050092595;4861.732604706775;4887.971551488268;4889.657723959289;4894.070126675921;4939.53074457926 09:39:54 INFO - 2015-12-17 09:39:54,136 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.3111033432373;543.6493461717192;548.8847342058168;556.8667761106148;567.9318481782187;27639.585406218925;28241.293967650818;36139;36641;36699.63300366996;40079.198416031664;40473.59526404735;40722.59277407225;40785.59214407855;40811.38782918259;7002.08972833531;7883.448158628884;8031.9598402007905;8051.396145289097;8055.033395992489;7154.785356439315;7244.782656520313;7260.818479538001;7269.636518174097;10209.33639313446;10115.54480048396;10249;10253.487325633725;10280.94859525705;10289.279750417474;9980.700578982642;10058.145057670106;10075.949620251926;10076.39541627501;10078.395296282246;7236.96381518089;7437.181909989897;10201.693949181536;10528.789424211549;10541.947290263577;37700.81149594262;38233.23533529314;38263.42604860929;38278.23443531142;38313.42529862055;2797.622320986661;2829.9292517687018;2874.195225336909;2888.8844446222124;2895.5946167536563;28532.794451513193;29015.564766528518;29066.41867162666;29082.85458572715;29699.10902672923;3452.8446219920165;3467.09855437588;3493.5633045869267;3526.523919270917;3613.295407395559;223496;224478;224738;224780;225522;43645.56354436415;56405;56728;56782.148267776014;56812.715936420056;43321.56678433238;59230.40769592335;61806;61828.69085654543;61914;12997.740045199043;13168.407421666048;13280.933595331962;13281.734365312639;13318.400671969785;9947.20422366209;9947.701568952943;10001.299909006446;10009.599616015277;10019.899801001897;19347.129379177688;19486.415407537796;19573.90213048954;19596.314129005415;19615.803841961682;6951.131108611424;7145.642717864086;7152.356287934111;7190.496665233383;7235.529690570096;886.1006078829993;914.5564401265381;932.69687351611;955.0831202046113;984.9359791613665;25865.35336616562;26439;27487.17538473849;27487.86256068707;27495.862520687268;932.4684929590204;951.509972364233;969.95150242489;980.9558569864373;1060.490964337107;12571.622851314476;12747.107702460924;14145.504907328193;14738.263086845614;15028.09831410119;272870;274867;274977;275992;276166;46740.53259467362;47347.289790653165;47351;47455.5254447458;47605.523944760804;1234.154604096197;1239.367922359585;1242.5588915934893;1253.4923356040817;1261.1046157228286;26718;27217.31956701098;27583.586246205923;27745;27916.44167116687;36435.45346819853;36989.26021479609;37327.81336093302;41736.58263417327;42600.36099458449;165577;167248;168847;169087;169521;25463.490730185662;25583;25588.872055639604;25689.357766055997;25998.480030399664;30111.397772044875;30504.734853212347;32819.69259577076;36238;37963.43054854235;28282.85858570694;28881.42237155287;29003.854980725806;29412.970546030785;29549.409011820073;28779.424411511234;28976.855115724287;29099.272518187216;29159.271018224714;29164.416711665224;28925.7107428923;29582.260443488223;29622.703772962857;29652.406951860412;32282;26375.472490550466;28714.99497517577;29619.85190074036;30634.234144145685;30650;21153.25963591267;21322.573548529253;21393.465163371042;23382.76617233806;23924 09:39:54 INFO - 2015-12-17 09:39:54,136 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.4921427287794;321.7667191286318;322.51622566150786;325.219473264166;332.0519915640847;14966.700665986673;15207.391704331827;15359.462418815343;15780.605484862885;15792;14892.404303827834;14949.85050149501;14957.850421495781;14962.551123466286;15148.1668508232;4917.7541122943885;5049.545540901318;5078.289039534468;5079.4412614612365;5082;4246.68149888758;5024.397072351323;5056.747162641853;5063.139266324733;5065.138926382506;3702.1670124222105;3814.408766641175;3816.923661526768;5756.107803290497;5760.0783874580075;3793.279276937387;3800.6389393007757;3803.619638036202;5525.668459892379;5726.5418766499;4790.664653474259;4899.873029203303;4984.327115839352;4986.252062190701;5085.669431486942;19144.904275478533;19363.83816970972;19401.32095376655;19485.512862178417;19665;1535.8617724404746;1815.6277963017683;1881.5578339090303;1923.1249781349452;2010.1657812008145;11806.232594881305;11842;12002.879971200264;12074.335911524862;12113;1664.1429663723193;1703.7359209322574;1744.5376975101608;1767.690654135521;1788.8658350623755;52287.73856130695;54746.452535474535;55953.44046559523;56179.15731263993;56593.71703141499;8715.738527844174;8921.349550333209;9354.20489258407;9374.859377109213;9424.057594240658;11738.295702257721;11745.412729363497;11821.113416493798;11842.28946263227;11847.407629618485;6652.833679157963;6682.665866706645;6725;6730.562513436611;6818.761343352959;6327.588706734047;6330.240371155491;6360.936390636034;6399.13611662429;6406.167198264196;5579.637323574036;5638.887222255532;5652.293463317085;5659.801906933238;5692.7722891083895;1567.9451219207274;1591.2282542966652;1593.689230600045;1604.133767765417;1619.0852168524746;877.5699907045502;924.7179610218814;938.0525669074284;945.924326053914;974.1378879691524;16152.273147708382;16230.269637866324;16242;16388.75416868748;16628.83371166297;683.2859661653584;845.8012367093728;871.5642178910545;906.5693795447241;933.0576118120612;8500.574971251413;8546.401751877309;8585.914140858511;8694.000189978233;8725.650973961097;453491;456954;461936;462359;466308;62572;64943;65119.674401627686;66362.33637663658;66861;1046.3669479964665;1050.3487837540774;1057.0222544146786;1069.8395240713955;1070.673444599389;13800.309984500534;13967.790483142559;14291.28543572838;14405.7839132411;14506.34721437559;30069.849650751607;30180.396392072475;30418.239544011576;30733.231669207555;31594.36811263716;40710.79644601758;41268.587314126475;41586.79206604069;42466.36300455434;42957;8340.624671889658;8747.693830716149;8819.29445644334;9082.818343633222;9113.134252246025;7845.3723702104835;15556.688866222386;15717.449889253821;16131.516054518383;16261.51215463538;13370.799438008244;13428.127171733806;13592;13834.515791947233;13871.306434678025;13185.80221296662;13245.602631921058;13265.66835829112;13488;13512.93243533776;13484.932575337452;14001.369938352595;14031.508897188549;14169.291535423394;14241.430342786172;8704.738857834274;8714.346424018097;8892.86660700103;8924.821503570021;8952.507612081397;11264.887351126712;13154.408051637507;13263.668408289484;13875.653108672364;14559 09:39:54 INFO - 2015-12-17 09:39:54,137 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1438.971220575588;1631.420845599812;1677.6476939842632;1710.1021963469177;1718.2182107141248;5959.702014899254;6751.932480675198;6900.206476255232;6904.723811047558;6911.377975982161;6788.355106264897;6998.230194678594;6998.54509456885;7006.544574602647;7017.333353331425;1750.2998800479781;1777.3334999375234;2022.6460369435363;2049.928252511166;2082.7708952015264;2082.208760670943;2087.530305681217;2087.6242276390244;2088.4048046306807;2089.550746589483;1966.665666836634;1970.5763260898905;2021.7877122902105;2022.4539374368912;2031.2585906144225;2025.686018667109;2033.400146956644;2062.3194345865827;2068.7827778083233;2069.5447001659686;2109.219588752156;2132.818710409617;2137.861039032458;2138.390558690766;2139.4865232344127;6988.266232045613;7062.6821793019435;7087.043249161349;7089.645517724145;7091.18451378093;4059.533153687334;4139.8965025874295;4166.229247589175;4171.270027745163;4178.143480586503;2586.056089527328;2658.667666541682;2670.092168662645;2673.2247648182006;2679.6650418697664;884.8495755721543;898.1153563739712;904.159132007233;920.4431319052011;924.533110779059;9556;9646.9517652412;9686.515674216262;9704.12662860339;9714.319997600242;3715.1826598148364;3721.9441708374397;3751.681107105872;3767.095896984704;3789.147441825567;8438.324934005388;8444.915550844536;8454.943132108487;8472.068072512018;8496.490210587384;4127.669786417079;4145.626893579592;4160.750354978711;4177.770222637723;4186.079062606222;3859.6912247020173;3862.6909847212155;3867.9613203867602;3870.2646497165447;3871.05159235989;3013.608230930009;3065.969340306613;3330.5670262865674;3372.224388390684;3411.113110591264;1107.4352080438873;1123.1183520936027;1134.9432528373547;1151.0388825330774;1155.064397837754;853.3216093205916;856.6188046319328;856.8671855862351;858.0861382627606;954.1394281151781;6612.07430959666;6781.830454238683;6797.524173307821;6801.387875091265;6805.285445028201;523.4033202149552;527.4567195788344;539.3016044222662;573.9024365857814;719.802054435024;5407.297051383295;5488.615796894179;5502.422245664227;5521.061419558685;5532.114861622121;8211.8357632847;8758.56207189638;8779.03430622631;8780.165884240987;8789.780255493535;8651.178138076873;8654.567271636393;8677.609507572175;8681.262092722063;8685.609147588373;6657.700403481855;6763.425108865801;6888.104546409035;6894.793156205322;6896.3103689631635;6477.902831457438;6497.935020649733;6498.350164983463;6500.739970401131;6501.609903405811;7599.050118735158;7741.187175346733;7825.960870195612;7840.882386764089;7848.450608457581;7789.883151752615;7942.166072562529;8082.555459449787;8101.675932962616;8105.554194519123;5877.471027607536;6150.815475535741;6167.629942203482;6190.380961903774;6209.844753881189;6187.412195841388;6296.338884417253;6611.735530578723;6742;6754.696038678173;5281.630285879952;5814;6586.47308215332;6709.865802683821;6762.526623136333;6512.413882750575;6532.902006470002;6547.279799221987;6633.834154146185;6657.06801047844;6583.670816459254;6618.437432818265;6619.2056953164;6621.801345959629;6633.568818026813;6062.636241825505;6067.120267561268;6070.78752243687;6083.6349819011;6103.908441373294;6078.057901025348;6138.109974053827;6140.385961404003;6143.96928015357;6180.072989051679 09:39:54 INFO - 2015-12-17 09:39:54,138 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.7422216893471;301.5070359961463;309.9752019838413;310.75139888089535;311.78331059913353;5147.253648221011;5248.47515248475;5276.419593844679;5304.867378315535;5317.042932272189;4949.802007919688;5062.822801201959;5130.07658621448;5203.661761985469;5230.816921407752;4096.672266218696;4117.773522456264;4127.092039751257;4129.814158362866;4131.173765246947;3860.1700634363606;4130.401091841682;4136.172765446908;4137.4207610934345;4138.7516748995;3878.4764056852387;3938.369860822269;4054.6350828425434;4091.1408604193007;4105.2815757242515;4056.9188616227807;4061.8578349757618;4088.550259471456;4101.487314085739;4109.6712263019035;3613.9096522586883;3617.819109044537;3625.87597844669;3626.839411388357;3631.527901372831;5065.366829146356;5071.518205770446;5071.87320316995;5073.923891141636;5077;4613.192691279013;4698.4361876574685;4721.079389519045;4724.889650932028;4732.739699316537;5521.806736764234;5528.143137813645;5533.03171944908;5533.478293469288;5536.141898005815;3950.9727470857497;3955.5846636103083;3956.109875278068;3958.7228893977435;3959.4060890866313;5797.333306669745;5802.97098514509;5804.62269952456;5811.941880581182;5814.098814683731;3978;4057.5739547347102;4075.1645912587846;4083.0404854859084;4095.7133000689664;4127.5666055064385;4132.669386449077;4139.151473947833;4140.0891803803115;4142.834286628501;4640.074369136771;4672.462666793363;4673.626109911199;4677.883052923704;4688.249880019181;5458.099413596791;5471.616986810965;5479.150731636602;5501.614886957875;5518.751656175482;1367.0703921333588;1418.184543887269;1435.4832260386252;1442.4158215922569;1445.38571107279;939.5959737312884;940.7883226274033;943.4056544376998;945.4941606240766;950.9904900951041;4761.595264402496;4763.309320148628;4769.523047695203;4775.474697783241;4775.95224047762;5582.8325150245555;5602.0196465619165;5602.2717046783655;5604.299462567179;5604.719764011865;4699.765011749399;4759.428868535798;4770.260609605447;4770.809167633325;4831;3058.648255450607;3078.707522785332;3095;3095.0250671038552;3097.1637657832257;5449.509544141047;5470.124780035176;5471.343438787371;5472.480114389126;5481.177823326533;5922.9930911745105;5925.140854576062;5932.673702946379;5934.258217722785;5934.6142500737315;5311.707856067954;5486.039943009957;5493.972530137404;5496.5053145217125;5500.862478438071;5770.365259821332;5777.480026797609;5786.566007549535;5787.739551720267;5789.131630255495;5653.915191272216;5658.17956396312;5664;5666.263385759989;5673.886522269614;5342.839714808562;5485.807996720096;5486.753096110605;5492.945070549244;5499.917501237404;3919.1377896862646;3952.288588054178;3956.9604303957744;3957.050307926135;3961.425593288899;5764.971175144097;5768.884622307614;5771.971140144273;5772.191893135048;5773.595848290579;5541.9168712470155;5551.084071128219;5555.361133469541;5556.138798486241;5558.360788509373;5412.648177868584;5537.723113844372;5544.168374743659;5546.722663866871;5547.944520554743;5415.891682166256;5429.429909859566;5431.56547476193;5436.0486914790545;5438.075527160471;5567.109262517978;5578.693171875586;5579.218909352613;5579.525740312119;5590.86022849432;5301.5493683037375;5446.373667028342;5448.618596698193;5452.672839629635;5461.262729531462 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: |5;yui.html;686.8866637004894;720.0926832191441;722.6350692900088;732.4177279063144;739.4010851210518;10793;10999.670009899706;10999.725006874833;11002.724931876706;11010.944945275272;10981.890181098186;11009.394483303415;11073.833892491599;11098.500567474463;11099.944500277508;622.9781957631484;631.1447987976295;631.8167731357901;788.9723859664898;806.3267171911461;627.5199472403615;636.1062706896818;783.3889566138421;798.7683571764181;805.2913436176186;837.736113124367;839.0476808822001;843.2705709561216;846.0059430169526;846.1834329871704;647.9967600162016;832.6919039955225;834.0616806093145;834.1866679987024;834.3492076180559;486.6180048661819;616.7687117331001;624.8750249949983;627.1815281058217;628.5505863307757;10510.527026283835;10701.518431670593;10705;10724.946375268073;10741.140708743282;9978.351407158583;11058.22592418531;11112.888871111347;11264.718382040433;11280.43597820114;8938.687145949925;9681.854772178423;9701.320907536476;9881.357711748786;10125.898741012643;3082.5647738286725;3151.8896838610767;3167.524871269305;3172.4289627866974;3193.3294008258295;38670.61329386698;39023.609763902285;39176.41235381472;39267.8036609818;39298.214035719415;8768.298536117096;8780.78048048791;8900.643974240958;8951.239144672776;8966.551672416354;15423.383064677511;15531.767023494656;15592.298346574431;15747.606309842116;15754.606134846721;6020.969895150583;6082.817515474543;6091.604045737102;6127.050307202391;6166.044263139221;3359.6591447686883;3382.8139452330356;3391.745619078579;3436.9484457733156;3449.6377880322207;2427.5994460914103;2459.360566252787;2461.74151714071;2462.667539882129;2463.1625247415604;449.9775011249424;450.3762289229441;460.17628445083596;463.49710564037724;464.53314419009354;416.66250337226944;452.7147896824979;492.33534728116757;547.5099785691783;552.2296396526823;6417.422431981051;6498.285188629247;6796.76211332601;7135.857282854314;7787.5716835574585;515.8504033830222;532.8321578702696;555.5361273336729;556.1352097488444;563.7209581257304;3353.9496907546404;3464.6188919218866;3602.47764074213;3615.060084378081;3636.61815509373;44098.7795061029;45190.32214516785;45271.32093018608;45564.088718226114;45586.772066139456;41286;41382.79308603498;41872.79063604723;42513.574864250964;42713.145737085084;37356.43965340522;37792;38039.23921521554;38513.422298665544;39318.2136357277;7282.4902256841515;7298.708051677873;7344.70621175147;7356.006939063158;7464.440166987389;29766.553501697927;30357.392852143275;30587.54118688177;30761.384772304875;30854.84572577123;34716.30567388688;35085;35481.82259088688;37521;37966.8101659501;9376;9565.378250413702;9681.273904457054;9737.561809718722;9777.657781977596;10676.519556619816;10737.731556711145;10800.45997700096;11246.437678116225;11300.265482743924;9800.509974501103;9923.305368624417;9973.202143828332;10463.319884207502;10468.424236667057;9576.521173941135;9875.259355548505;9877.111060004634;10055.39667619916;10173.186145108522;9833.60665573369;10404.635837745642;10449.895501044892;10511.474426278503;10517.368957862553;8442.831143377221;8563.229309362187;8647.740567782977;8874.822503550022;8965;7867.606619668879;7957.403194760532;7987.48081374732;8748.08145144776;8923.330750193632 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,849 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: __startTimestamp1450373994133__endTimestamp 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:39:54 INFO - 2015-12-17 09:39:54,140 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4688.08 Median:4839.08 stddev:499.29 (10.3%) stddev-sans-first:473.79 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: Values: 2622.1 2696.5 2699.5 2705.8 2747.7 4497.9 4608.1 4630.6 4704.1 4753.8 4641.3 4708.0 4730.9 4731.3 4879.1 4348.6 4354.1 4396.0 4487.1 4532.3 4444.8 4504.7 4507.5 4517.3 4547.5 4210.9 4269.9 4330.8 4374.6 4406.4 4369.6 4418.1 4445.6 4446.2 4473.7 4186.1 4397.8 4417.4 4434.2 4468.1 4603.4 4610.2 4611.1 4736.0 4754.2 5140.5 5141.3 5145.6 5146.8 5177.9 5150.0 5162.9 5163.4 5163.8 5201.5 4608.4 4716.7 4724.9 4725.8 4768.2 5170.8 5313.8 5325.7 5326.0 5328.7 4991.5 4993.2 4993.7 5040.1 5058.3 5022.8 5092.1 5097.8 5101.5 5146.7 4710.0 4828.8 4842.9 4879.1 4990.7 5069.7 5075.9 5103.2 5104.2 5145.6 4265.6 4273.0 4275.0 4281.8 4325.0 3585.4 3624.6 3681.8 3700.9 3707.2 4379.8 4386.2 4406.0 4414.6 4453.0 5166.3 5166.9 5170.8 5176.7 5181.8 4115.6 4216.5 4220.7 4278.1 4348.0 4492.6 4493.8 4497.6 4503.1 4557.9 4825.1 4830.5 4839.1 4849.3 4894.1 4844.2 4955.3 4958.5 4959.3 5104.2 4737.2 4842.2 4863.7 4863.8 4889.6 5025.9 5048.4 5060.3 5079.8 5118.4 4807.0 4926.2 5145.4 5157.3 5163.6 4852.2 4873.6 4951.2 4954.4 5000.7 4942.8 4959.6 4961.1 4963.7 5006.1 4668.0 4801.3 4852.3 4873.2 4921.6 4852.4 4870.9 4876.0 4931.6 4961.7 4861.7 4888.0 4889.7 4894.1 4939.5 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38292.07 Median:29091.06 stddev:59141.54 (203.3%) stddev-sans-first:59239.52 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: Values: 540.3 543.6 548.9 556.9 567.9 27639.6 28241.3 36139.0 36641.0 36699.6 40079.2 40473.6 40722.6 40785.6 40811.4 7002.1 7883.4 8032.0 8051.4 8055.0 7154.8 7244.8 7260.8 7269.6 10209.3 10115.5 10249.0 10253.5 10280.9 10289.3 9980.7 10058.1 10075.9 10076.4 10078.4 7237.0 7437.2 10201.7 10528.8 10541.9 37700.8 38233.2 38263.4 38278.2 38313.4 2797.6 2829.9 2874.2 2888.9 2895.6 28532.8 29015.6 29066.4 29082.9 29699.1 3452.8 3467.1 3493.6 3526.5 3613.3 223496.0 224478.0 224738.0 224780.0 225522.0 43645.6 56405.0 56728.0 56782.1 56812.7 43321.6 59230.4 61806.0 61828.7 61914.0 12997.7 13168.4 13280.9 13281.7 13318.4 9947.2 9947.7 10001.3 10009.6 10019.9 19347.1 19486.4 19573.9 19596.3 19615.8 6951.1 7145.6 7152.4 7190.5 7235.5 886.1 914.6 932.7 955.1 984.9 25865.4 26439.0 27487.2 27487.9 27495.9 932.5 951.5 970.0 981.0 1060.5 12571.6 12747.1 14145.5 14738.3 15028.1 272870.0 274867.0 274977.0 275992.0 276166.0 46740.5 47347.3 47351.0 47455.5 47605.5 1234.2 1239.4 1242.6 1253.5 1261.1 26718.0 27217.3 27583.6 27745.0 27916.4 36435.5 36989.3 37327.8 41736.6 42600.4 165577.0 167248.0 168847.0 169087.0 169521.0 25463.5 25583.0 25588.9 25689.4 25998.5 30111.4 30504.7 32819.7 36238.0 37963.4 28282.9 28881.4 29003.9 29413.0 29549.4 28779.4 28976.9 29099.3 29159.3 29164.4 28925.7 29582.3 29622.7 29652.4 32282.0 26375.5 28715.0 29619.9 30634.2 30650.0 21153.3 21322.6 21393.5 23382.8 23924.0 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,141 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25332.52 Median:3796.96 stddev:75077.10 (1977.3%) stddev-sans-first:75264.21 09:39:54 INFO - 2015-12-17 09:39:54,142 DEBUG : BROWSER_OUTPUT: Values: 313.5 321.8 322.5 325.2 332.1 14966.7 15207.4 15359.5 15780.6 15792.0 14892.4 14949.9 14957.9 14962.6 15148.2 4917.8 5049.5 5078.3 5079.4 5082.0 4246.7 5024.4 5056.7 5063.1 5065.1 3702.2 3814.4 3816.9 5756.1 5760.1 3793.3 3800.6 3803.6 5525.7 5726.5 4790.7 4899.9 4984.3 4986.3 5085.7 19144.9 19363.8 19401.3 19485.5 19665.0 1535.9 1815.6 1881.6 1923.1 2010.2 11806.2 11842.0 12002.9 12074.3 12113.0 1664.1 1703.7 1744.5 1767.7 1788.9 52287.7 54746.5 55953.4 56179.2 56593.7 8715.7 8921.3 9354.2 9374.9 9424.1 11738.3 11745.4 11821.1 11842.3 11847.4 6652.8 6682.7 6725.0 6730.6 6818.8 6327.6 6330.2 6360.9 6399.1 6406.2 5579.6 5638.9 5652.3 5659.8 5692.8 1567.9 1591.2 1593.7 1604.1 1619.1 877.6 924.7 938.1 945.9 974.1 16152.3 16230.3 16242.0 16388.8 16628.8 683.3 845.8 871.6 906.6 933.1 8500.6 8546.4 8585.9 8694.0 8725.7 453491.0 456954.0 461936.0 462359.0 466308.0 62572.0 64943.0 65119.7 66362.3 66861.0 1046.4 1050.3 1057.0 1069.8 1070.7 13800.3 13967.8 14291.3 14405.8 14506.3 30069.8 30180.4 30418.2 30733.2 31594.4 40710.8 41268.6 41586.8 42466.4 42957.0 8340.6 8747.7 8819.3 9082.8 9113.1 7845.4 15556.7 15717.4 16131.5 16261.5 13370.8 13428.1 13592.0 13834.5 13871.3 13185.8 13245.6 13265.7 13488.0 13512.9 13484.9 14001.4 14031.5 14169.3 14241.4 8704.7 8714.3 8892.9 8924.8 8952.5 11264.9 13154.4 13263.7 13875.7 14559.0 09:39:54 INFO - 2015-12-17 09:39:54,142 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,142 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4970.32 Median:6188.90 stddev:2625.24 (42.4%) stddev-sans-first:2619.19 09:39:54 INFO - 2015-12-17 09:39:54,142 DEBUG : BROWSER_OUTPUT: Values: 1439.0 1631.4 1677.6 1710.1 1718.2 5959.7 6751.9 6900.2 6904.7 6911.4 6788.4 6998.2 6998.5 7006.5 7017.3 1750.3 1777.3 2022.6 2049.9 2082.8 2082.2 2087.5 2087.6 2088.4 2089.6 1966.7 1970.6 2021.8 2022.5 2031.3 2025.7 2033.4 2062.3 2068.8 2069.5 2109.2 2132.8 2137.9 2138.4 2139.5 6988.3 7062.7 7087.0 7089.6 7091.2 4059.5 4139.9 4166.2 4171.3 4178.1 2586.1 2658.7 2670.1 2673.2 2679.7 884.8 898.1 904.2 920.4 924.5 9556.0 9647.0 9686.5 9704.1 9714.3 3715.2 3721.9 3751.7 3767.1 3789.1 8438.3 8444.9 8454.9 8472.1 8496.5 4127.7 4145.6 4160.8 4177.8 4186.1 3859.7 3862.7 3868.0 3870.3 3871.1 3013.6 3066.0 3330.6 3372.2 3411.1 1107.4 1123.1 1134.9 1151.0 1155.1 853.3 856.6 856.9 858.1 954.1 6612.1 6781.8 6797.5 6801.4 6805.3 523.4 527.5 539.3 573.9 719.8 5407.3 5488.6 5502.4 5521.1 5532.1 8211.8 8758.6 8779.0 8780.2 8789.8 8651.2 8654.6 8677.6 8681.3 8685.6 6657.7 6763.4 6888.1 6894.8 6896.3 6477.9 6497.9 6498.4 6500.7 6501.6 7599.1 7741.2 7826.0 7840.9 7848.5 7789.9 7942.2 8082.6 8101.7 8105.6 5877.5 6150.8 6167.6 6190.4 6209.8 6187.4 6296.3 6611.7 6742.0 6754.7 5281.6 5814.0 6586.5 6709.9 6762.5 6512.4 6532.9 6547.3 6633.8 6657.1 6583.7 6618.4 6619.2 6621.8 6633.6 6062.6 6067.1 6070.8 6083.6 6103.9 6078.1 6138.1 6140.4 6144.0 6180.1 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4599.63 Median:5239.65 stddev:1344.71 (25.7%) stddev-sans-first:1309.18 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: Values: 299.7 301.5 310.0 310.8 311.8 5147.3 5248.5 5276.4 5304.9 5317.0 4949.8 5062.8 5130.1 5203.7 5230.8 4096.7 4117.8 4127.1 4129.8 4131.2 3860.2 4130.4 4136.2 4137.4 4138.8 3878.5 3938.4 4054.6 4091.1 4105.3 4056.9 4061.9 4088.6 4101.5 4109.7 3613.9 3617.8 3625.9 3626.8 3631.5 5065.4 5071.5 5071.9 5073.9 5077.0 4613.2 4698.4 4721.1 4724.9 4732.7 5521.8 5528.1 5533.0 5533.5 5536.1 3951.0 3955.6 3956.1 3958.7 3959.4 5797.3 5803.0 5804.6 5811.9 5814.1 3978.0 4057.6 4075.2 4083.0 4095.7 4127.6 4132.7 4139.2 4140.1 4142.8 4640.1 4672.5 4673.6 4677.9 4688.2 5458.1 5471.6 5479.2 5501.6 5518.8 1367.1 1418.2 1435.5 1442.4 1445.4 939.6 940.8 943.4 945.5 951.0 4761.6 4763.3 4769.5 4775.5 4776.0 5582.8 5602.0 5602.3 5604.3 5604.7 4699.8 4759.4 4770.3 4770.8 4831.0 3058.6 3078.7 3095.0 3095.0 3097.2 5449.5 5470.1 5471.3 5472.5 5481.2 5923.0 5925.1 5932.7 5934.3 5934.6 5311.7 5486.0 5494.0 5496.5 5500.9 5770.4 5777.5 5786.6 5787.7 5789.1 5653.9 5658.2 5664.0 5666.3 5673.9 5342.8 5485.8 5486.8 5492.9 5499.9 3919.1 3952.3 3957.0 3957.1 3961.4 5765.0 5768.9 5772.0 5772.2 5773.6 5541.9 5551.1 5555.4 5556.1 5558.4 5412.6 5537.7 5544.2 5546.7 5547.9 5415.9 5429.4 5431.6 5436.0 5438.1 5567.1 5578.7 5579.2 5579.5 5590.9 5301.5 5446.4 5448.6 5452.7 5461.3 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11542.79 Median:45575.43 stddev:12911.69 (28.3%) stddev-sans-first:12922.17 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: Values: 686.9 720.1 722.6 732.4 739.4 10793.0 10999.7 10999.7 11002.7 11010.9 10981.9 11009.4 11073.8 11098.5 11099.9 623.0 631.1 631.8 789.0 806.3 627.5 636.1 783.4 798.8 805.3 837.7 839.0 843.3 846.0 846.2 648.0 832.7 834.1 834.2 834.3 486.6 616.8 624.9 627.2 628.6 10510.5 10701.5 10705.0 10724.9 10741.1 9978.4 11058.2 11112.9 11264.7 11280.4 8938.7 9681.9 9701.3 9881.4 10125.9 3082.6 3151.9 3167.5 3172.4 3193.3 38670.6 39023.6 39176.4 39267.8 39298.2 8768.3 8780.8 8900.6 8951.2 8966.6 15423.4 15531.8 15592.3 15747.6 15754.6 6021.0 6082.8 6091.6 6127.1 6166.0 3359.7 3382.8 3391.7 3436.9 3449.6 2427.6 2459.4 2461.7 2462.7 2463.2 450.0 450.4 460.2 463.5 464.5 416.7 452.7 492.3 547.5 552.2 6417.4 6498.3 6796.8 7135.9 7787.6 515.9 532.8 555.5 556.1 563.7 3353.9 3464.6 3602.5 3615.1 3636.6 44098.8 45190.3 45271.3 45564.1 45586.8 41286.0 41382.8 41872.8 42513.6 42713.1 37356.4 37792.0 38039.2 38513.4 39318.2 7282.5 7298.7 7344.7 7356.0 7464.4 29766.6 30357.4 30587.5 30761.4 30854.8 34716.3 35085.0 35481.8 37521.0 37966.8 9376.0 9565.4 9681.3 9737.6 9777.7 10676.5 10737.7 10800.5 11246.4 11300.3 9800.5 9923.3 9973.2 10463.3 10468.4 9576.5 9875.3 9877.1 10055.4 10173.2 9833.6 10404.6 10449.9 10511.5 10517.4 8442.8 8563.2 8647.7 8874.8 8965.0 7867.6 7957.4 7987.5 8748.1 8923.3 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:39:54 INFO - 2015-12-17 09:39:54,143 DEBUG : BROWSER_OUTPUT: 09:39:54 INFO - 2015-12-17 09:39:54,917 INFO : Browser exited with error code: 0 09:39:54 INFO - 2015-12-17 09:39:54,938 INFO : Completed test dromaeo_css (00:18:38) 09:39:54 INFO - 2015-12-17 09:39:54,938 INFO : Starting test kraken 09:39:54 INFO - 2015-12-17 09:39:54,938 DEBUG : operating with platform_type : linux_ 09:39:54 INFO - 2015-12-17 09:39:54,938 INFO : Initialising browser for kraken test... 09:39:54 INFO - 2015-12-17 09:39:54,944 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_aEJ3/profile http://localhost:34051/getInfo.html 09:39:59 INFO - 2015-12-17 09:39:59,454 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:39:59 INFO - 2015-12-17 09:39:59,454 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:39:59 INFO - 2015-12-17 09:39:59,454 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:39:59 INFO - 2015-12-17 09:39:59,454 DEBUG : BROWSER_OUTPUT: __metrics 09:39:59 INFO - 2015-12-17 09:39:59,611 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:39:59 INFO - 2015-12-17 09:39:59,821 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:00 INFO - 2015-12-17 09:40:00,915 INFO : Browser initialized. 09:40:00 INFO - 2015-12-17 09:40:00,916 INFO : Running cycle 1/1 for kraken test... 09:40:00 INFO - 2015-12-17 09:40:00,916 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_aEJ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:40:12 INFO - 2015-12-17 09:40:12,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 149708800 09:40:12 INFO - 2015-12-17 09:40:12,853 DEBUG : BROWSER_OUTPUT: 09:40:15 INFO - 2015-12-17 09:40:15,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34051/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:16 INFO - 2015-12-17 09:40:16,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 186552320 09:40:16 INFO - 2015-12-17 09:40:16,029 DEBUG : BROWSER_OUTPUT: 09:40:18 INFO - 2015-12-17 09:40:18,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34051/tests/kraken/driver.html?testName=audio-dft) 09:40:19 INFO - 2015-12-17 09:40:19,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 177049600 09:40:19 INFO - 2015-12-17 09:40:19,337 DEBUG : BROWSER_OUTPUT: 09:40:22 INFO - 2015-12-17 09:40:22,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34051/tests/kraken/driver.html?testName=audio-fft) 09:40:22 INFO - 2015-12-17 09:40:22,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 161918976 09:40:22 INFO - 2015-12-17 09:40:22,926 DEBUG : BROWSER_OUTPUT: 09:40:24 INFO - 2015-12-17 09:40:24,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34051/tests/kraken/driver.html?testName=audio-oscillator) 09:40:25 INFO - 2015-12-17 09:40:25,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 161759232 09:40:25 INFO - 2015-12-17 09:40:25,523 DEBUG : BROWSER_OUTPUT: 09:40:27 INFO - 2015-12-17 09:40:27,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:28 INFO - 2015-12-17 09:40:28,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 164589568 09:40:28 INFO - 2015-12-17 09:40:28,309 DEBUG : BROWSER_OUTPUT: 09:40:31 INFO - 2015-12-17 09:40:31,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34051/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:31 INFO - 2015-12-17 09:40:31,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 166088704 09:40:31 INFO - 2015-12-17 09:40:31,853 DEBUG : BROWSER_OUTPUT: 09:40:35 INFO - 2015-12-17 09:40:35,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34051/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:35 INFO - 2015-12-17 09:40:35,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 165908480 09:40:35 INFO - 2015-12-17 09:40:35,849 DEBUG : BROWSER_OUTPUT: 09:40:38 INFO - 2015-12-17 09:40:38,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34051/tests/kraken/driver.html?testName=json-parse-financial) 09:40:39 INFO - 2015-12-17 09:40:39,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 167403520 09:40:39 INFO - 2015-12-17 09:40:39,260 DEBUG : BROWSER_OUTPUT: 09:40:41 INFO - 2015-12-17 09:40:41,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:41 INFO - 2015-12-17 09:40:41,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 173731840 09:40:41 INFO - 2015-12-17 09:40:41,632 DEBUG : BROWSER_OUTPUT: 09:40:43 INFO - 2015-12-17 09:40:43,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:44 INFO - 2015-12-17 09:40:44,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 172867584 09:40:44 INFO - 2015-12-17 09:40:44,138 DEBUG : BROWSER_OUTPUT: 09:40:46 INFO - 2015-12-17 09:40:46,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:46 INFO - 2015-12-17 09:40:46,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 182448128 09:40:46 INFO - 2015-12-17 09:40:46,823 DEBUG : BROWSER_OUTPUT: 09:40:49 INFO - 2015-12-17 09:40:49,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:49 INFO - 2015-12-17 09:40:49,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 191541248 09:40:49 INFO - 2015-12-17 09:40:49,918 DEBUG : BROWSER_OUTPUT: 09:40:52 INFO - 2015-12-17 09:40:52,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:53 INFO - 2015-12-17 09:40:53,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 188448768 09:40:53 INFO - 2015-12-17 09:40:53,091 DEBUG : BROWSER_OUTPUT: 09:40:54 INFO - 2015-12-17 09:40:54,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34051/tests/kraken/driver.html?testName=ai-astar) 09:40:55 INFO - 2015-12-17 09:40:55,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 246718464 09:40:55 INFO - 2015-12-17 09:40:55,117 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:40:55 INFO - 2015-12-17 09:40:55,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;108;112;113;113;102;113;113;118 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;128;148;163;130;160;150;131;174;130 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;159;160;160;162;162;162;162;161 09:40:55 INFO - 2015-12-17 09:40:55,121 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;91;70;70;71;101;88;71 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;128;94;95;96;131;94;95;136 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;110;109;109;110;109 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;147;148;148;148;147;148 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;96;96;95;95 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;72;72;73;72;72;82;71;71 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;68;68;68;68;68;68 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;83;81;83;84;84;83;83;83;83 09:40:55 INFO - 2015-12-17 09:40:55,122 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;129;116;120;129;129;128;123;127;125 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;139;151;146;151;137;154;158;149;135 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;72;70;69;69;69;69;71;71 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:40:55 INFO - 2015-12-17 09:40:55,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1450374055119__endTimestamp 09:40:55 INFO - 2015-12-17 09:40:55,124 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:4.16 (3.7%) stddev-sans-first:4.42 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 108.0 112.0 113.0 113.0 102.0 113.0 113.0 118.0 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:18.90 (12.2%) stddev-sans-first:17.14 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: Values: 177.0 128.0 148.0 163.0 130.0 160.0 150.0 131.0 174.0 130.0 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,127 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 159.0 160.0 160.0 162.0 162.0 162.0 162.0 161.0 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:72.00 stddev:11.06 (15.4%) stddev-sans-first:11.46 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 91.0 70.0 70.0 71.0 101.0 88.0 71.0 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.50 stddev:17.90 (18.9%) stddev-sans-first:18.46 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 128.0 94.0 95.0 96.0 131.0 94.0 95.0 136.0 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,128 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.00 stddev:3.23 (4.5%) stddev-sans-first:3.43 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 72.0 73.0 72.0 72.0 82.0 71.0 71.0 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.36 (2.8%) stddev-sans-first:0.87 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: Values: 90.0 83.0 81.0 83.0 84.0 84.0 83.0 83.0 83.0 83.0 09:40:55 INFO - 2015-12-17 09:40:55,129 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:127.50 stddev:4.36 (3.4%) stddev-sans-first:4.62 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: Values: 125.0 129.0 116.0 120.0 129.0 129.0 128.0 123.0 127.0 125.0 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:150.00 stddev:8.04 (5.4%) stddev-sans-first:8.02 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: Values: 138.0 139.0 151.0 146.0 151.0 137.0 154.0 158.0 149.0 135.0 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.15 (1.6%) stddev-sans-first:1.17 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 72.0 70.0 69.0 69.0 69.0 69.0 71.0 71.0 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:40:55 INFO - 2015-12-17 09:40:55,130 DEBUG : BROWSER_OUTPUT: 09:40:56 INFO - 2015-12-17 09:40:56,065 INFO : Browser exited with error code: 0 09:40:56 INFO - 2015-12-17 09:40:56,114 INFO : Completed test kraken (00:01:01) 09:40:56 INFO - 2015-12-17 09:40:56,114 INFO : Starting test v8_7 09:40:56 INFO - 2015-12-17 09:40:56,114 DEBUG : operating with platform_type : linux_ 09:40:56 INFO - 2015-12-17 09:40:56,114 INFO : Initialising browser for v8_7 test... 09:40:56 INFO - 2015-12-17 09:40:56,120 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0aDJk/profile http://localhost:34051/getInfo.html 09:41:00 INFO - 2015-12-17 09:41:00,605 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:41:00 INFO - 2015-12-17 09:41:00,605 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:41:00 INFO - 2015-12-17 09:41:00,605 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:41:00 INFO - 2015-12-17 09:41:00,605 DEBUG : BROWSER_OUTPUT: __metrics 09:41:00 INFO - 2015-12-17 09:41:00,750 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:41:00 INFO - 2015-12-17 09:41:00,838 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:02 INFO - 2015-12-17 09:41:02,157 INFO : Browser initialized. 09:41:02 INFO - 2015-12-17 09:41:02,157 INFO : Running cycle 1/1 for v8_7 test... 09:41:02 INFO - 2015-12-17 09:41:02,158 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0aDJk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:41:14 INFO - 2015-12-17 09:41:14,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 150011904 09:41:14 INFO - 2015-12-17 09:41:14,176 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34051/tests/v8_7/run.html (next: http://localhost:34051/tests/v8_7/run.html) 09:41:35 INFO - 2015-12-17 09:41:35,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 450084864 09:41:35 INFO - 2015-12-17 09:41:35,818 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,818 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:41:35 INFO - 2015-12-17 09:41:35,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.35681186283597 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.1618625277162 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5180.412371134021 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |8;Splay;613.1207847946046 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:41:35 INFO - 2015-12-17 09:41:35,819 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: __startTimestamp1450374095817__endTimestamp 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: Values: 165.5 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.36 Median:185.36 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: Values: 185.4 09:41:35 INFO - 2015-12-17 09:41:35,820 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.16 Median:277.16 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: Values: 277.2 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: Values: 5180.4 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: Values: 1976.3 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: Values: 783.1 09:41:35 INFO - 2015-12-17 09:41:35,821 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: Values: 12120.5 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: Values: 26657.9 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.12 Median:613.12 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: Values: 613.1 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:41:35 INFO - 2015-12-17 09:41:35,822 DEBUG : BROWSER_OUTPUT: 09:41:36 INFO - 2015-12-17 09:41:36,709 INFO : Browser exited with error code: 0 09:41:36 INFO - 2015-12-17 09:41:36,721 INFO : Completed test v8_7 (00:00:40) 09:41:36 INFO - 2015-12-17 09:41:36,853 INFO : Completed test suite (00:20:20) 09:41:36 INFO - 2015-12-17 09:41:36,854 DEBUG : Working with test: dromaeo_css 09:41:36 INFO - 2015-12-17 09:41:36,854 DEBUG : Generating results file: dromaeo_css 09:41:36 INFO - 2015-12-17 09:41:36,855 DEBUG : Working with test: kraken 09:41:36 INFO - 2015-12-17 09:41:36,855 DEBUG : Generating results file: kraken 09:41:36 INFO - 2015-12-17 09:41:36,855 INFO : javascript benchmark 09:41:36 INFO - 2015-12-17 09:41:36,855 DEBUG : Working with test: v8_7 09:41:36 INFO - 2015-12-17 09:41:36,855 DEBUG : Generating results file: v8_7 09:41:36 INFO - 2015-12-17 09:41:36,856 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:36 INFO - 2015-12-17 09:41:36,913 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:41:36 INFO - 2015-12-17 09:41:36,913 DEBUG : process_Request line: dromaeo_css 6210.26 graph.html#tests=[[72,132,35]] 09:41:36 INFO - 2015-12-17 09:41:36,913 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:36 INFO - 2015-12-17 09:41:36,942 DEBUG : process_Request line: kraken 1524.00 graph.html#tests=[[232,132,35]] 09:41:36 INFO - 2015-12-17 09:41:36,942 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:36 INFO - 2015-12-17 09:41:36,982 DEBUG : process_Request line: v8_7 19861.10 graph.html#tests=[[230,132,35]] 09:41:36 INFO - 2015-12-17 09:41:36,983 INFO : javascript benchmark 09:41:37 INFO - 2015-12-17 09:41:36,987 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.1478019643614, 2696.501147287751, 2699.500592390407, 2705.8105932584726, 2747.6565429321336, 4497.887552811173, 4608.055348653526, 4630.62954963603, 4704.129735998838, 4753.786079626417, 4641.25739881619, 4708.034852855165, 4730.9053818923685, 4731.290306454033, 4879.146149423846, 4348.608625223745, 4354.127725078215, 4395.978020109895, 4487.080148569552, 4532.342810292505, 4444.822207111728, 4504.662150338721, 4507.526709695484, 4517.344984977176, 4547.545245475442, 4210.936835947463, 4269.893252668677, 4330.761808100553, 4374.562543745632, 4406.449193850769, 4369.563043695637, 4418.072204836956, 4445.622122119624, 4446.221911165566, 4473.731576105444, 4186.0581369192, 4397.780110994469, 4417.425734654475, 4434.201843668138, 4468.061707041526, 4603.378543896564, 4610.216263235258, 4611.123886461562, 4736.0, 4754.1917873961165, 5140.537351638333, 5141.30592370029, 5145.614078944094, 5146.794128234867, 5177.948220517785, 5149.974250128763, 5162.870928226786, 5163.40620828602, 5163.793448262065, 5201.479852014768, 4608.400907882021, 4716.716996980193, 4724.905501889943, 4725.810967561328, 4768.237082066853, 5170.819021334235, 5313.787448502017, 5325.733713314319, 5326.041312563698, 5328.6802791832615, 4991.4758950310425, 4993.176125939252, 4993.650444468853, 5040.092783298968, 5058.317127187856, 5022.8196373852115, 5092.083424983464, 5097.796088156507, 5101.489851014869, 5146.742662866842, 4709.95290047102, 4828.758562071883, 4842.903141937141, 4879.097366987048, 4990.675606085593, 5069.695818250917, 5075.923861142086, 5103.209002604603, 5104.2343648453025, 5145.61407894402, 4265.637420819203, 4272.957270427318, 4275.03811642378, 4281.807318670667, 4325.048489332342, 3585.408407612767, 3624.5650521937537, 3681.7975011374097, 3700.9074773130887, 3707.1844194277214, 4379.824807007684, 4386.18855511725, 4406.030673251879, 4414.602685758233, 4453.042595841845, 5166.349478383035, 5166.896662066738, 5170.8190213343105, 5176.7152806596, 5181.844544663666, 4115.588441155861, 4216.51510076339, 4220.662347012231, 4278.058827058042, 4348.043430445297, 4492.618127459203, 4493.820247190141, 4497.550244975476, 4503.121891231244, 4557.886052848706, 4825.083234185494, 4830.516948305141, 4839.080574690797, 4849.2968519565175, 4894.094592500399, 4844.176489996779, 4955.306257123933, 4958.45456999737, 4959.330490383896, 5104.183330667224, 4737.170995075779, 4842.15262329098, 4863.683860549053, 4863.805447782049, 4889.608831293559, 5025.924611130909, 5048.3941926969, 5060.342155519759, 5079.822206222764, 5118.38579370478, 4806.951930480651, 4926.211806111005, 5145.382554093533, 5157.329547158845, 5163.6127290454115, 4852.2479015752615, 4873.610111191026, 4951.183054796063, 4954.380702412199, 5000.724960127228, 4942.75286235694, 4959.553640172402, 4961.08219979305, 4963.70217786934, 5006.07387633289, 4668.0, 4801.303810947324, 4852.296417019583, 4873.171560834738, 4921.557059864629, 4852.393450818648, 4870.853874383774, 4876.024795040935, 4931.556159945622, 4961.7271050092595, 4861.732604706775, 4887.971551488268, 4889.657723959289, 4894.070126675921, 4939.53074457926], "unit": "score", "name": "dojo.html", "value": 4656.365625208957}, {"lowerIsBetter": false, "replicates": [540.3111033432373, 543.6493461717192, 548.8847342058168, 556.8667761106148, 567.9318481782187, 27639.585406218925, 28241.293967650818, 36139.0, 36641.0, 36699.63300366996, 40079.198416031664, 40473.59526404735, 40722.59277407225, 40785.59214407855, 40811.38782918259, 7002.08972833531, 7883.448158628884, 8031.9598402007905, 8051.396145289097, 8055.033395992489, 7154.785356439315, 7244.782656520313, 7260.818479538001, 7269.636518174097, 10209.33639313446, 10115.54480048396, 10249.0, 10253.487325633725, 10280.94859525705, 10289.279750417474, 9980.700578982642, 10058.145057670106, 10075.949620251926, 10076.39541627501, 10078.395296282246, 7236.96381518089, 7437.181909989897, 10201.693949181536, 10528.789424211549, 10541.947290263577, 37700.81149594262, 38233.23533529314, 38263.42604860929, 38278.23443531142, 38313.42529862055, 2797.622320986661, 2829.9292517687018, 2874.195225336909, 2888.8844446222124, 2895.5946167536563, 28532.794451513193, 29015.564766528518, 29066.41867162666, 29082.85458572715, 29699.10902672923, 3452.8446219920165, 3467.09855437588, 3493.5633045869267, 3526.523919270917, 3613.295407395559, 223496.0, 224478.0, 224738.0, 224780.0, 225522.0, 43645.56354436415, 56405.0, 56728.0, 56782.148267776014, 56812.715936420056, 43321.56678433238, 59230.40769592335, 61806.0, 61828.69085654543, 61914.0, 12997.740045199043, 13168.407421666048, 13280.933595331962, 13281.734365312639, 13318.400671969785, 9947.20422366209, 9947.701568952943, 10001.299909006446, 10009.599616015277, 10019.899801001897, 19347.129379177688, 19486.415407537796, 19573.90213048954, 19596.314129005415, 19615.803841961682, 6951.131108611424, 7145.642717864086, 7152.356287934111, 7190.496665233383, 7235.529690570096, 886.1006078829993, 914.5564401265381, 932.69687351611, 955.0831202046113, 984.9359791613665, 25865.35336616562, 26439.0, 27487.17538473849, 27487.86256068707, 27495.862520687268, 932.4684929590204, 951.509972364233, 969.95150242489, 980.9558569864373, 1060.490964337107, 12571.622851314476, 12747.107702460924, 14145.504907328193, 14738.263086845614, 15028.09831410119, 272870.0, 274867.0, 274977.0, 275992.0, 276166.0, 46740.53259467362, 47347.289790653165, 47351.0, 47455.5254447458, 47605.523944760804, 1234.154604096197, 1239.367922359585, 1242.5588915934893, 1253.4923356040817, 1261.1046157228286, 26718.0, 27217.31956701098, 27583.586246205923, 27745.0, 27916.44167116687, 36435.45346819853, 36989.26021479609, 37327.81336093302, 41736.58263417327, 42600.36099458449, 165577.0, 167248.0, 168847.0, 169087.0, 169521.0, 25463.490730185662, 25583.0, 25588.872055639604, 25689.357766055997, 25998.480030399664, 30111.397772044875, 30504.734853212347, 32819.69259577076, 36238.0, 37963.43054854235, 28282.85858570694, 28881.42237155287, 29003.854980725806, 29412.970546030785, 29549.409011820073, 28779.424411511234, 28976.855115724287, 29099.272518187216, 29159.271018224714, 29164.416711665224, 28925.7107428923, 29582.260443488223, 29622.703772962857, 29652.406951860412, 32282.0, 26375.472490550466, 28714.99497517577, 29619.85190074036, 30634.234144145685, 30650.0, 21153.25963591267, 21322.573548529253, 21393.465163371042, 23382.76617233806, 23924.0], "unit": "score", "name": "ext.html", "value": 16614.15906421831}, {"lowerIsBetter": false, "replicates": [313.4921427287794, 321.7667191286318, 322.51622566150786, 325.219473264166, 332.0519915640847, 14966.700665986673, 15207.391704331827, 15359.462418815343, 15780.605484862885, 15792.0, 14892.404303827834, 14949.85050149501, 14957.850421495781, 14962.551123466286, 15148.1668508232, 4917.7541122943885, 5049.545540901318, 5078.289039534468, 5079.4412614612365, 5082.0, 4246.68149888758, 5024.397072351323, 5056.747162641853, 5063.139266324733, 5065.138926382506, 3702.1670124222105, 3814.408766641175, 3816.923661526768, 5756.107803290497, 5760.0783874580075, 3793.279276937387, 3800.6389393007757, 3803.619638036202, 5525.668459892379, 5726.5418766499, 4790.664653474259, 4899.873029203303, 4984.327115839352, 4986.252062190701, 5085.669431486942, 19144.904275478533, 19363.83816970972, 19401.32095376655, 19485.512862178417, 19665.0, 1535.8617724404746, 1815.6277963017683, 1881.5578339090303, 1923.1249781349452, 2010.1657812008145, 11806.232594881305, 11842.0, 12002.879971200264, 12074.335911524862, 12113.0, 1664.1429663723193, 1703.7359209322574, 1744.5376975101608, 1767.690654135521, 1788.8658350623755, 52287.73856130695, 54746.452535474535, 55953.44046559523, 56179.15731263993, 56593.71703141499, 8715.738527844174, 8921.349550333209, 9354.20489258407, 9374.859377109213, 9424.057594240658, 11738.295702257721, 11745.412729363497, 11821.113416493798, 11842.28946263227, 11847.407629618485, 6652.833679157963, 6682.665866706645, 6725.0, 6730.562513436611, 6818.761343352959, 6327.588706734047, 6330.240371155491, 6360.936390636034, 6399.13611662429, 6406.167198264196, 5579.637323574036, 5638.887222255532, 5652.293463317085, 5659.801906933238, 5692.7722891083895, 1567.9451219207274, 1591.2282542966652, 1593.689230600045, 1604.133767765417, 1619.0852168524746, 877.5699907045502, 924.7179610218814, 938.0525669074284, 945.924326053914, 974.1378879691524, 16152.273147708382, 16230.269637866324, 16242.0, 16388.75416868748, 16628.83371166297, 683.2859661653584, 845.8012367093728, 871.5642178910545, 906.5693795447241, 933.0576118120612, 8500.574971251413, 8546.401751877309, 8585.914140858511, 8694.000189978233, 8725.650973961097, 453491.0, 456954.0, 461936.0, 462359.0, 466308.0, 62572.0, 64943.0, 65119.674401627686, 66362.33637663658, 66861.0, 1046.3669479964665, 1050.3487837540774, 1057.0222544146786, 1069.8395240713955, 1070.673444599389, 13800.309984500534, 13967.790483142559, 14291.28543572838, 14405.7839132411, 14506.34721437559, 30069.849650751607, 30180.396392072475, 30418.239544011576, 30733.231669207555, 31594.36811263716, 40710.79644601758, 41268.587314126475, 41586.79206604069, 42466.36300455434, 42957.0, 8340.624671889658, 8747.693830716149, 8819.29445644334, 9082.818343633222, 9113.134252246025, 7845.3723702104835, 15556.688866222386, 15717.449889253821, 16131.516054518383, 16261.51215463538, 13370.799438008244, 13428.127171733806, 13592.0, 13834.515791947233, 13871.306434678025, 13185.80221296662, 13245.602631921058, 13265.66835829112, 13488.0, 13512.93243533776, 13484.932575337452, 14001.369938352595, 14031.508897188549, 14169.291535423394, 14241.430342786172, 8704.738857834274, 8714.346424018097, 8892.86660700103, 8924.821503570021, 8952.507612081397, 11264.887351126712, 13154.408051637507, 13263.668408289484, 13875.653108672364, 14559.0], "unit": "score", "name": "jquery.html", "value": 8195.022608570313}, {"lowerIsBetter": false, "replicates": [1438.971220575588, 1631.420845599812, 1677.6476939842632, 1710.1021963469177, 1718.2182107141248, 5959.702014899254, 6751.932480675198, 6900.206476255232, 6904.723811047558, 6911.377975982161, 6788.355106264897, 6998.230194678594, 6998.54509456885, 7006.544574602647, 7017.333353331425, 1750.2998800479781, 1777.3334999375234, 2022.6460369435363, 2049.928252511166, 2082.7708952015264, 2082.208760670943, 2087.530305681217, 2087.6242276390244, 2088.4048046306807, 2089.550746589483, 1966.665666836634, 1970.5763260898905, 2021.7877122902105, 2022.4539374368912, 2031.2585906144225, 2025.686018667109, 2033.400146956644, 2062.3194345865827, 2068.7827778083233, 2069.5447001659686, 2109.219588752156, 2132.818710409617, 2137.861039032458, 2138.390558690766, 2139.4865232344127, 6988.266232045613, 7062.6821793019435, 7087.043249161349, 7089.645517724145, 7091.18451378093, 4059.533153687334, 4139.8965025874295, 4166.229247589175, 4171.270027745163, 4178.143480586503, 2586.056089527328, 2658.667666541682, 2670.092168662645, 2673.2247648182006, 2679.6650418697664, 884.8495755721543, 898.1153563739712, 904.159132007233, 920.4431319052011, 924.533110779059, 9556.0, 9646.9517652412, 9686.515674216262, 9704.12662860339, 9714.319997600242, 3715.1826598148364, 3721.9441708374397, 3751.681107105872, 3767.095896984704, 3789.147441825567, 8438.324934005388, 8444.915550844536, 8454.943132108487, 8472.068072512018, 8496.490210587384, 4127.669786417079, 4145.626893579592, 4160.750354978711, 4177.770222637723, 4186.079062606222, 3859.6912247020173, 3862.6909847212155, 3867.9613203867602, 3870.2646497165447, 3871.05159235989, 3013.608230930009, 3065.969340306613, 3330.5670262865674, 3372.224388390684, 3411.113110591264, 1107.4352080438873, 1123.1183520936027, 1134.9432528373547, 1151.0388825330774, 1155.064397837754, 853.3216093205916, 856.6188046319328, 856.8671855862351, 858.0861382627606, 954.1394281151781, 6612.07430959666, 6781.830454238683, 6797.524173307821, 6801.387875091265, 6805.285445028201, 523.4033202149552, 527.4567195788344, 539.3016044222662, 573.9024365857814, 719.802054435024, 5407.297051383295, 5488.615796894179, 5502.422245664227, 5521.061419558685, 5532.114861622121, 8211.8357632847, 8758.56207189638, 8779.03430622631, 8780.165884240987, 8789.780255493535, 8651.178138076873, 8654.567271636393, 8677.609507572175, 8681.262092722063, 8685.609147588373, 6657.700403481855, 6763.425108865801, 6888.104546409035, 6894.793156205322, 6896.3103689631635, 6477.902831457438, 6497.935020649733, 6498.350164983463, 6500.739970401131, 6501.609903405811, 7599.050118735158, 7741.187175346733, 7825.960870195612, 7840.882386764089, 7848.450608457581, 7789.883151752615, 7942.166072562529, 8082.555459449787, 8101.675932962616, 8105.554194519123, 5877.471027607536, 6150.815475535741, 6167.629942203482, 6190.380961903774, 6209.844753881189, 6187.412195841388, 6296.338884417253, 6611.735530578723, 6742.0, 6754.696038678173, 5281.630285879952, 5814.0, 6586.47308215332, 6709.865802683821, 6762.526623136333, 6512.413882750575, 6532.902006470002, 6547.279799221987, 6633.834154146185, 6657.06801047844, 6583.670816459254, 6618.437432818265, 6619.2056953164, 6621.801345959629, 6633.568818026813, 6062.636241825505, 6067.120267561268, 6070.78752243687, 6083.6349819011, 6103.908441373294, 6078.057901025348, 6138.109974053827, 6140.385961404003, 6143.96928015357, 6180.072989051679], "unit": "score", "name": "mootools.html", "value": 4014.77695570768}, {"lowerIsBetter": false, "replicates": [299.7422216893471, 301.5070359961463, 309.9752019838413, 310.75139888089535, 311.78331059913353, 5147.253648221011, 5248.47515248475, 5276.419593844679, 5304.867378315535, 5317.042932272189, 4949.802007919688, 5062.822801201959, 5130.07658621448, 5203.661761985469, 5230.816921407752, 4096.672266218696, 4117.773522456264, 4127.092039751257, 4129.814158362866, 4131.173765246947, 3860.1700634363606, 4130.401091841682, 4136.172765446908, 4137.4207610934345, 4138.7516748995, 3878.4764056852387, 3938.369860822269, 4054.6350828425434, 4091.1408604193007, 4105.2815757242515, 4056.9188616227807, 4061.8578349757618, 4088.550259471456, 4101.487314085739, 4109.6712263019035, 3613.9096522586883, 3617.819109044537, 3625.87597844669, 3626.839411388357, 3631.527901372831, 5065.366829146356, 5071.518205770446, 5071.87320316995, 5073.923891141636, 5077.0, 4613.192691279013, 4698.4361876574685, 4721.079389519045, 4724.889650932028, 4732.739699316537, 5521.806736764234, 5528.143137813645, 5533.03171944908, 5533.478293469288, 5536.141898005815, 3950.9727470857497, 3955.5846636103083, 3956.109875278068, 3958.7228893977435, 3959.4060890866313, 5797.333306669745, 5802.97098514509, 5804.62269952456, 5811.941880581182, 5814.098814683731, 3978.0, 4057.5739547347102, 4075.1645912587846, 4083.0404854859084, 4095.7133000689664, 4127.5666055064385, 4132.669386449077, 4139.151473947833, 4140.0891803803115, 4142.834286628501, 4640.074369136771, 4672.462666793363, 4673.626109911199, 4677.883052923704, 4688.249880019181, 5458.099413596791, 5471.616986810965, 5479.150731636602, 5501.614886957875, 5518.751656175482, 1367.0703921333588, 1418.184543887269, 1435.4832260386252, 1442.4158215922569, 1445.38571107279, 939.5959737312884, 940.7883226274033, 943.4056544376998, 945.4941606240766, 950.9904900951041, 4761.595264402496, 4763.309320148628, 4769.523047695203, 4775.474697783241, 4775.95224047762, 5582.8325150245555, 5602.0196465619165, 5602.2717046783655, 5604.299462567179, 5604.719764011865, 4699.765011749399, 4759.428868535798, 4770.260609605447, 4770.809167633325, 4831.0, 3058.648255450607, 3078.707522785332, 3095.0, 3095.0250671038552, 3097.1637657832257, 5449.509544141047, 5470.124780035176, 5471.343438787371, 5472.480114389126, 5481.177823326533, 5922.9930911745105, 5925.140854576062, 5932.673702946379, 5934.258217722785, 5934.6142500737315, 5311.707856067954, 5486.039943009957, 5493.972530137404, 5496.5053145217125, 5500.862478438071, 5770.365259821332, 5777.480026797609, 5786.566007549535, 5787.739551720267, 5789.131630255495, 5653.915191272216, 5658.17956396312, 5664.0, 5666.263385759989, 5673.886522269614, 5342.839714808562, 5485.807996720096, 5486.753096110605, 5492.945070549244, 5499.917501237404, 3919.1377896862646, 3952.288588054178, 3956.9604303957744, 3957.050307926135, 3961.425593288899, 5764.971175144097, 5768.884622307614, 5771.971140144273, 5772.191893135048, 5773.595848290579, 5541.9168712470155, 5551.084071128219, 5555.361133469541, 5556.138798486241, 5558.360788509373, 5412.648177868584, 5537.723113844372, 5544.168374743659, 5546.722663866871, 5547.944520554743, 5415.891682166256, 5429.429909859566, 5431.56547476193, 5436.0486914790545, 5438.075527160471, 5567.109262517978, 5578.693171875586, 5579.218909352613, 5579.525740312119, 5590.86022849432, 5301.5493683037375, 5446.373667028342, 5448.618596698193, 5452.672839629635, 5461.262729531462], "unit": "score", "name": "prototype.html", "value": 4167.006130906522}, {"lowerIsBetter": false, "replicates": [686.8866637004894, 720.0926832191441, 722.6350692900088, 732.4177279063144, 739.4010851210518, 10793.0, 10999.670009899706, 10999.725006874833, 11002.724931876706, 11010.944945275272, 10981.890181098186, 11009.394483303415, 11073.833892491599, 11098.500567474463, 11099.944500277508, 622.9781957631484, 631.1447987976295, 631.8167731357901, 788.9723859664898, 806.3267171911461, 627.5199472403615, 636.1062706896818, 783.3889566138421, 798.7683571764181, 805.2913436176186, 837.736113124367, 839.0476808822001, 843.2705709561216, 846.0059430169526, 846.1834329871704, 647.9967600162016, 832.6919039955225, 834.0616806093145, 834.1866679987024, 834.3492076180559, 486.6180048661819, 616.7687117331001, 624.8750249949983, 627.1815281058217, 628.5505863307757, 10510.527026283835, 10701.518431670593, 10705.0, 10724.946375268073, 10741.140708743282, 9978.351407158583, 11058.22592418531, 11112.888871111347, 11264.718382040433, 11280.43597820114, 8938.687145949925, 9681.854772178423, 9701.320907536476, 9881.357711748786, 10125.898741012643, 3082.5647738286725, 3151.8896838610767, 3167.524871269305, 3172.4289627866974, 3193.3294008258295, 38670.61329386698, 39023.609763902285, 39176.41235381472, 39267.8036609818, 39298.214035719415, 8768.298536117096, 8780.78048048791, 8900.643974240958, 8951.239144672776, 8966.551672416354, 15423.383064677511, 15531.767023494656, 15592.298346574431, 15747.606309842116, 15754.606134846721, 6020.969895150583, 6082.817515474543, 6091.604045737102, 6127.050307202391, 6166.044263139221, 3359.6591447686883, 3382.8139452330356, 3391.745619078579, 3436.9484457733156, 3449.6377880322207, 2427.5994460914103, 2459.360566252787, 2461.74151714071, 2462.667539882129, 2463.1625247415604, 449.9775011249424, 450.3762289229441, 460.17628445083596, 463.49710564037724, 464.53314419009354, 416.66250337226944, 452.7147896824979, 492.33534728116757, 547.5099785691783, 552.2296396526823, 6417.422431981051, 6498.285188629247, 6796.76211332601, 7135.857282854314, 7787.5716835574585, 515.8504033830222, 532.8321578702696, 555.5361273336729, 556.1352097488444, 563.7209581257304, 3353.9496907546404, 3464.6188919218866, 3602.47764074213, 3615.060084378081, 3636.61815509373, 44098.7795061029, 45190.32214516785, 45271.32093018608, 45564.088718226114, 45586.772066139456, 41286.0, 41382.79308603498, 41872.79063604723, 42513.574864250964, 42713.145737085084, 37356.43965340522, 37792.0, 38039.23921521554, 38513.422298665544, 39318.2136357277, 7282.4902256841515, 7298.708051677873, 7344.70621175147, 7356.006939063158, 7464.440166987389, 29766.553501697927, 30357.392852143275, 30587.54118688177, 30761.384772304875, 30854.84572577123, 34716.30567388688, 35085.0, 35481.82259088688, 37521.0, 37966.8101659501, 9376.0, 9565.378250413702, 9681.273904457054, 9737.561809718722, 9777.657781977596, 10676.519556619816, 10737.731556711145, 10800.45997700096, 11246.437678116225, 11300.265482743924, 9800.509974501103, 9923.305368624417, 9973.202143828332, 10463.319884207502, 10468.424236667057, 9576.521173941135, 9875.259355548505, 9877.111060004634, 10055.39667619916, 10173.186145108522, 9833.60665573369, 10404.635837745642, 10449.895501044892, 10511.474426278503, 10517.368957862553, 8442.831143377221, 8563.229309362187, 8647.740567782977, 8874.822503550022, 8965.0, 7867.606619668879, 7957.403194760532, 7987.48081374732, 8748.08145144776, 8923.330750193632], "unit": "score", "name": "yui.html", "value": 5408.195946098454}], "name": "dromaeo_css", "value": 6210.260898529071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 112.0, 113.0, 113.0, 102.0, 113.0, 113.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [177.0, 128.0, 148.0, 163.0, 130.0, 160.0, 150.0, 131.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 159.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 91.0, 70.0, 70.0, 71.0, 101.0, 88.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 128.0, 94.0, 95.0, 96.0, 131.0, 94.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 72.0, 72.0, 82.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 81.0, 83.0, 84.0, 84.0, 83.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [125.0, 129.0, 116.0, 120.0, 129.0, 129.0, 128.0, 123.0, 127.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 151.0, 146.0, 151.0, 137.0, 154.0, 158.0, 149.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 72.0, 70.0, 69.0, 69.0, 69.0, 69.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1523.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [185.35681186283597], "unit": "score", "name": "DeltaBlue", "value": 356.7066099999999}, {"lowerIsBetter": false, "replicates": [277.1618625277162], "unit": "score", "name": "Encrypt", "value": 960.3810479999997}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [613.1207847946046], "unit": "score", "name": "Splay", "value": 132.91182099999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19861.101035690244}]} 09:41:37 INFO - RETURN: dromaeo_css: 6210.26 09:41:37 INFO - RETURN: kraken: 1524.00 09:41:37 INFO - RETURN: v8_7: 19861.10 09:41:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19861.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6210.26"}}} 09:41:37 INFO - Return code: 0 09:41:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:41:37 INFO - # TBPL SUCCESS # 09:41:37 INFO - Running post-action listener: _resource_record_post_action 09:41:37 INFO - Running post-run listener: _resource_record_post_run 09:41:38 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 12288; Write bytes: 555560960; Read time: 352; Write time: 729968 09:41:38 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 4096; Write bytes: 236023808; Read time: 156; Write time: 445960 09:41:38 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 315338752; Read time: 196; Write time: 283164 09:41:38 INFO - Running post-run listener: _upload_blobber_files 09:41:38 INFO - Blob upload gear active. 09:41:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:41:38 INFO - Copying logs to upload dir... 09:41:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.317524 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 09:41:37.718455) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:41:37.721938) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009979 build_url: 'https://queue.taskcluster.net/v1/task/E-xBxCxAR2yXPnbI9c9yYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:41:37.773696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:41:37.774013) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450371793.495583-1995148096 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:41:37.823295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 09:41:37.823616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 09:41:37.823912) ========= ========= Total master_lag: 0.28 =========