builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1450403013.28 results: success (0) buildid: 20151217170055 builduid: 768dda47749b4f908b79ab54e5c16d8b revision: e4aca954089ddf8bf8c33f7b13cec453c5dd259f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.281297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.281787) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.282103) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006371 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.312478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.312812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.371176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.371465) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.433865) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.434156) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.434568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.434876) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 17:43:33-- 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% 223M=0s 2015-12-17 17:43:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.639030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.639348) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016733 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.698729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:43:33.699074) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4aca954089ddf8bf8c33f7b13cec453c5dd259f --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 e4aca954089ddf8bf8c33f7b13cec453c5dd259f --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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 17:43:34,063 truncating revision to first 12 chars 2015-12-17 17:43:34,063 Setting DEBUG logging. 2015-12-17 17:43:34,063 attempt 1/10 2015-12-17 17:43:34,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4aca954089d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 17:43:34,975 unpacking tar archive at: fx-team-e4aca954089d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.187213 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:43:34.905472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:34.905783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:34.913615) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:34.913907) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:34.914327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-17 17:43:34.914612) ========= /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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:35 INFO - MultiFileLogger online at 20151217 17:43:35 in /builds/slave/test 17:43:35 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 17:43:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:35 INFO - {'append_to_log': False, 17:43:35 INFO - 'base_work_dir': '/builds/slave/test', 17:43:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:43:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:35 INFO - 'branch': 'Fx-Team-Non-PGO', 17:43:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:35 INFO - 'config_files': ('talos/linux_config.py',), 17:43:35 INFO - 'default_actions': ('clobber', 17:43:35 INFO - 'read-buildbot-config', 17:43:35 INFO - 'download-and-extract', 17:43:35 INFO - 'populate-webroot', 17:43:35 INFO - 'create-virtualenv', 17:43:35 INFO - 'install', 17:43:35 INFO - 'run-tests'), 17:43:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:35 INFO - 'download_minidump_stackwalk': True, 17:43:35 INFO - 'download_symbols': 'ondemand', 17:43:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:35 INFO - 'installer_path': 'installer.exe', 17:43:35 INFO - 'log_level': 'info', 17:43:35 INFO - 'log_name': 'talos', 17:43:35 INFO - 'log_to_console': True, 17:43:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:35 INFO - 'opt_config_files': (), 17:43:35 INFO - 'pip_index': False, 17:43:35 INFO - 'sps_profile': False, 17:43:35 INFO - 'sps_profile_interval': 0, 17:43:35 INFO - 'suite': 'dromaeojs', 17:43:35 INFO - 'system_bits': '64', 17:43:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:35 INFO - 'title': 'talos-linux64-ix-055', 17:43:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:35 INFO - 'use_talos_json': True, 17:43:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:35 INFO - 'work_dir': 'build'} 17:43:35 INFO - ##### 17:43:35 INFO - ##### Running clobber step. 17:43:35 INFO - ##### 17:43:35 INFO - Running pre-action listener: _resource_record_pre_action 17:43:35 INFO - Running main action method: clobber 17:43:35 INFO - rmtree: /builds/slave/test/build 17:43:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:36 INFO - Running post-action listener: _resource_record_post_action 17:43:36 INFO - ##### 17:43:36 INFO - ##### Running read-buildbot-config step. 17:43:36 INFO - ##### 17:43:36 INFO - Running pre-action listener: _resource_record_pre_action 17:43:36 INFO - Running main action method: read_buildbot_config 17:43:36 INFO - Using buildbot properties: 17:43:36 INFO - { 17:43:36 INFO - "project": "", 17:43:36 INFO - "product": "firefox", 17:43:36 INFO - "script_repo_revision": "production", 17:43:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:43:36 INFO - "repository": "", 17:43:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:43:36 INFO - "buildid": "20151217170055", 17:43:36 INFO - "pgo_build": "False", 17:43:36 INFO - "basedir": "/builds/slave/test", 17:43:36 INFO - "buildnumber": 1027, 17:43:36 INFO - "slavename": "talos-linux64-ix-055", 17:43:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:43:36 INFO - "platform": "ubuntu64_hw", 17:43:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:43:36 INFO - "branch": "fx-team", 17:43:36 INFO - "repo_path": "integration/fx-team", 17:43:36 INFO - "revision": "e4aca954089ddf8bf8c33f7b13cec453c5dd259f", 17:43:36 INFO - "stage_platform": "linux64", 17:43:36 INFO - "builduid": "768dda47749b4f908b79ab54e5c16d8b", 17:43:36 INFO - "slavebuilddir": "test" 17:43:36 INFO - } 17:43:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:43:36 INFO - Running post-action listener: _resource_record_post_action 17:43:36 INFO - ##### 17:43:36 INFO - ##### Running download-and-extract step. 17:43:36 INFO - ##### 17:43:36 INFO - Running pre-action listener: _resource_record_pre_action 17:43:36 INFO - Running main action method: download_and_extract 17:43:36 INFO - mkdir: /builds/slave/test/build/tests 17:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:36 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json 17:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json 17:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:43:41 INFO - Downloaded 1302 bytes. 17:43:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:43:41 INFO - Using the following test package requirements: 17:43:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:43:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'jsshell-linux-x86_64.zip'], 17:43:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:43:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:43:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:43:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:43:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:43:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:41 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:43 INFO - Downloaded 21870957 bytes. 17:43:43 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 17:43:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:43 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 17:43:44 INFO - Return code: 0 17:43:44 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 17:43: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')]} 17:43:44 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:46 INFO - Downloaded 21870957 bytes. 17:43:46 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 17:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:46 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 17:43:48 INFO - Return code: 0 17:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:48 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:49 INFO - Downloaded 11132039 bytes. 17:43:49 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 17:43:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:49 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 17:43:49 INFO - Return code: 0 17:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:49 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 17:43:50 INFO - Downloaded 53019173 bytes. 17:43:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:50 INFO - mkdir: /builds/slave/test/properties 17:43:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:50 INFO - Contents: 17:43:50 INFO - build_url:https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:50 INFO - Running post-action listener: _resource_record_post_action 17:43:50 INFO - Running post-action listener: set_extra_try_arguments 17:43:50 INFO - ##### 17:43:50 INFO - ##### Running populate-webroot step. 17:43:50 INFO - ##### 17:43:50 INFO - Running pre-action listener: _resource_record_pre_action 17:43:50 INFO - Running main action method: populate_webroot 17:43:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:50 INFO - '--tppagecycles', 17:43:50 INFO - '7'], 17:43:50 INFO - 'tests': ['tsvgm']}}, 17:43:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:43:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:43:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:43:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'tests': ['damp', 'tps']}, 17:43:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['damp', 'tps']}, 17:43:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:43:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:50 INFO - 'other': {'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'other_l64': {'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'other_nol64': {'tests': ['a11yr', 17:43:50 INFO - 'ts_paint', 17:43:50 INFO - 'tpaint', 17:43:50 INFO - 'sessionrestore', 17:43:50 INFO - 'sessionrestore_no_auto_restore']}, 17:43:50 INFO - 'svgr': {'tests': ['tsvgx', 17:43:50 INFO - 'tsvgr_opacity', 17:43:50 INFO - 'tart', 17:43:50 INFO - 'tscrollx', 17:43:50 INFO - 'cart']}, 17:43:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['tsvgx', 17:43:50 INFO - 'tsvgr_opacity', 17:43:50 INFO - 'tart', 17:43:50 INFO - 'tscrollx', 17:43:50 INFO - 'cart']}, 17:43:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'tests': ['tp5o']}, 17:43:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'talos_options': ['--e10s'], 17:43:50 INFO - 'tests': ['tp5o']}, 17:43:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'talos_options': ['--xperf_path', 17:43:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:50 INFO - 'tests': ['tp5n']}, 17:43:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:50 INFO - 'talos_options': ['--e10s', 17:43:50 INFO - '--xperf_path', 17:43:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:50 INFO - 'tests': ['tp5n']}}, 17:43:50 INFO - 'talos.zip': {'path': '', 17:43:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:50 INFO - Running post-action listener: _resource_record_post_action 17:43:50 INFO - ##### 17:43:50 INFO - ##### Running create-virtualenv step. 17:43:50 INFO - ##### 17:43:50 INFO - Running pre-action listener: _resource_record_pre_action 17:43:50 INFO - Running main action method: create_virtualenv 17:43:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:50 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 17:43:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:50 INFO - Using real prefix '/usr' 17:43:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:53 INFO - Installing pip.................done. 17:43:53 INFO - Return code: 0 17:43:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:43:53 INFO - Using env: {'DISPLAY': ':0', 17:43:53 INFO - 'HOME': '/home/cltbld', 17:43:53 INFO - 'LANG': 'en_US.UTF-8', 17:43:53 INFO - 'LANGUAGE': 'en_US:en', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MAIL': '/var/mail/cltbld', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SHLVL': '1', 17:43:53 INFO - 'TERM': 'linux', 17:43:53 INFO - 'TMOUT': '86400', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 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 17:43:53 INFO - Cleaning up... 17:43:53 INFO - Return code: 0 17:43:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:43:53 INFO - Using env: {'DISPLAY': ':0', 17:43:53 INFO - 'HOME': '/home/cltbld', 17:43:53 INFO - 'LANG': 'en_US.UTF-8', 17:43:53 INFO - 'LANGUAGE': 'en_US:en', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MAIL': '/var/mail/cltbld', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SHLVL': '1', 17:43:53 INFO - 'TERM': 'linux', 17:43:53 INFO - 'TMOUT': '86400', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 INFO - Downloading/unpacking psutil>=0.7.1 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:43:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:55 INFO - Installing collected packages: psutil 17:43:55 INFO - Running setup.py install for psutil 17:43:55 INFO - building 'psutil._psutil_linux' extension 17:43:55 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 17:43:55 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 17:43:55 INFO - building 'psutil._psutil_posix' extension 17:43:55 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 17:43:55 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 17:43:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:56 INFO - Successfully installed psutil 17:43:56 INFO - Cleaning up... 17:43:56 INFO - Return code: 0 17:43:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:56 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:43:56 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 17:43:56 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 17:43:56 INFO - Using env: {'DISPLAY': ':0', 17:43:56 INFO - 'HOME': '/home/cltbld', 17:43:56 INFO - 'LANG': 'en_US.UTF-8', 17:43:56 INFO - 'LANGUAGE': 'en_US:en', 17:43:56 INFO - 'LOGNAME': 'cltbld', 17:43:56 INFO - 'MAIL': '/var/mail/cltbld', 17:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:56 INFO - 'MOZ_NO_REMOTE': '1', 17:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:56 INFO - 'NO_EM_RESTART': '1', 17:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:56 INFO - 'PWD': '/builds/slave/test', 17:43:56 INFO - 'SHELL': '/bin/bash', 17:43:56 INFO - 'SHLVL': '1', 17:43:56 INFO - 'TERM': 'linux', 17:43:56 INFO - 'TMOUT': '86400', 17:43:56 INFO - 'USER': 'cltbld', 17:43:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:56 INFO - '_': '/tools/buildbot/bin/python'} 17:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:43:58 INFO - Installing collected packages: mozsystemmonitor 17:43:58 INFO - Running setup.py install for mozsystemmonitor 17:43:58 INFO - Successfully installed mozsystemmonitor 17:43:58 INFO - Cleaning up... 17:43:58 INFO - Return code: 0 17:43:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:58 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')]} 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 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')]} 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:43:58 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 17:43:58 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 17:43:58 INFO - Using env: {'DISPLAY': ':0', 17:43:58 INFO - 'HOME': '/home/cltbld', 17:43:58 INFO - 'LANG': 'en_US.UTF-8', 17:43:58 INFO - 'LANGUAGE': 'en_US:en', 17:43:58 INFO - 'LOGNAME': 'cltbld', 17:43:58 INFO - 'MAIL': '/var/mail/cltbld', 17:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:58 INFO - 'MOZ_NO_REMOTE': '1', 17:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:58 INFO - 'NO_EM_RESTART': '1', 17:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:58 INFO - 'PWD': '/builds/slave/test', 17:43:58 INFO - 'SHELL': '/bin/bash', 17:43:58 INFO - 'SHLVL': '1', 17:43:58 INFO - 'TERM': 'linux', 17:43:58 INFO - 'TMOUT': '86400', 17:43:58 INFO - 'USER': 'cltbld', 17:43:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:58 INFO - '_': '/tools/buildbot/bin/python'} 17:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:44:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - Downloading docopt-0.6.1.tar.gz 17:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:00 INFO - Running setup.py install for blobuploader 17:44:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:00 INFO - Running setup.py install for requests 17:44:01 INFO - Running setup.py install for docopt 17:44:01 INFO - Successfully installed blobuploader requests docopt 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:01 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')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 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')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:44:01 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 17:44:01 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 17:44:01 INFO - Using env: {'DISPLAY': ':0', 17:44:01 INFO - 'HOME': '/home/cltbld', 17:44:01 INFO - 'LANG': 'en_US.UTF-8', 17:44:01 INFO - 'LANGUAGE': 'en_US:en', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MAIL': '/var/mail/cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SHLVL': '1', 17:44:01 INFO - 'TERM': 'linux', 17:44:01 INFO - 'TMOUT': '86400', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - '_': '/tools/buildbot/bin/python'} 17:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:01 INFO - Running setup.py (path:/tmp/pip-mGjCK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:01 INFO - Running setup.py (path:/tmp/pip-UbzJ8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:01 INFO - Running setup.py (path:/tmp/pip-HIMCos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:01 INFO - Running setup.py (path:/tmp/pip-LoHf0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:01 INFO - Running setup.py (path:/tmp/pip-39SsUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:01 INFO - Running setup.py (path:/tmp/pip-8ovR2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:02 INFO - Running setup.py (path:/tmp/pip-EgBdLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:02 INFO - Running setup.py (path:/tmp/pip-xBs_kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:02 INFO - Running setup.py (path:/tmp/pip-U4Ioea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:02 INFO - Running setup.py (path:/tmp/pip-EHdmir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:02 INFO - Running setup.py (path:/tmp/pip-SVcOVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:02 INFO - Running setup.py (path:/tmp/pip-PMhXXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:02 INFO - Running setup.py (path:/tmp/pip-aEzb16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:02 INFO - Running setup.py (path:/tmp/pip-0fZ_gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:02 INFO - Running setup.py (path:/tmp/pip-C_Umk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:02 INFO - Running setup.py (path:/tmp/pip-_cxf8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:02 INFO - Running setup.py (path:/tmp/pip-SGSqK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:02 INFO - Running setup.py install for manifestparser 17:44:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:02 INFO - Running setup.py install for mozcrash 17:44:03 INFO - Running setup.py install for mozdebug 17:44:03 INFO - Running setup.py install for mozdevice 17:44:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for mozfile 17:44:03 INFO - Running setup.py install for mozhttpd 17:44:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for mozinfo 17:44:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for mozInstall 17:44:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for mozleak 17:44:03 INFO - Running setup.py install for mozlog 17:44:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for moznetwork 17:44:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:03 INFO - Running setup.py install for mozprocess 17:44:04 INFO - Running setup.py install for mozprofile 17:44:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Running setup.py install for mozrunner 17:44:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Running setup.py install for mozscreenshot 17:44:04 INFO - Running setup.py install for moztest 17:44:04 INFO - Running setup.py install for mozversion 17:44:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:04 INFO - Cleaning up... 17:44:04 INFO - Return code: 0 17:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 17:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 17:44:04 INFO - Using env: {'DISPLAY': ':0', 17:44:04 INFO - 'HOME': '/home/cltbld', 17:44:04 INFO - 'LANG': 'en_US.UTF-8', 17:44:04 INFO - 'LANGUAGE': 'en_US:en', 17:44:04 INFO - 'LOGNAME': 'cltbld', 17:44:04 INFO - 'MAIL': '/var/mail/cltbld', 17:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:04 INFO - 'MOZ_NO_REMOTE': '1', 17:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:04 INFO - 'NO_EM_RESTART': '1', 17:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:04 INFO - 'PWD': '/builds/slave/test', 17:44:04 INFO - 'SHELL': '/bin/bash', 17:44:04 INFO - 'SHLVL': '1', 17:44:04 INFO - 'TERM': 'linux', 17:44:04 INFO - 'TMOUT': '86400', 17:44:04 INFO - 'USER': 'cltbld', 17:44:04 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:04 INFO - '_': '/tools/buildbot/bin/python'} 17:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:04 INFO - Running setup.py (path:/tmp/pip-S_9MI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:04 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)) 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 INFO - Running setup.py (path:/tmp/pip-0QCXwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 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)) 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:04 INFO - Running setup.py (path:/tmp/pip-n1j9fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:05 INFO - Running setup.py (path:/tmp/pip-vw8Yb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:05 INFO - Running setup.py (path:/tmp/pip-NfEmpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:05 INFO - Running setup.py (path:/tmp/pip-tbVtvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:05 INFO - Running setup.py (path:/tmp/pip-lkbdZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:05 INFO - Running setup.py (path:/tmp/pip-hJeND9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:05 INFO - Running setup.py (path:/tmp/pip-znqFQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:05 INFO - Running setup.py (path:/tmp/pip-FKrzrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:05 INFO - Running setup.py (path:/tmp/pip-OQ_P8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 INFO - Running setup.py (path:/tmp/pip-NKAD26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 INFO - Running setup.py (path:/tmp/pip-cWUI0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 INFO - Running setup.py (path:/tmp/pip-7Th5HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:05 INFO - Running setup.py (path:/tmp/pip-1tCF5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:05 INFO - Running setup.py (path:/tmp/pip-jdK3bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:05 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)) 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:05 INFO - Running setup.py (path:/tmp/pip-4KQBhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:06 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)) 17:44:06 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)) 17:44:06 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)) 17:44:06 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)) 17:44:06 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)) 17:44:06 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)) 17:44:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - Downloading blessings-1.5.1.tar.gz 17:44:07 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 17:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:07 INFO - Installing collected packages: blessings 17:44:07 INFO - Running setup.py install for blessings 17:44:07 INFO - Successfully installed blessings 17:44:07 INFO - Cleaning up... 17:44:07 INFO - Return code: 0 17:44:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:08 INFO - Reading from file tmpfile_stdout 17:44:08 INFO - Current package versions: 17:44:08 INFO - argparse == 1.2.1 17:44:08 INFO - blessings == 1.5.1 17:44:08 INFO - blobuploader == 1.2.4 17:44:08 INFO - docopt == 0.6.1 17:44:08 INFO - manifestparser == 1.1 17:44:08 INFO - mozInstall == 1.12 17:44:08 INFO - mozcrash == 0.16 17:44:08 INFO - mozdebug == 0.1 17:44:08 INFO - mozdevice == 0.47 17:44:08 INFO - mozfile == 1.2 17:44:08 INFO - mozhttpd == 0.7 17:44:08 INFO - mozinfo == 0.9 17:44:08 INFO - mozleak == 0.1 17:44:08 INFO - mozlog == 3.1 17:44:08 INFO - moznetwork == 0.27 17:44:08 INFO - mozprocess == 0.22 17:44:08 INFO - mozprofile == 0.27 17:44:08 INFO - mozrunner == 6.11 17:44:08 INFO - mozscreenshot == 0.1 17:44:08 INFO - mozsystemmonitor == 0.0 17:44:08 INFO - moztest == 0.7 17:44:08 INFO - mozversion == 1.4 17:44:08 INFO - psutil == 3.1.1 17:44:08 INFO - requests == 1.2.3 17:44:08 INFO - wsgiref == 0.1.2 17:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:08 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')]} 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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')]} 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:44:08 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 17:44:08 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 17:44:08 INFO - Using env: {'DISPLAY': ':0', 17:44:08 INFO - 'HOME': '/home/cltbld', 17:44:08 INFO - 'LANG': 'en_US.UTF-8', 17:44:08 INFO - 'LANGUAGE': 'en_US:en', 17:44:08 INFO - 'LOGNAME': 'cltbld', 17:44:08 INFO - 'MAIL': '/var/mail/cltbld', 17:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:08 INFO - 'MOZ_NO_REMOTE': '1', 17:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:08 INFO - 'NO_EM_RESTART': '1', 17:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:08 INFO - 'PWD': '/builds/slave/test', 17:44:08 INFO - 'SHELL': '/bin/bash', 17:44:08 INFO - 'SHLVL': '1', 17:44:08 INFO - 'TERM': 'linux', 17:44:08 INFO - 'TMOUT': '86400', 17:44:08 INFO - 'USER': 'cltbld', 17:44:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:08 INFO - '_': '/tools/buildbot/bin/python'} 17:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 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)) 17:44:08 INFO - Cleaning up... 17:44:08 INFO - Return code: 0 17:44:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:08 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')]} 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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')]} 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:44:08 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 17:44:08 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 17:44:08 INFO - Using env: {'DISPLAY': ':0', 17:44:08 INFO - 'HOME': '/home/cltbld', 17:44:08 INFO - 'LANG': 'en_US.UTF-8', 17:44:08 INFO - 'LANGUAGE': 'en_US:en', 17:44:08 INFO - 'LOGNAME': 'cltbld', 17:44:08 INFO - 'MAIL': '/var/mail/cltbld', 17:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:08 INFO - 'MOZ_NO_REMOTE': '1', 17:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:08 INFO - 'NO_EM_RESTART': '1', 17:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:08 INFO - 'PWD': '/builds/slave/test', 17:44:08 INFO - 'SHELL': '/bin/bash', 17:44:08 INFO - 'SHLVL': '1', 17:44:08 INFO - 'TERM': 'linux', 17:44:08 INFO - 'TMOUT': '86400', 17:44:08 INFO - 'USER': 'cltbld', 17:44:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:08 INFO - '_': '/tools/buildbot/bin/python'} 17:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:08 INFO - Downloading/unpacking jsonschema 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:10 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 17:44:10 INFO - Downloading/unpacking functools32 (from jsonschema) 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:10 INFO - warning: no files found matching '*.txt' 17:44:10 INFO - no previously-included directories found matching 'build' 17:44:10 INFO - no previously-included directories found matching 'dist' 17:44:10 INFO - no previously-included directories found matching '.git*' 17:44:10 INFO - Installing collected packages: jsonschema, functools32 17:44:10 INFO - Running setup.py install for functools32 17:44:10 INFO - warning: no files found matching '*.txt' 17:44:10 INFO - no previously-included directories found matching 'build' 17:44:10 INFO - no previously-included directories found matching 'dist' 17:44:10 INFO - no previously-included directories found matching '.git*' 17:44:10 INFO - Successfully installed jsonschema functools32 17:44:10 INFO - Cleaning up... 17:44:10 INFO - Return code: 0 17:44:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:44:10 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')]} 17:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:10 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')]} 17:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:10 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 0x7ff948aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, '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': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', '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 17:44:10 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 17:44:10 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 17:44:10 INFO - Using env: {'DISPLAY': ':0', 17:44:10 INFO - 'HOME': '/home/cltbld', 17:44:10 INFO - 'LANG': 'en_US.UTF-8', 17:44:10 INFO - 'LANGUAGE': 'en_US:en', 17:44:10 INFO - 'LOGNAME': 'cltbld', 17:44:10 INFO - 'MAIL': '/var/mail/cltbld', 17:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:10 INFO - 'MOZ_NO_REMOTE': '1', 17:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:10 INFO - 'NO_EM_RESTART': '1', 17:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:10 INFO - 'PWD': '/builds/slave/test', 17:44:10 INFO - 'SHELL': '/bin/bash', 17:44:10 INFO - 'SHLVL': '1', 17:44:10 INFO - 'TERM': 'linux', 17:44:10 INFO - 'TMOUT': '86400', 17:44:10 INFO - 'USER': 'cltbld', 17:44:10 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:10 INFO - '_': '/tools/buildbot/bin/python'} 17:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:10 INFO - Downloading/unpacking flake8 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:44:12 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 17:44:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:44:12 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 17:44:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:12 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 17:44:13 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 17:44:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:44:13 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 17:44:13 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 17:44:13 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 17:44:13 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 17:44:13 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 17:44:13 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 17:44:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:13 INFO - no previously-included directories found matching 'docs/_build' 17:44:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:44:13 INFO - Running setup.py install for pep8 17:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:13 INFO - no previously-included directories found matching 'docs/_build' 17:44:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:44:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:44:13 INFO - Cleaning up... 17:44:13 INFO - Return code: 0 17:44:13 INFO - Running post-action listener: _resource_record_post_action 17:44:13 INFO - Running post-action listener: _start_resource_monitoring 17:44:13 INFO - Starting resource monitoring. 17:44:13 INFO - ##### 17:44:13 INFO - ##### Running install step. 17:44:13 INFO - ##### 17:44:13 INFO - Running pre-action listener: _resource_record_pre_action 17:44:13 INFO - Running main action method: install 17:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Output received: 17:44:14 INFO - Usage: mozinstall [options] installer 17:44:14 INFO - Options: 17:44:14 INFO - -h, --help show this help message and exit 17:44:14 INFO - -d DEST, --destination=DEST 17:44:14 INFO - Directory to install application into. [default: 17:44:14 INFO - "/builds/slave/test"] 17:44:14 INFO - --app=APP Application being installed. [default: firefox] 17:44:14 INFO - mkdir: /builds/slave/test/build/application 17:44:14 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'] 17:44:14 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 17:44:29 INFO - Reading from file tmpfile_stdout 17:44:29 INFO - Output received: 17:44:29 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:29 INFO - Running post-action listener: _resource_record_post_action 17:44:29 INFO - ##### 17:44:29 INFO - ##### Running run-tests step. 17:44:29 INFO - ##### 17:44:29 INFO - Running pre-action listener: _resource_record_pre_action 17:44:29 INFO - Running main action method: run_tests 17:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:29 INFO - Python 2.7.3 17:44:29 INFO - Return code: 0 17:44:29 INFO - grabbing minidump binary from tooltool 17:44: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')]} 17:44:29 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 0x1f310b0>, '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 0x1f31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:29 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 17:44:29 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 17:44:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:29 INFO - Return code: 0 17:44:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:44:30 INFO - Return code: 0 17:44:30 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 17:44:30 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 17:44:30 INFO - Using env: {'DISPLAY': ':0', 17:44:30 INFO - 'HOME': '/home/cltbld', 17:44:30 INFO - 'LANG': 'en_US.UTF-8', 17:44:30 INFO - 'LANGUAGE': 'en_US:en', 17:44:30 INFO - 'LOGNAME': 'cltbld', 17:44:30 INFO - 'MAIL': '/var/mail/cltbld', 17:44:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:30 INFO - 'MOZ_NO_REMOTE': '1', 17:44:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:30 INFO - 'NO_EM_RESTART': '1', 17:44:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:30 INFO - 'PWD': '/builds/slave/test', 17:44:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:30 INFO - 'SHELL': '/bin/bash', 17:44:30 INFO - 'SHLVL': '1', 17:44:30 INFO - 'TERM': 'linux', 17:44:30 INFO - 'TMOUT': '86400', 17:44:30 INFO - 'USER': 'cltbld', 17:44:30 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309', 17:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:30 INFO - '_': '/tools/buildbot/bin/python'} 17:44:30 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 17:44:30 INFO - mozversion INFO | application_buildid: 20151217170055 17:44:30 INFO - mozversion INFO | application_changeset: e4aca954089ddf8bf8c33f7b13cec453c5dd259f 17:44:30 INFO - mozversion INFO | application_display_name: Nightly 17:44:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:30 INFO - mozversion INFO | application_name: Firefox 17:44:30 INFO - mozversion INFO | application_remotingname: firefox 17:44:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:44:30 INFO - mozversion INFO | application_vendor: Mozilla 17:44:30 INFO - mozversion INFO | application_version: 46.0a1 17:44:30 INFO - mozversion INFO | platform_buildid: 20151217170055 17:44:30 INFO - mozversion INFO | platform_changeset: e4aca954089ddf8bf8c33f7b13cec453c5dd259f 17:44:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:44:30 INFO - mozversion INFO | platform_version: 46.0a1 17:44:30 INFO - 2015-12-17 17:44:30,829 DEBUG : using testdate: 1450403070 17:44:30 INFO - 2015-12-17 17:44:30,829 DEBUG : actual date: 1450403070 17:44:30 INFO - 2015-12-17 17:44:30,838 INFO : starting webserver on 'localhost:41140' 17:44:30 INFO - 2015-12-17 17:44:30,839 INFO : Starting test suite talos-linux64-ix-055 17:44:30 INFO - 2015-12-17 17:44:30,839 INFO : Starting test dromaeo_css 17:44:30 INFO - 2015-12-17 17:44:30,839 DEBUG : operating with platform_type : linux_ 17:44:30 INFO - 2015-12-17 17:44:30,840 INFO : Initialising browser for dromaeo_css test... 17:44:30 INFO - 2015-12-17 17:44:30,852 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwodSOQ/profile http://localhost:41140/getInfo.html 17:44:35 INFO - 2015-12-17 17:44:35,561 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:44:35 INFO - 2015-12-17 17:44:35,561 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:44:35 INFO - 2015-12-17 17:44:35,561 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:44:35 INFO - 2015-12-17 17:44:35,561 DEBUG : BROWSER_OUTPUT: __metrics 17:44:35 INFO - 2015-12-17 17:44:35,662 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] 17:44:35 INFO - 2015-12-17 17:44:35,730 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] 17:44:35 ERROR - 2015-12-17 17:44:35,746 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:44:36 INFO - 2015-12-17 17:44:36,571 INFO : Browser initialized. 17:44:36 INFO - 2015-12-17 17:44:36,572 INFO : Running cycle 1/1 for dromaeo_css test... 17:44:36 INFO - 2015-12-17 17:44:36,572 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwodSOQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:44:48 INFO - 2015-12-17 17:44:48,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 150167552 17:44:48 INFO - 2015-12-17 17:44:48,637 DEBUG : BROWSER_OUTPUT: 17:45:40 INFO - 2015-12-17 17:45:40,006 DEBUG : BROWSER_OUTPUT: 1450403140000 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] 17:47:52 INFO - 2015-12-17 17:47:52,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41140/tests/dromaeo/cssquery-ext.html) 17:47:53 INFO - 2015-12-17 17:47:53,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 269582336 17:47:53 INFO - 2015-12-17 17:47:53,254 DEBUG : BROWSER_OUTPUT: 17:50:55 INFO - 2015-12-17 17:50:55,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-ext.html (next: http://localhost:41140/tests/dromaeo/cssquery-jquery.html) 17:50:56 INFO - 2015-12-17 17:50:56,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 234004480 17:50:56 INFO - 2015-12-17 17:50:56,327 DEBUG : BROWSER_OUTPUT: 17:53:58 INFO - 2015-12-17 17:53:58,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41140/tests/dromaeo/cssquery-mootools.html) 17:53:58 INFO - 2015-12-17 17:53:58,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 226308096 17:53:58 INFO - 2015-12-17 17:53:58,919 DEBUG : BROWSER_OUTPUT: 17:57:00 INFO - 2015-12-17 17:57:00,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41140/tests/dromaeo/cssquery-prototype.html) 17:57:01 INFO - 2015-12-17 17:57:01,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 214421504 17:57:01 INFO - 2015-12-17 17:57:01,496 DEBUG : BROWSER_OUTPUT: 18:00:04 INFO - 2015-12-17 18:00:04,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41140/tests/dromaeo/cssquery-yui.html) 18:00:04 INFO - 2015-12-17 18:00:04,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 193241088 18:00:04 INFO - 2015-12-17 18:00:04,731 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/dromaeo/cssquery-yui.html (next: http://localhost:41140/tests/dromaeo/cssquery-dojo.html) 18:03:07 INFO - 2015-12-17 18:03:07,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 261599232 18:03:07 INFO - 2015-12-17 18:03:07,420 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,421 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:03:07 INFO - 2015-12-17 18:03:07,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:03:07 INFO - 2015-12-17 18:03:07,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:03:07 INFO - 2015-12-17 18:03:07,422 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:03:07 INFO - 2015-12-17 18:03:07,423 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2605.452854900471;2683.498827403823;2696.366353906833;2706.1475635174907;2712.186344096771;4457.375967364572;4595.379623750792;4678.766061696914;4679.929801052983;4681.765911704414;4549.977250113753;4583.977080114595;4657.55753203446;4665.580097791198;4710.317004034421;4337.522872484024;4344.261475549164;4348.173846969065;4362.825486980517;4369.737815731066;4146.419501269825;4377.4528183977;4378.452693413324;4427.911441771163;4440.533743956887;4217;4281.422008028907;4284.721493102954;4330.826766929319;4338.609525142752;4280.6361459275995;4283.164782867342;4290.721103128287;4322.82708691652;4334.046509767846;4158.584141585848;4294.334378171388;4298.31227003681;4299.355096735483;4346.217680817452;4606.516315786827;4612.723236605781;4620.768961551943;4715.64632652549;4749.121412538657;5061.898762024739;5092.79628814847;5092.872678183038;5094.77073531692;5131.820386286499;4818.084563932842;5105.5915526758145;5110.923336149961;5115.693058416469;5116.309298244763;4563.885902852388;4602.378678878342;4618.330342100377;4625.444946606362;4679.81280748773;5203.73981300941;5220.843374698765;5227.817026404134;5231.450697676765;5235.554977826928;4710.4347478302825;5002.324686167393;5006.89986200274;5059.316992206005;5062.038212739568;4885.877853053631;4924.679895806761;4949.109160351171;4968.453470118357;5012.198048312325;4980.452150263468;4981.153203955337;4982.451930287665;4985.351904252497;5030;4937.407511098691;4942.678725882806;4943.678660887031;4955.2567114933045;4985.376827896513;4008.719389642697;4079.1637714268504;4118.382242663624;4118.91762164755;4136.048708796933;3670.724695647784;3690.372636651776;3693.4459831025024;3694.039549717093;3698.0754811297174;4195.7692326922315;4247.065645558034;4250.4474418326035;4252.107057517894;4304.935425968613;5074.314967479417;5102.158143906288;5127;5133.281340612317;5138.3577052868395;4329.956700432956;4358.302671572596;4379.824807007748;4410.051838854662;4420.9115817684105;4204.180184863983;4357.7385356878685;4365.781710914442;4521.186186486399;4524.25349817283;4733.857984260478;4825.879353016203;4830.589399901048;4836.782344794422;4876.683015603974;5057.595392368676;5062.949370506248;5065.848024559269;5067.493250674903;5109.310243117132;4565.817367305403;4615.88460288482;4668.6498512611015;4800.903981920412;4846.151923413318;4860.270959355983;4885.975570122127;4946.604271658187;4960.330355402119;4993.550580447777;5057.216131499624;5065.265536497261;5066.341375621146;5071.416787069386;5111.795528178831;4715.6699031068865;4908.141075311734;4909.091818013679;4910.165271903714;4948.109340318777;4764.737939413366;4813.614910807197;4829.5653391194965;4839.322494850794;4894.388201474816;4795.520447955177;4799.136155492045;4812.278158276286;4832;4848.854534363974;4748.477667456508;4904.288878112725;4904.509549045067;4921.360223170965;4952.133376659142;4714.457837348748;4715.552022557851;4751.263554149113;4869.4400143982475;4879.536444037811 18:03:07 INFO - 2015-12-17 18:03:07,425 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.1840130603441;552.7484994327581;555.5472290083583;563.7688547695443;572.5219441766125;26515.734842651567;34420.655793442056;35237.295254094905;35289.47065794015;35418.114547136334;39442;39988.60011399885;39991.40012899809;40024.19951600966;40050.19899602006;7066.646667666596;7204.423646108299;7953.840923181548;8130.674773009102;8138.3896207784355;10335;10575.629852955148;10578.206634502405;10579.259451838374;10587.417692026935;10199;10348.327358721697;10364;10367.948160259188;10372.53323600436;7332.340089391981;7480.551166930001;10104.49477526128;10137.239707021967;10406.635767748168;10018.298719089667;10156.187504999656;10157.593696252141;10159.949200254025;10164.288499805016;36130.73542426029;36624;36638.81680591607;36662.450063249074;36674.08314792125;2784.429192015632;2830.3348713052414;2941.7793665475174;3474.166200111955;3510.1224693826543;27688;28099.157025289274;28200.717992820013;28242.85878570594;28714.569281460794;3449.1032331593715;3454.084667563098;3507.2108775525303;3571.357155711971;3573.4997100405963;218726;220330;220717;220826;224127.87936060378;50193.48645594846;51597.48402516002;53497.1975420369;53967;55197.72401137969;47711.5228847714;47786.28320575194;47824.32614858463;48041.75979120152;48120.27819582709;12829.23024618526;13095.148815326973;13099;13100;13132.540361087507;9752.95123524392;9870.062344077302;9895;9900.207983361313;9930.652427165014;18103.63792724138;18314.63370732578;18356.632867342578;18366.90816545909;18368.173432195315;7068.3702175075405;7253.419726421874;7458.888116678254;7471.215522370181;7487.3261406473675;845.9280961118251;860.875173099897;910.7586489580267;945.4280160502797;1006.993006993007;26082.217533474028;26438.6034209487;27758.306042349104;28338.716612833607;29111.417771644872;954.4321128928276;987.6543209876629;1089.6349722842779;1096.8957948994832;1106.1482658353023;12741.426635801226;12816.93591532055;12847.421866016051;12848.357582121043;12987.155834870891;262592;263153;266068;267036;267233;42833;43124.706258812286;43195.568044319785;43287.134257314676;43293;1048.1928914735763;1202.290648517379;1229.9631011069682;1245.2964075297427;1247.600767754328;18545.35091271799;24805;24833;25029.624555632043;25230.74769252284;37797.24405511929;38088.809555952044;38287.61712382841;38384;38447;206655;209059;218219;221873;241105;25730.87134564315;25762;25846.353841154123;26139;26288.211353659422;37475.625243747214;37953.81023094867;38235.80882095572;38579.80710096544;38852.41721374125;31782.205444864063;31804.204894877814;31941.520877187326;32820.179495512806;32973.50539741954;32977.67022329746;33181.33637327288;33193.17017074592;37389.626103738614;40169.79915100406;34225.82887085548;40595.18809623732;41113.1777364457;41488.79255603703;41702.79148604238;34069.48895766516;35466.468002980495;35899.28201435904;36440;36471.27057458783;23231;23744.168954086523;23879.16422925189;23901.641475377535;23911.402214944766 18:03:07 INFO - 2015-12-17 18:03:07,426 DEBUG : BROWSER_OUTPUT: |2;jquery.html;318.21877291249984;323.1515730024261;324.02953155299866;326.4955643530745;327.0482894776201;12397.876021239785;12714.173578717377;14663.780043299359;14814.111153330809;15162.39350425983;12235.755284894296;14719.632009199748;14930.178840163786;15405;15408.614784630361;4823.686460380064;4828.5412885775795;4946.505349465061;4951;4965.875853103666;3655.798931058791;3765.9246815063684;4909.116359055369;4956.752162391884;5577.414371490996;5675.971620141893;5701.714914254291;5723.141528770697;5724.284464441945;5726.484616384525;5535.25274087999;5687.402822703619;5716.028275193206;5716.056850619642;5722.399148089432;5067.49325067494;5067.923981140286;5076.390833100052;5077.5684066854365;5078.847634570969;18892.244310227576;19086.713699294523;19280.22879084835;19290;19391;1820.7997120316754;1877.239717914247;1920.9135588898394;1943.834774044208;1990.4327266728912;12086;12476.937615311956;12643.178193417398;12776.61670149897;13042.869571304354;1636.108320965077;1697.3804561335148;1746.4847869878417;1753.6142048749255;1769.2127003483456;53397.937632003974;54868.45131548673;55292;55466.16800747992;55660.16509752357;8868.246199073023;9066.22937050358;9352.719418417459;9385.108414700593;9420.811583768285;11974.521019159136;11975.580854670045;11981.580644677395;11990.400479975966;12012.159148859671;6899.896501552481;6924.446044316443;6977.860442791217;7049.612271325126;7110.964445177844;6335.1447554579545;6388.776392826228;6401.871962560723;6401.9039714404325;6521.152250207443;5591.776328946878;5680.346760122638;5719.056355701346;5732.3121225453215;5785.797497087666;1485.9777103343458;1515.3181068519211;1547.6517783498623;1567.6002619331998;1571.2143928035982;816.3754727633366;834;868.9522076285865;934.0286102453508;985.7929834734642;15935.442259520862;16283.59291017734;16460.83539164617;16577.50267491977;16674.916625416794;766.4979438467813;804.3766081287049;807.7738233294687;862.3877047296489;882.5190271302156;8514.74455766328;8922.197002269697;9060.682876099305;9133.77165570866;9327.766805829908;466388;467478;470272;474889;495542;71053.644731776;71562.64218678873;73820.63089684518;74281;74425.6278718603;1050.5640159333943;1065.8934106589434;1080.4273734920662;1081.8269076947652;1084.4631907205983;14311.785323220369;14403.495877644651;14575.897202933469;14735.92632036833;15092;32777.67222327746;32951.835240823646;33403.99788006364;33757.49363759496;34056;41802.95492612709;42390.57609423866;42421;43335.56664433315;43521.78239108784;8305.37709671765;8383.916160838558;8555.57222138903;8621.827563448822;8672.696455624024;10055.29612927088;10129.392236465541;10178.13485853681;10208.438535880598;14459.710805784036;13385.263810490516;13386;13614.842738366953;13740.175589464665;13957.441702331793;12909.483620655068;13262.867371326163;13281.80077298822;13742.519011834538;13837.584872453843;10682.305650132717;13750;13888.375023124187;14299.07056041354;14435.3504092314;8672.841954934882;8745.256653184297;8811.33914956368;8870.86693699582;8906.421082629608;12661.177023493443;13715.794263086262;13892.93053534726;13936.651583710489;14272.643183920485 18:03:07 INFO - 2015-12-17 18:03:07,427 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1245.7757603631353;1667.624784423505;1691.42491552872;1732.7660765796613;1736.4703765351567;6038.637681739093;6835.794926152217;7014.614196219206;7023.19233288172;7035.824104397393;7106.467014973872;7215.567065976045;7280.417566594673;7282.490225684204;7294.3799777018885;2001.3495613925495;2031.5936812637458;2033.1359172351692;2034.410021093881;2036.4501584572156;2051.7537895452565;2079.6984437256588;2090.6550419180817;2117.819985301251;2121.2681624839406;2006.5485265815148;2017.5561376497146;2028.9289874854383;2039.4901274681329;2043.632146213681;2027.472857057161;2054.5377290109604;2055.835533157351;2056.3830850744716;2056.7120603115577;2016.6168427998634;2035.216441669953;2038.4598081508263;2039.7042428847733;2040.0207900207984;7143.357097861165;7211.927880721178;7228.421726261939;7230.746923857692;7235.71057157713;4087.223427548786;4111.814968326433;4116.238495878272;4155.480564929384;4157.875263742093;2630.1320564213956;2645.4576811753545;2668.159529748123;2683.9194824155306;2689.556223223166;876.6537217798998;886.3396769406833;894.9821003579892;903.8870141232346;917.807260475301;9430.339876208669;9442.952785236099;9463.574139163755;9465.290103242285;9501.192398646124;3688.834002469842;3689;3772.1512659651908;3796.677282431024;3800.144967382372;8238.217369349903;8246.340292776684;8251.092379838214;8251.463654862415;8271.296939760188;4097.364908439196;4100.65144462724;4123.113530590937;4124.752514849119;4134.793260336971;3204.070819462376;3276.983615081909;3651.634836516327;3712.424574190951;3762.887113386603;3410.6759857813468;3441.741869359808;3456.0495863637198;3473.913152171216;3499.8950031499094;1091.1816137896578;1093.1746531368924;1098.3025778630467;1106.4744246483017;1117.7038084907506;837.2757564706607;915.844306467902;924.7503174142944;975.7755716185317;1162.8778978207336;6697.8995315070315;6831.487638427137;6834.829129271709;6847.691853866588;6852.45180385568;1021.3361315145215;1022.7392015036119;1028.4857571214393;1034.8809886863107;1053.4785281285813;5296.9670914171365;5315.867103322448;5333.093374126408;5346.705931173823;5348.839534813962;8155.388345874083;8493.27807136388;8513.616887240089;8753.431026983226;8791.34064945119;8593.269572086443;8740.300775937909;8767.123287671182;8775.473471591726;8779.122087791298;6796.626185559841;6821.21556021054;6899.689513971884;6910.516263861481;6922.58464492132;6845.726170953305;6863.553868998499;6895.931040689529;6901.275366086488;6903.689333980084;7718.575478348745;7747.922520774946;7778.688852445839;7795.805104872424;7796.376289896682;7914.287714105758;8045.275925166529;8140.063892652421;8181.79545511367;8193.303569196447;6219.440250377488;6233.438990490878;6316.526260530571;6320.5575609706875;6324.177856878577;7009.754658586925;7130.429565634633;7131.821704457223;7135.215126336203;7141.214466408587;6595.472362211108;6708.463322934056;6723.562968407038;6751.594904305757;6838.384545390939;5583.8883222336135;5851.853703657443;6105.664188469676;6239.220097487814;6401.071844582602;6254.562180647311;6473.514486413444;6506.089147519446;6533.934660653523;6546.18172728409;6001.06983417571;6024.096385542204;6027.427394397525;6031.306399764083;6051.0923361496125;6037.124616930609;6046.879062418815;6083.6045657032155;6085.786997455068;6098.786542470993 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.68982103522853;301.91697283247106;305.19276513621475;305.88809676824764;309.0835672231832;5214.582833373331;5255.92116118258;5287.682739035656;5300.787968481256;5309.920351194735;5193.792248310073;5199.194124910636;5208.947910520894;5216.556592689616;5237.083510385686;3879.1659793144468;4089.734167279132;4090.4886889138857;4094.651954583864;4098.733582317155;3965.4646622705854;4012.0972781124306;4127.607877251657;4130.463039804837;4139.048018955642;4060.1473690525027;4074.9185016299803;4076.9796151019204;4079.9184016319655;4082.5509193988637;3813.504244448232;3920.9019774505864;3956.940645890314;4072.4095006223934;4072.7963601819793;3600.747947643666;3600.873969411058;3612.6387361263664;3625.782453052825;3632.1827588792576;5054.115529782273;5056.721880296583;5077.984403119354;5085.618578606619;5086.237064440326;4706.270528068155;4715.269133284346;4718.598919091882;4721.693089949143;4723.126221649006;5404.351477822647;5516.779328826882;5519.530839878616;5535;5537.003339398907;3932.842686292545;3934.980325098385;3937.6652984496354;3942.9014274643077;3947.782871942071;5731.885362292773;5816.098504731774;5822.883542329129;5829.650220986712;5831.562632802515;4084;4088.550259471456;4089.3048181809163;4089.488813898263;4090.795460227036;4023.7988100594853;4146;4147.792610369469;4150.377443383456;4151.958480415217;4688.695234809727;4693.249080147229;4695.718256904596;4697.6241900647865;4700.412448443944;5546.944530554723;5555.611107222537;5559.054960656698;5560.165975103767;5562.694051827108;1445.9638509037147;1466.6186791434304;1468.3245706974697;1468.8751456126136;1470.0371256826795;996.9750756231152;997.6059456514636;1002.0680766886866;1022.6727447216967;1031.7626945802508;4857.53853383928;4863.683860549053;4865;4865.95134048662;4870.6103511718975;5733.31200255972;5764;5769.336526299529;5776.682282474504;5780;4858.5384388483035;4859.97940432506;4866.635002374836;4866.853994380174;4869.1722407190155;3031.7271445570004;3084.1364417963005;3110.7666924980717;3112.066380085965;3113.050519591546;5490.945090549043;5493.670379777226;5500.202470641734;5505.03661859173;5515.25544051556;5923.45990042592;5940.257467816523;5941.673207973603;5945.048792193228;5952.76188952437;5468.535174510132;5489.890202195934;5501.092319767194;5501.367342755554;5516.14499752531;5664.631798933056;5804.1293805929445;5807.593468457168;5814.680192589448;5819.476247137778;5655.688937108499;5665.3201615806365;5665.943340566541;5671.262735844314;5674.347450043298;5477.643953143033;5492.313460817398;5492.917606235989;5495.587830912617;5501.5323697486165;3901.1612503311926;3949.842006319715;3979.442877997025;3990.4612877261197;3996.960030399659;5789.1605717171615;5795.536357091507;5797.710114494174;5798.362180160095;5808;5573.164025396223;5574.581906356958;5581.023320918742;5581.49766521015;5588;5575.693336866511;5586.022446072003;5586.804461843816;5592.3009623797025;5593.440655934374;5275.939954826268;5461.590380721383;5461.672299662033;5462.989346970823;5463.918041229305;5401.837944861661;5524.640898341595;5610.410906854721;5619.100943848965;5622.016147174147;5334.359876814652;5464.890702185855;5496.697681627549;5497.120460726264;5498.3127109111365 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: |5;yui.html;707.6603230449383;712.3980236699988;731.7109741652048;738.3723834740468;748.0835975929486;10408.167346612272;10645.57417703293;10668;10677.092447141993;10685.358878467297;11251.887481125186;11412.31526108434;11416.257943233704;11419.54321827126;11446.370449625289;621.6208113051035;628.2492421556242;773.3581127664054;778.8208711996244;791.0862953288931;786.7482405630201;790.4269404681618;792.2513225002375;794.3486341200218;794.8608993426157;658.9308122647125;832.6669332267081;837.1001173738225;838.5555655502593;839.3830534557126;654.469879397687;815.747118393297;828.0187977246921;828.5981299069946;830.6760363458257;616.3743800042915;618.542278713753;618.5608218165108;620.488097319713;621.8569728962319;10938.56245750169;10942.288751231144;11001.834972475419;11050.502727377287;11075.612353567587;10828.242023058388;11284.153688473398;11305.095592352674;11387.430628468543;11490.36802975836;8751.562421878943;8839.558022098934;9068.909310906873;9157.450552966844;9225.67710130149;3067.6778938211614;3140.905772826819;3141.183292344007;3148.9527657085164;3195.8561864716144;37896.810515947516;37906.24187516234;38068.42897356542;38333.80833095845;38601.61398386036;8749.16882896124;9090.318226132935;9172.12864777845;9216.447013179231;9227.861582076273;16349.34602615882;16383.836161638232;16423.343066277215;16424;16426.507204783877;5993.160957465958;6166.9383306167265;6208.410201030895;6259.906101408483;6299.590526615755;3178.3802158578856;3233.0624119005697;3268.7548433867555;3329.417351963397;3344.0469466202017;2373.6439534070028;2392.6171812509915;2405.7834794868545;2410.722766881796;2411.3489357873277;448.02107395341284;449.8425551057104;454.23234733300615;455.78805855276795;456.5525784730982;431.0903992575663;489.38826466916356;517.6350672775684;520.5185203686575;570.292836882263;6712.309710242852;6875.243723190445;6887.621180835102;7158.749443769547;7171.39043181325;423.90257157679156;425.1963788439851;470.7881453346008;478.8946431785002;518.5177784660227;3333.7666363354333;3384.1708781348725;3420.3672320620763;3461.44616861301;3462;44405;44803;45134;45223.321650175276;45439;39991.40012899809;41156.176876462305;41245;41433.1713365737;41822.79088604599;38437.615623843965;38457.42313865294;38768;39024.219515609526;39247.60752392497;7112.857742845011;7527.548347099191;7609.201033891583;7663.923360766544;7716.614169291625;29504;29668;30105.09684709462;30425.695743042284;30434.695653044073;34468;34798;40941;40956.59043409528;42151.7892410536;9463.763405914631;9645.951770241103;9653.951730241304;9692.612295508101;9701.757456063655;10596.311239769699;10602.416867072385;10707.304025238334;11063.557457701601;11507;9739.430578001113;9857.507124643882;9989.60041598328;10117.848232276374;10138.341007834468;9743.658971935949;9799.85300220483;9818.950905245429;10025.5488503019;10030;9489.430634161972;9615.9038409615;9736.9026309736;10034.949825250827;10067.345622534513;8548.786280343042;8846.217052024704;9026.368154229142;9032.412893161923;9045.366824322235;8600.13998600135;8786.780330491789;8837.160469755363;8841.425307355;8993.595288211915 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404187420__endTimestamp 18:03:07 INFO - 2015-12-17 18:03:07,429 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,430 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:03:07 INFO - 2015-12-17 18:03:07,430 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:03:07 INFO - 2015-12-17 18:03:07,430 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,430 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4628.42 Median:4748.48 stddev:495.26 (10.4%) stddev-sans-first:470.67 18:03:07 INFO - 2015-12-17 18:03:07,431 DEBUG : BROWSER_OUTPUT: Values: 2605.5 2683.5 2696.4 2706.1 2712.2 4457.4 4595.4 4678.8 4679.9 4681.8 4550.0 4584.0 4657.6 4665.6 4710.3 4337.5 4344.3 4348.2 4362.8 4369.7 4146.4 4377.5 4378.5 4427.9 4440.5 4217.0 4281.4 4284.7 4330.8 4338.6 4280.6 4283.2 4290.7 4322.8 4334.0 4158.6 4294.3 4298.3 4299.4 4346.2 4606.5 4612.7 4620.8 4715.6 4749.1 5061.9 5092.8 5092.9 5094.8 5131.8 4818.1 5105.6 5110.9 5115.7 5116.3 4563.9 4602.4 4618.3 4625.4 4679.8 5203.7 5220.8 5227.8 5231.5 5235.6 4710.4 5002.3 5006.9 5059.3 5062.0 4885.9 4924.7 4949.1 4968.5 5012.2 4980.5 4981.2 4982.5 4985.4 5030.0 4937.4 4942.7 4943.7 4955.3 4985.4 4008.7 4079.2 4118.4 4118.9 4136.0 3670.7 3690.4 3693.4 3694.0 3698.1 4195.8 4247.1 4250.4 4252.1 4304.9 5074.3 5102.2 5127.0 5133.3 5138.4 4330.0 4358.3 4379.8 4410.1 4420.9 4204.2 4357.7 4365.8 4521.2 4524.3 4733.9 4825.9 4830.6 4836.8 4876.7 5057.6 5062.9 5065.8 5067.5 5109.3 4565.8 4615.9 4668.6 4800.9 4846.2 4860.3 4886.0 4946.6 4960.3 4993.6 5057.2 5065.3 5066.3 5071.4 5111.8 4715.7 4908.1 4909.1 4910.2 4948.1 4764.7 4813.6 4829.6 4839.3 4894.4 4795.5 4799.1 4812.3 4832.0 4848.9 4748.5 4904.3 4904.5 4921.4 4952.1 4714.5 4715.6 4751.3 4869.4 4879.5 18:03:07 INFO - 2015-12-17 18:03:07,431 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,431 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39652.96 Median:32975.59 stddev:61318.68 (186.0%) stddev-sans-first:61420.38 18:03:07 INFO - 2015-12-17 18:03:07,431 DEBUG : BROWSER_OUTPUT: Values: 542.2 552.7 555.5 563.8 572.5 26515.7 34420.7 35237.3 35289.5 35418.1 39442.0 39988.6 39991.4 40024.2 40050.2 7066.6 7204.4 7953.8 8130.7 8138.4 10335.0 10575.6 10578.2 10579.3 10587.4 10199.0 10348.3 10364.0 10367.9 10372.5 7332.3 7480.6 10104.5 10137.2 10406.6 10018.3 10156.2 10157.6 10159.9 10164.3 36130.7 36624.0 36638.8 36662.5 36674.1 2784.4 2830.3 2941.8 3474.2 3510.1 27688.0 28099.2 28200.7 28242.9 28714.6 3449.1 3454.1 3507.2 3571.4 3573.5 218726.0 220330.0 220717.0 220826.0 224127.9 50193.5 51597.5 53497.2 53967.0 55197.7 47711.5 47786.3 47824.3 48041.8 48120.3 12829.2 13095.1 13099.0 13100.0 13132.5 9753.0 9870.1 9895.0 9900.2 9930.7 18103.6 18314.6 18356.6 18366.9 18368.2 7068.4 7253.4 7458.9 7471.2 7487.3 845.9 860.9 910.8 945.4 1007.0 26082.2 26438.6 27758.3 28338.7 29111.4 954.4 987.7 1089.6 1096.9 1106.1 12741.4 12816.9 12847.4 12848.4 12987.2 262592.0 263153.0 266068.0 267036.0 267233.0 42833.0 43124.7 43195.6 43287.1 43293.0 1048.2 1202.3 1230.0 1245.3 1247.6 18545.4 24805.0 24833.0 25029.6 25230.7 37797.2 38088.8 38287.6 38384.0 38447.0 206655.0 209059.0 218219.0 221873.0 241105.0 25730.9 25762.0 25846.4 26139.0 26288.2 37475.6 37953.8 38235.8 38579.8 38852.4 31782.2 31804.2 31941.5 32820.2 32973.5 32977.7 33181.3 33193.2 37389.6 40169.8 34225.8 40595.2 41113.2 41488.8 41702.8 34069.5 35466.5 35899.3 36440.0 36471.3 23231.0 23744.2 23879.2 23901.6 23911.4 18:03:07 INFO - 2015-12-17 18:03:07,431 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,432 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26006.04 Median:3710.86 stddev:77605.66 (2091.3%) stddev-sans-first:77799.39 18:03:07 INFO - 2015-12-17 18:03:07,432 DEBUG : BROWSER_OUTPUT: Values: 318.2 323.2 324.0 326.5 327.0 12397.9 12714.2 14663.8 14814.1 15162.4 12235.8 14719.6 14930.2 15405.0 15408.6 4823.7 4828.5 4946.5 4951.0 4965.9 3655.8 3765.9 4909.1 4956.8 5577.4 5676.0 5701.7 5723.1 5724.3 5726.5 5535.3 5687.4 5716.0 5716.1 5722.4 5067.5 5067.9 5076.4 5077.6 5078.8 18892.2 19086.7 19280.2 19290.0 19391.0 1820.8 1877.2 1920.9 1943.8 1990.4 12086.0 12476.9 12643.2 12776.6 13042.9 1636.1 1697.4 1746.5 1753.6 1769.2 53397.9 54868.5 55292.0 55466.2 55660.2 8868.2 9066.2 9352.7 9385.1 9420.8 11974.5 11975.6 11981.6 11990.4 12012.2 6899.9 6924.4 6977.9 7049.6 7111.0 6335.1 6388.8 6401.9 6401.9 6521.2 5591.8 5680.3 5719.1 5732.3 5785.8 1486.0 1515.3 1547.7 1567.6 1571.2 816.4 834.0 869.0 934.0 985.8 15935.4 16283.6 16460.8 16577.5 16674.9 766.5 804.4 807.8 862.4 882.5 8514.7 8922.2 9060.7 9133.8 9327.8 466388.0 467478.0 470272.0 474889.0 495542.0 71053.6 71562.6 73820.6 74281.0 74425.6 1050.6 1065.9 1080.4 1081.8 1084.5 14311.8 14403.5 14575.9 14735.9 15092.0 32777.7 32951.8 33404.0 33757.5 34056.0 41803.0 42390.6 42421.0 43335.6 43521.8 8305.4 8383.9 8555.6 8621.8 8672.7 10055.3 10129.4 10178.1 10208.4 14459.7 13385.3 13386.0 13614.8 13740.2 13957.4 12909.5 13262.9 13281.8 13742.5 13837.6 10682.3 13750.0 13888.4 14299.1 14435.4 8672.8 8745.3 8811.3 8870.9 8906.4 12661.2 13715.8 13892.9 13936.7 14272.6 18:03:07 INFO - 2015-12-17 18:03:07,432 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,433 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5004.45 Median:6226.44 stddev:2615.59 (42.0%) stddev-sans-first:2607.67 18:03:07 INFO - 2015-12-17 18:03:07,433 DEBUG : BROWSER_OUTPUT: Values: 1245.8 1667.6 1691.4 1732.8 1736.5 6038.6 6835.8 7014.6 7023.2 7035.8 7106.5 7215.6 7280.4 7282.5 7294.4 2001.3 2031.6 2033.1 2034.4 2036.5 2051.8 2079.7 2090.7 2117.8 2121.3 2006.5 2017.6 2028.9 2039.5 2043.6 2027.5 2054.5 2055.8 2056.4 2056.7 2016.6 2035.2 2038.5 2039.7 2040.0 7143.4 7211.9 7228.4 7230.7 7235.7 4087.2 4111.8 4116.2 4155.5 4157.9 2630.1 2645.5 2668.2 2683.9 2689.6 876.7 886.3 895.0 903.9 917.8 9430.3 9443.0 9463.6 9465.3 9501.2 3688.8 3689.0 3772.2 3796.7 3800.1 8238.2 8246.3 8251.1 8251.5 8271.3 4097.4 4100.7 4123.1 4124.8 4134.8 3204.1 3277.0 3651.6 3712.4 3762.9 3410.7 3441.7 3456.0 3473.9 3499.9 1091.2 1093.2 1098.3 1106.5 1117.7 837.3 915.8 924.8 975.8 1162.9 6697.9 6831.5 6834.8 6847.7 6852.5 1021.3 1022.7 1028.5 1034.9 1053.5 5297.0 5315.9 5333.1 5346.7 5348.8 8155.4 8493.3 8513.6 8753.4 8791.3 8593.3 8740.3 8767.1 8775.5 8779.1 6796.6 6821.2 6899.7 6910.5 6922.6 6845.7 6863.6 6895.9 6901.3 6903.7 7718.6 7747.9 7778.7 7795.8 7796.4 7914.3 8045.3 8140.1 8181.8 8193.3 6219.4 6233.4 6316.5 6320.6 6324.2 7009.8 7130.4 7131.8 7135.2 7141.2 6595.5 6708.5 6723.6 6751.6 6838.4 5583.9 5851.9 6105.7 6239.2 6401.1 6254.6 6473.5 6506.1 6533.9 6546.2 6001.1 6024.1 6027.4 6031.3 6051.1 6037.1 6046.9 6083.6 6085.8 6098.8 18:03:07 INFO - 2015-12-17 18:03:07,433 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,433 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4621.55 Median:5211.77 stddev:1349.95 (25.9%) stddev-sans-first:1314.18 18:03:07 INFO - 2015-12-17 18:03:07,433 DEBUG : BROWSER_OUTPUT: Values: 299.7 301.9 305.2 305.9 309.1 5214.6 5255.9 5287.7 5300.8 5309.9 5193.8 5199.2 5208.9 5216.6 5237.1 3879.2 4089.7 4090.5 4094.7 4098.7 3965.5 4012.1 4127.6 4130.5 4139.0 4060.1 4074.9 4077.0 4079.9 4082.6 3813.5 3920.9 3956.9 4072.4 4072.8 3600.7 3600.9 3612.6 3625.8 3632.2 5054.1 5056.7 5078.0 5085.6 5086.2 4706.3 4715.3 4718.6 4721.7 4723.1 5404.4 5516.8 5519.5 5535.0 5537.0 3932.8 3935.0 3937.7 3942.9 3947.8 5731.9 5816.1 5822.9 5829.7 5831.6 4084.0 4088.6 4089.3 4089.5 4090.8 4023.8 4146.0 4147.8 4150.4 4152.0 4688.7 4693.2 4695.7 4697.6 4700.4 5546.9 5555.6 5559.1 5560.2 5562.7 1446.0 1466.6 1468.3 1468.9 1470.0 997.0 997.6 1002.1 1022.7 1031.8 4857.5 4863.7 4865.0 4866.0 4870.6 5733.3 5764.0 5769.3 5776.7 5780.0 4858.5 4860.0 4866.6 4866.9 4869.2 3031.7 3084.1 3110.8 3112.1 3113.1 5490.9 5493.7 5500.2 5505.0 5515.3 5923.5 5940.3 5941.7 5945.0 5952.8 5468.5 5489.9 5501.1 5501.4 5516.1 5664.6 5804.1 5807.6 5814.7 5819.5 5655.7 5665.3 5665.9 5671.3 5674.3 5477.6 5492.3 5492.9 5495.6 5501.5 3901.2 3949.8 3979.4 3990.5 3997.0 5789.2 5795.5 5797.7 5798.4 5808.0 5573.2 5574.6 5581.0 5581.5 5588.0 5575.7 5586.0 5586.8 5592.3 5593.4 5275.9 5461.6 5461.7 5463.0 5463.9 5401.8 5524.6 5610.4 5619.1 5622.0 5334.4 5464.9 5496.7 5497.1 5498.3 18:03:07 INFO - 2015-12-17 18:03:07,434 DEBUG : BROWSER_OUTPUT: 18:03:07 INFO - 2015-12-17 18:03:07,434 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11588.41 Median:22946.62 stddev:12969.02 (56.5%) stddev-sans-first:12979.66 18:03:07 INFO - 2015-12-17 18:03:07,435 DEBUG : BROWSER_OUTPUT: Values: 707.7 712.4 731.7 738.4 748.1 10408.2 10645.6 10668.0 10677.1 10685.4 11251.9 11412.3 11416.3 11419.5 11446.4 621.6 628.2 773.4 778.8 791.1 786.7 790.4 792.3 794.3 794.9 658.9 832.7 837.1 838.6 839.4 654.5 815.7 828.0 828.6 830.7 616.4 618.5 618.6 620.5 621.9 10938.6 10942.3 11001.8 11050.5 11075.6 10828.2 11284.2 11305.1 11387.4 11490.4 8751.6 8839.6 9068.9 9157.5 9225.7 3067.7 3140.9 3141.2 3149.0 3195.9 37896.8 37906.2 38068.4 38333.8 38601.6 8749.2 9090.3 9172.1 9216.4 9227.9 16349.3 16383.8 16423.3 16424.0 16426.5 5993.2 6166.9 6208.4 6259.9 6299.6 3178.4 3233.1 3268.8 3329.4 3344.0 2373.6 2392.6 2405.8 2410.7 2411.3 448.0 449.8 454.2 455.8 456.6 431.1 489.4 517.6 520.5 570.3 6712.3 6875.2 6887.6 7158.7 7171.4 423.9 425.2 470.8 478.9 518.5 3333.8 3384.2 3420.4 3461.4 3462.0 44405.0 44803.0 45134.0 45223.3 45439.0 39991.4 41156.2 41245.0 41433.2 41822.8 38437.6 38457.4 38768.0 39024.2 39247.6 7112.9 7527.5 7609.2 7663.9 7716.6 29504.0 29668.0 30105.1 30425.7 30434.7 34468.0 34798.0 40941.0 40956.6 42151.8 9463.8 9646.0 9654.0 9692.6 9701.8 10596.3 10602.4 10707.3 11063.6 11507.0 9739.4 9857.5 9989.6 10117.8 10138.3 9743.7 9799.9 9819.0 10025.5 10030.0 9489.4 9615.9 9736.9 10034.9 10067.3 8548.8 8846.2 9026.4 9032.4 9045.4 8600.1 8786.8 8837.2 8841.4 8993.6 18:03:07 INFO - 2015-12-17 18:03:07,435 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:03:07 INFO - 2015-12-17 18:03:07,435 DEBUG : BROWSER_OUTPUT: 18:03:08 INFO - 2015-12-17 18:03:08,197 INFO : Browser exited with error code: 0 18:03:08 INFO - 2015-12-17 18:03:08,216 INFO : Completed test dromaeo_css (00:18:37) 18:03:08 INFO - 2015-12-17 18:03:08,216 INFO : Starting test kraken 18:03:08 INFO - 2015-12-17 18:03:08,216 DEBUG : operating with platform_type : linux_ 18:03:08 INFO - 2015-12-17 18:03:08,216 INFO : Initialising browser for kraken test... 18:03:08 INFO - 2015-12-17 18:03:08,222 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhmpJ4/profile http://localhost:41140/getInfo.html 18:03:12 INFO - 2015-12-17 18:03:12,626 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:03:12 INFO - 2015-12-17 18:03:12,626 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:03:12 INFO - 2015-12-17 18:03:12,626 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:03:12 INFO - 2015-12-17 18:03:12,626 DEBUG : BROWSER_OUTPUT: __metrics 18:03:12 INFO - 2015-12-17 18:03:12,702 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] 18:03:12 INFO - 2015-12-17 18:03:12,791 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] 18:03:13 INFO - 2015-12-17 18:03:13,792 INFO : Browser initialized. 18:03:13 INFO - 2015-12-17 18:03:13,793 INFO : Running cycle 1/1 for kraken test... 18:03:13 INFO - 2015-12-17 18:03:13,793 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhmpJ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:03:25 INFO - 2015-12-17 18:03:25,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 149614592 18:03:25 INFO - 2015-12-17 18:03:25,753 DEBUG : BROWSER_OUTPUT: 18:03:28 INFO - 2015-12-17 18:03:28,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41140/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:28 INFO - 2015-12-17 18:03:28,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 185040896 18:03:28 INFO - 2015-12-17 18:03:28,942 DEBUG : BROWSER_OUTPUT: 18:03:31 INFO - 2015-12-17 18:03:31,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41140/tests/kraken/driver.html?testName=audio-dft) 18:03:32 INFO - 2015-12-17 18:03:32,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 174911488 18:03:32 INFO - 2015-12-17 18:03:32,286 DEBUG : BROWSER_OUTPUT: 18:03:35 INFO - 2015-12-17 18:03:35,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41140/tests/kraken/driver.html?testName=audio-fft) 18:03:35 INFO - 2015-12-17 18:03:35,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 161341440 18:03:35 INFO - 2015-12-17 18:03:35,854 DEBUG : BROWSER_OUTPUT: 18:03:37 INFO - 2015-12-17 18:03:37,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41140/tests/kraken/driver.html?testName=audio-oscillator) 18:03:38 INFO - 2015-12-17 18:03:38,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 163856384 18:03:38 INFO - 2015-12-17 18:03:38,467 DEBUG : BROWSER_OUTPUT: 18:03:40 INFO - 2015-12-17 18:03:40,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:41 INFO - 2015-12-17 18:03:41,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 164532224 18:03:41 INFO - 2015-12-17 18:03:41,302 DEBUG : BROWSER_OUTPUT: 18:03:44 INFO - 2015-12-17 18:03:44,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41140/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:44 INFO - 2015-12-17 18:03:44,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 165150720 18:03:44 INFO - 2015-12-17 18:03:44,867 DEBUG : BROWSER_OUTPUT: 18:03:48 INFO - 2015-12-17 18:03:48,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41140/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:48 INFO - 2015-12-17 18:03:48,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 166305792 18:03:48 INFO - 2015-12-17 18:03:48,818 DEBUG : BROWSER_OUTPUT: 18:03:51 INFO - 2015-12-17 18:03:51,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41140/tests/kraken/driver.html?testName=json-parse-financial) 18:03:52 INFO - 2015-12-17 18:03:52,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 166928384 18:03:52 INFO - 2015-12-17 18:03:52,233 DEBUG : BROWSER_OUTPUT: 18:03:54 INFO - 2015-12-17 18:03:54,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:54 INFO - 2015-12-17 18:03:54,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 174018560 18:03:54 INFO - 2015-12-17 18:03:54,579 DEBUG : BROWSER_OUTPUT: 18:03:56 INFO - 2015-12-17 18:03:56,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:57 INFO - 2015-12-17 18:03:57,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 172662784 18:03:57 INFO - 2015-12-17 18:03:57,065 DEBUG : BROWSER_OUTPUT: 18:03:59 INFO - 2015-12-17 18:03:59,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:59 INFO - 2015-12-17 18:03:59,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 183037952 18:03:59 INFO - 2015-12-17 18:03:59,726 DEBUG : BROWSER_OUTPUT: 18:04:02 INFO - 2015-12-17 18:04:02,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:02 INFO - 2015-12-17 18:04:02,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 187912192 18:04:02 INFO - 2015-12-17 18:04:02,855 DEBUG : BROWSER_OUTPUT: 18:04:05 INFO - 2015-12-17 18:04:05,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:06 INFO - 2015-12-17 18:04:06,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 188231680 18:04:06 INFO - 2015-12-17 18:04:06,029 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41140/tests/kraken/driver.html?testName=ai-astar) 18:04:08 INFO - 2015-12-17 18:04:08,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 246149120 18:04:08 INFO - 2015-12-17 18:04:08,056 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,056 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:04:08 INFO - 2015-12-17 18:04:08,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;114;113;102;112;112;103 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;134;151;164;133;157;162;132;170;129 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;164;160;161;162;161;160 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;96;71;72;72;117;92;71 18:04:08 INFO - 2015-12-17 18:04:08,057 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;135;101;95;95;131;94;95;135 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;109;110;110;109;110;110 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;150;146;147;146;147;147;147;146 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;72;71;72;73;74;79;71;72 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;68;68;68;68;71;69 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;85;83;82;83;82;82;84;83;82 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;125;133;115;123;127;121;135;127;122 18:04:08 INFO - 2015-12-17 18:04:08,058 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;146;146;148;151;138;159;148;147;139 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;71;71;70;72;69;68;68;71 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404248051__endTimestamp 18:04:08 INFO - 2015-12-17 18:04:08,059 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 114.0 113.0 102.0 112.0 112.0 103.0 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.70 Median:156.00 stddev:15.30 (9.8%) stddev-sans-first:16.06 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: Values: 155.0 134.0 151.0 164.0 133.0 157.0 162.0 132.0 170.0 129.0 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 18:04:08 INFO - 2015-12-17 18:04:08,063 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 164.0 160.0 161.0 162.0 161.0 160.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:72.50 stddev:15.45 (21.3%) stddev-sans-first:15.96 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 96.0 71.0 72.0 72.0 117.0 92.0 71.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.00 stddev:18.62 (19.8%) stddev-sans-first:19.15 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 135.0 101.0 95.0 95.0 131.0 94.0 95.0 135.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 150.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:04:08 INFO - 2015-12-17 18:04:08,064 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:2.35 (3.3%) stddev-sans-first:2.47 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 71.0 72.0 73.0 74.0 79.0 71.0 72.0 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 71.0 69.0 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:1.05 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: Values: 80.0 85.0 83.0 82.0 83.0 82.0 82.0 84.0 83.0 82.0 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.50 stddev:5.78 (4.6%) stddev-sans-first:6.12 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: Values: 126.0 125.0 133.0 115.0 123.0 127.0 121.0 135.0 127.0 122.0 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.50 stddev:6.96 (4.7%) stddev-sans-first:6.21 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: Values: 135.0 146.0 146.0 148.0 151.0 138.0 159.0 148.0 147.0 139.0 18:04:08 INFO - 2015-12-17 18:04:08,065 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,066 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.37 (1.9%) stddev-sans-first:1.45 18:04:08 INFO - 2015-12-17 18:04:08,066 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 71.0 70.0 72.0 69.0 68.0 68.0 71.0 18:04:08 INFO - 2015-12-17 18:04:08,066 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:04:08 INFO - 2015-12-17 18:04:08,066 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,937 INFO : Browser exited with error code: 0 18:04:08 INFO - 2015-12-17 18:04:08,988 INFO : Completed test kraken (00:01:00) 18:04:08 INFO - 2015-12-17 18:04:08,988 INFO : Starting test v8_7 18:04:08 INFO - 2015-12-17 18:04:08,988 DEBUG : operating with platform_type : linux_ 18:04:08 INFO - 2015-12-17 18:04:08,988 INFO : Initialising browser for v8_7 test... 18:04:08 INFO - 2015-12-17 18:04:08,994 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjTnxt/profile http://localhost:41140/getInfo.html 18:04:13 INFO - 2015-12-17 18:04:13,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:04:13 INFO - 2015-12-17 18:04:13,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:04:13 INFO - 2015-12-17 18:04:13,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:04:13 INFO - 2015-12-17 18:04:13,095 DEBUG : BROWSER_OUTPUT: __metrics 18:04:13 INFO - 2015-12-17 18:04:13,171 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] 18:04:13 INFO - 2015-12-17 18:04:13,232 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] 18:04:14 INFO - 2015-12-17 18:04:14,464 INFO : Browser initialized. 18:04:14 INFO - 2015-12-17 18:04:14,464 INFO : Running cycle 1/1 for v8_7 test... 18:04:14 INFO - 2015-12-17 18:04:14,464 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjTnxt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:04:26 INFO - 2015-12-17 18:04:26,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 149426176 18:04:26 INFO - 2015-12-17 18:04:26,465 DEBUG : BROWSER_OUTPUT: 18:04:47 INFO - 2015-12-17 18:04:47,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41140/tests/v8_7/run.html (next: http://localhost:41140/tests/v8_7/run.html) 18:04:48 INFO - 2015-12-17 18:04:48,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 450699264 18:04:48 INFO - 2015-12-17 18:04:48,109 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:04:48 INFO - 2015-12-17 18:04:48,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |0;Richards;168.0672268907563 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.32246108228318 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 18:04:48 INFO - 2015-12-17 18:04:48,111 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: |6;Boyer;12353.658536585366 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: |8;Splay;618.8118811881188 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:04:48 INFO - 2015-12-17 18:04:48,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404288109__endTimestamp 18:04:48 INFO - 2015-12-17 18:04:48,113 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:04:48 INFO - 2015-12-17 18:04:48,114 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:04:48 INFO - 2015-12-17 18:04:48,114 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,115 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.07 Median:168.07 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,115 DEBUG : BROWSER_OUTPUT: Values: 168.1 18:04:48 INFO - 2015-12-17 18:04:48,115 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,115 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.32 Median:185.32 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,115 DEBUG : BROWSER_OUTPUT: Values: 185.3 18:04:48 INFO - 2015-12-17 18:04:48,116 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,116 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,116 DEBUG : BROWSER_OUTPUT: Values: 277.6 18:04:48 INFO - 2015-12-17 18:04:48,116 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,116 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: Values: 5122.4 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: Values: 2032.5 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: Values: 790.5 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,117 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: Values: 12353.7 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: Values: 27081.1 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.81 Median:618.81 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: Values: 618.8 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,118 DEBUG : BROWSER_OUTPUT: Values: 4826.9 18:04:48 INFO - 2015-12-17 18:04:48,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:04:48 INFO - 2015-12-17 18:04:48,119 DEBUG : BROWSER_OUTPUT: 18:04:49 INFO - 2015-12-17 18:04:49,017 INFO : Browser exited with error code: 0 18:04:49 INFO - 2015-12-17 18:04:49,032 INFO : Completed test v8_7 (00:00:40) 18:04:49 INFO - 2015-12-17 18:04:49,161 INFO : Completed test suite (00:20:18) 18:04:49 INFO - 2015-12-17 18:04:49,161 DEBUG : Working with test: dromaeo_css 18:04:49 INFO - 2015-12-17 18:04:49,161 DEBUG : Generating results file: dromaeo_css 18:04:49 INFO - 2015-12-17 18:04:49,162 DEBUG : Working with test: kraken 18:04:49 INFO - 2015-12-17 18:04:49,162 DEBUG : Generating results file: kraken 18:04:49 INFO - 2015-12-17 18:04:49,163 INFO : javascript benchmark 18:04:49 INFO - 2015-12-17 18:04:49,163 DEBUG : Working with test: v8_7 18:04:49 INFO - 2015-12-17 18:04:49,163 DEBUG : Generating results file: v8_7 18:04:49 INFO - 2015-12-17 18:04:49,163 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,223 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:04:49 INFO - 2015-12-17 18:04:49,223 DEBUG : process_Request line: dromaeo_css 6260.09 graph.html#tests=[[72,132,35]] 18:04:49 INFO - 2015-12-17 18:04:49,223 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,256 DEBUG : process_Request line: kraken 1525.10 graph.html#tests=[[232,132,35]] 18:04:49 INFO - 2015-12-17 18:04:49,256 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,288 DEBUG : process_Request line: v8_7 19689.90 graph.html#tests=[[230,132,35]] 18:04:49 INFO - 2015-12-17 18:04:49,289 INFO : javascript benchmark 18:04:49 INFO - 2015-12-17 18:04:49,293 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2605.452854900471, 2683.498827403823, 2696.366353906833, 2706.1475635174907, 2712.186344096771, 4457.375967364572, 4595.379623750792, 4678.766061696914, 4679.929801052983, 4681.765911704414, 4549.977250113753, 4583.977080114595, 4657.55753203446, 4665.580097791198, 4710.317004034421, 4337.522872484024, 4344.261475549164, 4348.173846969065, 4362.825486980517, 4369.737815731066, 4146.419501269825, 4377.4528183977, 4378.452693413324, 4427.911441771163, 4440.533743956887, 4217.0, 4281.422008028907, 4284.721493102954, 4330.826766929319, 4338.609525142752, 4280.6361459275995, 4283.164782867342, 4290.721103128287, 4322.82708691652, 4334.046509767846, 4158.584141585848, 4294.334378171388, 4298.31227003681, 4299.355096735483, 4346.217680817452, 4606.516315786827, 4612.723236605781, 4620.768961551943, 4715.64632652549, 4749.121412538657, 5061.898762024739, 5092.79628814847, 5092.872678183038, 5094.77073531692, 5131.820386286499, 4818.084563932842, 5105.5915526758145, 5110.923336149961, 5115.693058416469, 5116.309298244763, 4563.885902852388, 4602.378678878342, 4618.330342100377, 4625.444946606362, 4679.81280748773, 5203.73981300941, 5220.843374698765, 5227.817026404134, 5231.450697676765, 5235.554977826928, 4710.4347478302825, 5002.324686167393, 5006.89986200274, 5059.316992206005, 5062.038212739568, 4885.877853053631, 4924.679895806761, 4949.109160351171, 4968.453470118357, 5012.198048312325, 4980.452150263468, 4981.153203955337, 4982.451930287665, 4985.351904252497, 5030.0, 4937.407511098691, 4942.678725882806, 4943.678660887031, 4955.2567114933045, 4985.376827896513, 4008.719389642697, 4079.1637714268504, 4118.382242663624, 4118.91762164755, 4136.048708796933, 3670.724695647784, 3690.372636651776, 3693.4459831025024, 3694.039549717093, 3698.0754811297174, 4195.7692326922315, 4247.065645558034, 4250.4474418326035, 4252.107057517894, 4304.935425968613, 5074.314967479417, 5102.158143906288, 5127.0, 5133.281340612317, 5138.3577052868395, 4329.956700432956, 4358.302671572596, 4379.824807007748, 4410.051838854662, 4420.9115817684105, 4204.180184863983, 4357.7385356878685, 4365.781710914442, 4521.186186486399, 4524.25349817283, 4733.857984260478, 4825.879353016203, 4830.589399901048, 4836.782344794422, 4876.683015603974, 5057.595392368676, 5062.949370506248, 5065.848024559269, 5067.493250674903, 5109.310243117132, 4565.817367305403, 4615.88460288482, 4668.6498512611015, 4800.903981920412, 4846.151923413318, 4860.270959355983, 4885.975570122127, 4946.604271658187, 4960.330355402119, 4993.550580447777, 5057.216131499624, 5065.265536497261, 5066.341375621146, 5071.416787069386, 5111.795528178831, 4715.6699031068865, 4908.141075311734, 4909.091818013679, 4910.165271903714, 4948.109340318777, 4764.737939413366, 4813.614910807197, 4829.5653391194965, 4839.322494850794, 4894.388201474816, 4795.520447955177, 4799.136155492045, 4812.278158276286, 4832.0, 4848.854534363974, 4748.477667456508, 4904.288878112725, 4904.509549045067, 4921.360223170965, 4952.133376659142, 4714.457837348748, 4715.552022557851, 4751.263554149113, 4869.4400143982475, 4879.536444037811], "unit": "score", "name": "dojo.html", "value": 4597.1892392599875}, {"lowerIsBetter": false, "replicates": [542.1840130603441, 552.7484994327581, 555.5472290083583, 563.7688547695443, 572.5219441766125, 26515.734842651567, 34420.655793442056, 35237.295254094905, 35289.47065794015, 35418.114547136334, 39442.0, 39988.60011399885, 39991.40012899809, 40024.19951600966, 40050.19899602006, 7066.646667666596, 7204.423646108299, 7953.840923181548, 8130.674773009102, 8138.3896207784355, 10335.0, 10575.629852955148, 10578.206634502405, 10579.259451838374, 10587.417692026935, 10199.0, 10348.327358721697, 10364.0, 10367.948160259188, 10372.53323600436, 7332.340089391981, 7480.551166930001, 10104.49477526128, 10137.239707021967, 10406.635767748168, 10018.298719089667, 10156.187504999656, 10157.593696252141, 10159.949200254025, 10164.288499805016, 36130.73542426029, 36624.0, 36638.81680591607, 36662.450063249074, 36674.08314792125, 2784.429192015632, 2830.3348713052414, 2941.7793665475174, 3474.166200111955, 3510.1224693826543, 27688.0, 28099.157025289274, 28200.717992820013, 28242.85878570594, 28714.569281460794, 3449.1032331593715, 3454.084667563098, 3507.2108775525303, 3571.357155711971, 3573.4997100405963, 218726.0, 220330.0, 220717.0, 220826.0, 224127.87936060378, 50193.48645594846, 51597.48402516002, 53497.1975420369, 53967.0, 55197.72401137969, 47711.5228847714, 47786.28320575194, 47824.32614858463, 48041.75979120152, 48120.27819582709, 12829.23024618526, 13095.148815326973, 13099.0, 13100.0, 13132.540361087507, 9752.95123524392, 9870.062344077302, 9895.0, 9900.207983361313, 9930.652427165014, 18103.63792724138, 18314.63370732578, 18356.632867342578, 18366.90816545909, 18368.173432195315, 7068.3702175075405, 7253.419726421874, 7458.888116678254, 7471.215522370181, 7487.3261406473675, 845.9280961118251, 860.875173099897, 910.7586489580267, 945.4280160502797, 1006.993006993007, 26082.217533474028, 26438.6034209487, 27758.306042349104, 28338.716612833607, 29111.417771644872, 954.4321128928276, 987.6543209876629, 1089.6349722842779, 1096.8957948994832, 1106.1482658353023, 12741.426635801226, 12816.93591532055, 12847.421866016051, 12848.357582121043, 12987.155834870891, 262592.0, 263153.0, 266068.0, 267036.0, 267233.0, 42833.0, 43124.706258812286, 43195.568044319785, 43287.134257314676, 43293.0, 1048.1928914735763, 1202.290648517379, 1229.9631011069682, 1245.2964075297427, 1247.600767754328, 18545.35091271799, 24805.0, 24833.0, 25029.624555632043, 25230.74769252284, 37797.24405511929, 38088.809555952044, 38287.61712382841, 38384.0, 38447.0, 206655.0, 209059.0, 218219.0, 221873.0, 241105.0, 25730.87134564315, 25762.0, 25846.353841154123, 26139.0, 26288.211353659422, 37475.625243747214, 37953.81023094867, 38235.80882095572, 38579.80710096544, 38852.41721374125, 31782.205444864063, 31804.204894877814, 31941.520877187326, 32820.179495512806, 32973.50539741954, 32977.67022329746, 33181.33637327288, 33193.17017074592, 37389.626103738614, 40169.79915100406, 34225.82887085548, 40595.18809623732, 41113.1777364457, 41488.79255603703, 41702.79148604238, 34069.48895766516, 35466.468002980495, 35899.28201435904, 36440.0, 36471.27057458783, 23231.0, 23744.168954086523, 23879.16422925189, 23901.641475377535, 23911.402214944766], "unit": "score", "name": "ext.html", "value": 17050.504319623193}, {"lowerIsBetter": false, "replicates": [318.21877291249984, 323.1515730024261, 324.02953155299866, 326.4955643530745, 327.0482894776201, 12397.876021239785, 12714.173578717377, 14663.780043299359, 14814.111153330809, 15162.39350425983, 12235.755284894296, 14719.632009199748, 14930.178840163786, 15405.0, 15408.614784630361, 4823.686460380064, 4828.5412885775795, 4946.505349465061, 4951.0, 4965.875853103666, 3655.798931058791, 3765.9246815063684, 4909.116359055369, 4956.752162391884, 5577.414371490996, 5675.971620141893, 5701.714914254291, 5723.141528770697, 5724.284464441945, 5726.484616384525, 5535.25274087999, 5687.402822703619, 5716.028275193206, 5716.056850619642, 5722.399148089432, 5067.49325067494, 5067.923981140286, 5076.390833100052, 5077.5684066854365, 5078.847634570969, 18892.244310227576, 19086.713699294523, 19280.22879084835, 19290.0, 19391.0, 1820.7997120316754, 1877.239717914247, 1920.9135588898394, 1943.834774044208, 1990.4327266728912, 12086.0, 12476.937615311956, 12643.178193417398, 12776.61670149897, 13042.869571304354, 1636.108320965077, 1697.3804561335148, 1746.4847869878417, 1753.6142048749255, 1769.2127003483456, 53397.937632003974, 54868.45131548673, 55292.0, 55466.16800747992, 55660.16509752357, 8868.246199073023, 9066.22937050358, 9352.719418417459, 9385.108414700593, 9420.811583768285, 11974.521019159136, 11975.580854670045, 11981.580644677395, 11990.400479975966, 12012.159148859671, 6899.896501552481, 6924.446044316443, 6977.860442791217, 7049.612271325126, 7110.964445177844, 6335.1447554579545, 6388.776392826228, 6401.871962560723, 6401.9039714404325, 6521.152250207443, 5591.776328946878, 5680.346760122638, 5719.056355701346, 5732.3121225453215, 5785.797497087666, 1485.9777103343458, 1515.3181068519211, 1547.6517783498623, 1567.6002619331998, 1571.2143928035982, 816.3754727633366, 834.0, 868.9522076285865, 934.0286102453508, 985.7929834734642, 15935.442259520862, 16283.59291017734, 16460.83539164617, 16577.50267491977, 16674.916625416794, 766.4979438467813, 804.3766081287049, 807.7738233294687, 862.3877047296489, 882.5190271302156, 8514.74455766328, 8922.197002269697, 9060.682876099305, 9133.77165570866, 9327.766805829908, 466388.0, 467478.0, 470272.0, 474889.0, 495542.0, 71053.644731776, 71562.64218678873, 73820.63089684518, 74281.0, 74425.6278718603, 1050.5640159333943, 1065.8934106589434, 1080.4273734920662, 1081.8269076947652, 1084.4631907205983, 14311.785323220369, 14403.495877644651, 14575.897202933469, 14735.92632036833, 15092.0, 32777.67222327746, 32951.835240823646, 33403.99788006364, 33757.49363759496, 34056.0, 41802.95492612709, 42390.57609423866, 42421.0, 43335.56664433315, 43521.78239108784, 8305.37709671765, 8383.916160838558, 8555.57222138903, 8621.827563448822, 8672.696455624024, 10055.29612927088, 10129.392236465541, 10178.13485853681, 10208.438535880598, 14459.710805784036, 13385.263810490516, 13386.0, 13614.842738366953, 13740.175589464665, 13957.441702331793, 12909.483620655068, 13262.867371326163, 13281.80077298822, 13742.519011834538, 13837.584872453843, 10682.305650132717, 13750.0, 13888.375023124187, 14299.07056041354, 14435.3504092314, 8672.841954934882, 8745.256653184297, 8811.33914956368, 8870.86693699582, 8906.421082629608, 12661.177023493443, 13715.794263086262, 13892.93053534726, 13936.651583710489, 14272.643183920485], "unit": "score", "name": "jquery.html", "value": 8269.33665251869}, {"lowerIsBetter": false, "replicates": [1245.7757603631353, 1667.624784423505, 1691.42491552872, 1732.7660765796613, 1736.4703765351567, 6038.637681739093, 6835.794926152217, 7014.614196219206, 7023.19233288172, 7035.824104397393, 7106.467014973872, 7215.567065976045, 7280.417566594673, 7282.490225684204, 7294.3799777018885, 2001.3495613925495, 2031.5936812637458, 2033.1359172351692, 2034.410021093881, 2036.4501584572156, 2051.7537895452565, 2079.6984437256588, 2090.6550419180817, 2117.819985301251, 2121.2681624839406, 2006.5485265815148, 2017.5561376497146, 2028.9289874854383, 2039.4901274681329, 2043.632146213681, 2027.472857057161, 2054.5377290109604, 2055.835533157351, 2056.3830850744716, 2056.7120603115577, 2016.6168427998634, 2035.216441669953, 2038.4598081508263, 2039.7042428847733, 2040.0207900207984, 7143.357097861165, 7211.927880721178, 7228.421726261939, 7230.746923857692, 7235.71057157713, 4087.223427548786, 4111.814968326433, 4116.238495878272, 4155.480564929384, 4157.875263742093, 2630.1320564213956, 2645.4576811753545, 2668.159529748123, 2683.9194824155306, 2689.556223223166, 876.6537217798998, 886.3396769406833, 894.9821003579892, 903.8870141232346, 917.807260475301, 9430.339876208669, 9442.952785236099, 9463.574139163755, 9465.290103242285, 9501.192398646124, 3688.834002469842, 3689.0, 3772.1512659651908, 3796.677282431024, 3800.144967382372, 8238.217369349903, 8246.340292776684, 8251.092379838214, 8251.463654862415, 8271.296939760188, 4097.364908439196, 4100.65144462724, 4123.113530590937, 4124.752514849119, 4134.793260336971, 3204.070819462376, 3276.983615081909, 3651.634836516327, 3712.424574190951, 3762.887113386603, 3410.6759857813468, 3441.741869359808, 3456.0495863637198, 3473.913152171216, 3499.8950031499094, 1091.1816137896578, 1093.1746531368924, 1098.3025778630467, 1106.4744246483017, 1117.7038084907506, 837.2757564706607, 915.844306467902, 924.7503174142944, 975.7755716185317, 1162.8778978207336, 6697.8995315070315, 6831.487638427137, 6834.829129271709, 6847.691853866588, 6852.45180385568, 1021.3361315145215, 1022.7392015036119, 1028.4857571214393, 1034.8809886863107, 1053.4785281285813, 5296.9670914171365, 5315.867103322448, 5333.093374126408, 5346.705931173823, 5348.839534813962, 8155.388345874083, 8493.27807136388, 8513.616887240089, 8753.431026983226, 8791.34064945119, 8593.269572086443, 8740.300775937909, 8767.123287671182, 8775.473471591726, 8779.122087791298, 6796.626185559841, 6821.21556021054, 6899.689513971884, 6910.516263861481, 6922.58464492132, 6845.726170953305, 6863.553868998499, 6895.931040689529, 6901.275366086488, 6903.689333980084, 7718.575478348745, 7747.922520774946, 7778.688852445839, 7795.805104872424, 7796.376289896682, 7914.287714105758, 8045.275925166529, 8140.063892652421, 8181.79545511367, 8193.303569196447, 6219.440250377488, 6233.438990490878, 6316.526260530571, 6320.5575609706875, 6324.177856878577, 7009.754658586925, 7130.429565634633, 7131.821704457223, 7135.215126336203, 7141.214466408587, 6595.472362211108, 6708.463322934056, 6723.562968407038, 6751.594904305757, 6838.384545390939, 5583.8883222336135, 5851.853703657443, 6105.664188469676, 6239.220097487814, 6401.071844582602, 6254.562180647311, 6473.514486413444, 6506.089147519446, 6533.934660653523, 6546.18172728409, 6001.06983417571, 6024.096385542204, 6027.427394397525, 6031.306399764083, 6051.0923361496125, 6037.124616930609, 6046.879062418815, 6083.6045657032155, 6085.786997455068, 6098.786542470993], "unit": "score", "name": "mootools.html", "value": 4097.32169472511}, {"lowerIsBetter": false, "replicates": [299.68982103522853, 301.91697283247106, 305.19276513621475, 305.88809676824764, 309.0835672231832, 5214.582833373331, 5255.92116118258, 5287.682739035656, 5300.787968481256, 5309.920351194735, 5193.792248310073, 5199.194124910636, 5208.947910520894, 5216.556592689616, 5237.083510385686, 3879.1659793144468, 4089.734167279132, 4090.4886889138857, 4094.651954583864, 4098.733582317155, 3965.4646622705854, 4012.0972781124306, 4127.607877251657, 4130.463039804837, 4139.048018955642, 4060.1473690525027, 4074.9185016299803, 4076.9796151019204, 4079.9184016319655, 4082.5509193988637, 3813.504244448232, 3920.9019774505864, 3956.940645890314, 4072.4095006223934, 4072.7963601819793, 3600.747947643666, 3600.873969411058, 3612.6387361263664, 3625.782453052825, 3632.1827588792576, 5054.115529782273, 5056.721880296583, 5077.984403119354, 5085.618578606619, 5086.237064440326, 4706.270528068155, 4715.269133284346, 4718.598919091882, 4721.693089949143, 4723.126221649006, 5404.351477822647, 5516.779328826882, 5519.530839878616, 5535.0, 5537.003339398907, 3932.842686292545, 3934.980325098385, 3937.6652984496354, 3942.9014274643077, 3947.782871942071, 5731.885362292773, 5816.098504731774, 5822.883542329129, 5829.650220986712, 5831.562632802515, 4084.0, 4088.550259471456, 4089.3048181809163, 4089.488813898263, 4090.795460227036, 4023.7988100594853, 4146.0, 4147.792610369469, 4150.377443383456, 4151.958480415217, 4688.695234809727, 4693.249080147229, 4695.718256904596, 4697.6241900647865, 4700.412448443944, 5546.944530554723, 5555.611107222537, 5559.054960656698, 5560.165975103767, 5562.694051827108, 1445.9638509037147, 1466.6186791434304, 1468.3245706974697, 1468.8751456126136, 1470.0371256826795, 996.9750756231152, 997.6059456514636, 1002.0680766886866, 1022.6727447216967, 1031.7626945802508, 4857.53853383928, 4863.683860549053, 4865.0, 4865.95134048662, 4870.6103511718975, 5733.31200255972, 5764.0, 5769.336526299529, 5776.682282474504, 5780.0, 4858.5384388483035, 4859.97940432506, 4866.635002374836, 4866.853994380174, 4869.1722407190155, 3031.7271445570004, 3084.1364417963005, 3110.7666924980717, 3112.066380085965, 3113.050519591546, 5490.945090549043, 5493.670379777226, 5500.202470641734, 5505.03661859173, 5515.25544051556, 5923.45990042592, 5940.257467816523, 5941.673207973603, 5945.048792193228, 5952.76188952437, 5468.535174510132, 5489.890202195934, 5501.092319767194, 5501.367342755554, 5516.14499752531, 5664.631798933056, 5804.1293805929445, 5807.593468457168, 5814.680192589448, 5819.476247137778, 5655.688937108499, 5665.3201615806365, 5665.943340566541, 5671.262735844314, 5674.347450043298, 5477.643953143033, 5492.313460817398, 5492.917606235989, 5495.587830912617, 5501.5323697486165, 3901.1612503311926, 3949.842006319715, 3979.442877997025, 3990.4612877261197, 3996.960030399659, 5789.1605717171615, 5795.536357091507, 5797.710114494174, 5798.362180160095, 5808.0, 5573.164025396223, 5574.581906356958, 5581.023320918742, 5581.49766521015, 5588.0, 5575.693336866511, 5586.022446072003, 5586.804461843816, 5592.3009623797025, 5593.440655934374, 5275.939954826268, 5461.590380721383, 5461.672299662033, 5462.989346970823, 5463.918041229305, 5401.837944861661, 5524.640898341595, 5610.410906854721, 5619.100943848965, 5622.016147174147, 5334.359876814652, 5464.890702185855, 5496.697681627549, 5497.120460726264, 5498.3127109111365], "unit": "score", "name": "prototype.html", "value": 4191.614534491373}, {"lowerIsBetter": false, "replicates": [707.6603230449383, 712.3980236699988, 731.7109741652048, 738.3723834740468, 748.0835975929486, 10408.167346612272, 10645.57417703293, 10668.0, 10677.092447141993, 10685.358878467297, 11251.887481125186, 11412.31526108434, 11416.257943233704, 11419.54321827126, 11446.370449625289, 621.6208113051035, 628.2492421556242, 773.3581127664054, 778.8208711996244, 791.0862953288931, 786.7482405630201, 790.4269404681618, 792.2513225002375, 794.3486341200218, 794.8608993426157, 658.9308122647125, 832.6669332267081, 837.1001173738225, 838.5555655502593, 839.3830534557126, 654.469879397687, 815.747118393297, 828.0187977246921, 828.5981299069946, 830.6760363458257, 616.3743800042915, 618.542278713753, 618.5608218165108, 620.488097319713, 621.8569728962319, 10938.56245750169, 10942.288751231144, 11001.834972475419, 11050.502727377287, 11075.612353567587, 10828.242023058388, 11284.153688473398, 11305.095592352674, 11387.430628468543, 11490.36802975836, 8751.562421878943, 8839.558022098934, 9068.909310906873, 9157.450552966844, 9225.67710130149, 3067.6778938211614, 3140.905772826819, 3141.183292344007, 3148.9527657085164, 3195.8561864716144, 37896.810515947516, 37906.24187516234, 38068.42897356542, 38333.80833095845, 38601.61398386036, 8749.16882896124, 9090.318226132935, 9172.12864777845, 9216.447013179231, 9227.861582076273, 16349.34602615882, 16383.836161638232, 16423.343066277215, 16424.0, 16426.507204783877, 5993.160957465958, 6166.9383306167265, 6208.410201030895, 6259.906101408483, 6299.590526615755, 3178.3802158578856, 3233.0624119005697, 3268.7548433867555, 3329.417351963397, 3344.0469466202017, 2373.6439534070028, 2392.6171812509915, 2405.7834794868545, 2410.722766881796, 2411.3489357873277, 448.02107395341284, 449.8425551057104, 454.23234733300615, 455.78805855276795, 456.5525784730982, 431.0903992575663, 489.38826466916356, 517.6350672775684, 520.5185203686575, 570.292836882263, 6712.309710242852, 6875.243723190445, 6887.621180835102, 7158.749443769547, 7171.39043181325, 423.90257157679156, 425.1963788439851, 470.7881453346008, 478.8946431785002, 518.5177784660227, 3333.7666363354333, 3384.1708781348725, 3420.3672320620763, 3461.44616861301, 3462.0, 44405.0, 44803.0, 45134.0, 45223.321650175276, 45439.0, 39991.40012899809, 41156.176876462305, 41245.0, 41433.1713365737, 41822.79088604599, 38437.615623843965, 38457.42313865294, 38768.0, 39024.219515609526, 39247.60752392497, 7112.857742845011, 7527.548347099191, 7609.201033891583, 7663.923360766544, 7716.614169291625, 29504.0, 29668.0, 30105.09684709462, 30425.695743042284, 30434.695653044073, 34468.0, 34798.0, 40941.0, 40956.59043409528, 42151.7892410536, 9463.763405914631, 9645.951770241103, 9653.951730241304, 9692.612295508101, 9701.757456063655, 10596.311239769699, 10602.416867072385, 10707.304025238334, 11063.557457701601, 11507.0, 9739.430578001113, 9857.507124643882, 9989.60041598328, 10117.848232276374, 10138.341007834468, 9743.658971935949, 9799.85300220483, 9818.950905245429, 10025.5488503019, 10030.0, 9489.430634161972, 9615.9038409615, 9736.9026309736, 10034.949825250827, 10067.345622534513, 8548.786280343042, 8846.217052024704, 9026.368154229142, 9032.412893161923, 9045.366824322235, 8600.13998600135, 8786.780330491789, 8837.160469755363, 8841.425307355, 8993.595288211915], "unit": "score", "name": "yui.html", "value": 5405.728316283405}], "name": "dromaeo_css", "value": 6260.086580071331}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 114.0, 113.0, 102.0, 112.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 151.0, 164.0, 133.0, 157.0, 162.0, 132.0, 170.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 164.0, 160.0, 161.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 96.0, 71.0, 72.0, 72.0, 117.0, 92.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 135.0, 101.0, 95.0, 95.0, 131.0, 94.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 150.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 71.0, 72.0, 73.0, 74.0, 79.0, 71.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [80.0, 85.0, 83.0, 82.0, 83.0, 82.0, 82.0, 84.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 133.0, 115.0, 123.0, 127.0, 121.0, 135.0, 127.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [135.0, 146.0, 146.0, 148.0, 151.0, 138.0, 159.0, 148.0, 147.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 71.0, 70.0, 72.0, 69.0, 68.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1525.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.0672268907563], "unit": "score", "name": "Richards", "value": 210.04689999999997}, {"lowerIsBetter": false, "replicates": [185.32246108228318], "unit": "score", "name": "DeltaBlue", "value": 356.77272800000003}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [27081.08108108108], "unit": "score", "name": "RegExp", "value": 33.63916666666665}, {"lowerIsBetter": false, "replicates": [618.8118811881188], "unit": "score", "name": "Splay", "value": 131.68945600000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19689.895247974266}]} 18:04:49 INFO - RETURN: dromaeo_css: 6260.09 18:04:49 INFO - RETURN: kraken: 1525.10 18:04:49 INFO - RETURN: v8_7: 19689.90 18:04:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19689.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6260.09"}}} 18:04:49 INFO - Return code: 0 18:04:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:49 ERROR - # TBPL SUCCESS # 18:04:49 INFO - Running post-action listener: _resource_record_post_action 18:04:49 INFO - Running post-run listener: _resource_record_post_run 18:04:50 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549232640; Read time: 20; Write time: 397864 18:04:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 226336768; Read time: 0; Write time: 185892 18:04:50 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317546496; Read time: 20; Write time: 192488 18:04:50 INFO - Running post-run listener: _upload_blobber_files 18:04:50 INFO - Blob upload gear active. 18:04:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:04:50 INFO - Copying logs to upload dir... 18:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.313611 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-17 18:04:50.238064) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:04:50.241742) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009968 build_url: 'https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/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 18:04:50.292386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 54 secs) (at 2015-12-17 18:04:50.292739) ========= 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=820bb6602ddf640013a48df2000001a9-1450401908.241011-1333458309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 54.69 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 54 secs) (at 2015-12-17 18:05:44.983470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:05:44.983825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:05:45.141843) ========= ========= Total master_lag: 54.90 =========