builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1448561720.24 results: success (0) buildid: 20151126090112 builduid: aa9a9d29ae2e496ebb39bf697d5eab22 revision: b9e69115c83246737582ccf0577ba2e20d1a76a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.244866) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.245373) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.245711) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003371 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.261556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.261935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.283752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.284075) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003007 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.333686) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.334041) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.334454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.334769) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 10:15:20-- 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% 213M=0s 2015-11-26 10:15:20 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.541972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.542313) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:20.592908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 10:15:20.593306) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9e69115c83246737582ccf0577ba2e20d1a76a9 --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 b9e69115c83246737582ccf0577ba2e20d1a76a9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 10:15:20,659 truncating revision to first 12 chars 2015-11-26 10:15:20,659 Setting DEBUG logging. 2015-11-26 10:15:20,659 attempt 1/10 2015-11-26 10:15:20,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9e69115c832?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 10:15:22,012 unpacking tar archive at: fx-team-b9e69115c832/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 10:15:22.232594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:22.232927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:22.242921) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:22.243190) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 10:15:22.243595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-26 10:15:22.243892) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:22 INFO - MultiFileLogger online at 20151126 10:15:22 in /builds/slave/test 10:15:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:15:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:22 INFO - {'append_to_log': False, 10:15:22 INFO - 'base_work_dir': '/builds/slave/test', 10:15:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:15:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:22 INFO - 'branch': 'Fx-Team-Non-PGO', 10:15:22 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:22 INFO - 'config_files': ('talos/linux_config.py',), 10:15:22 INFO - 'default_actions': ('clobber', 10:15:22 INFO - 'read-buildbot-config', 10:15:22 INFO - 'download-and-extract', 10:15:22 INFO - 'populate-webroot', 10:15:22 INFO - 'create-virtualenv', 10:15:22 INFO - 'install', 10:15:22 INFO - 'run-tests'), 10:15:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:22 INFO - 'download_minidump_stackwalk': True, 10:15:22 INFO - 'download_symbols': 'ondemand', 10:15:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:22 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:22 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:22 INFO - 'installer_path': 'installer.exe', 10:15:22 INFO - 'log_level': 'info', 10:15:22 INFO - 'log_name': 'talos', 10:15:22 INFO - 'log_to_console': True, 10:15:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:22 INFO - 'opt_config_files': (), 10:15:22 INFO - 'pip_index': False, 10:15:22 INFO - 'sps_profile': False, 10:15:22 INFO - 'sps_profile_interval': 0, 10:15:22 INFO - 'suite': 'dromaeojs-e10s', 10:15:22 INFO - 'system_bits': '64', 10:15:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:22 INFO - 'title': 'talos-linux64-ix-034', 10:15:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:22 INFO - 'use_talos_json': True, 10:15:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:22 INFO - 'work_dir': 'build'} 10:15:22 INFO - ##### 10:15:22 INFO - ##### Running clobber step. 10:15:22 INFO - ##### 10:15:22 INFO - Running pre-action listener: _resource_record_pre_action 10:15:22 INFO - Running main action method: clobber 10:15:22 INFO - rmtree: /builds/slave/test/build 10:15:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:23 INFO - Running post-action listener: _resource_record_post_action 10:15:23 INFO - ##### 10:15:23 INFO - ##### Running read-buildbot-config step. 10:15:23 INFO - ##### 10:15:23 INFO - Running pre-action listener: _resource_record_pre_action 10:15:23 INFO - Running main action method: read_buildbot_config 10:15:23 INFO - Using buildbot properties: 10:15:23 INFO - { 10:15:23 INFO - "properties": { 10:15:23 INFO - "buildnumber": 521, 10:15:23 INFO - "product": "firefox", 10:15:23 INFO - "script_repo_revision": "production", 10:15:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:15:23 INFO - "repository": "", 10:15:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:15:23 INFO - "buildid": "20151126090112", 10:15:23 INFO - "slavename": "talos-linux64-ix-034", 10:15:23 INFO - "pgo_build": "False", 10:15:23 INFO - "basedir": "/builds/slave/test", 10:15:23 INFO - "project": "", 10:15:23 INFO - "platform": "ubuntu64_hw", 10:15:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:23 INFO - "slavebuilddir": "test", 10:15:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:15:23 INFO - "branch": "fx-team", 10:15:23 INFO - "repo_path": "integration/fx-team", 10:15:23 INFO - "stage_platform": "linux64", 10:15:23 INFO - "builduid": "aa9a9d29ae2e496ebb39bf697d5eab22", 10:15:23 INFO - "revision": "b9e69115c83246737582ccf0577ba2e20d1a76a9" 10:15:23 INFO - }, 10:15:23 INFO - "sourcestamp": { 10:15:23 INFO - "repository": "", 10:15:23 INFO - "hasPatch": false, 10:15:23 INFO - "project": "", 10:15:23 INFO - "branch": "fx-team-linux64-talos", 10:15:23 INFO - "changes": [ 10:15:23 INFO - { 10:15:23 INFO - "category": null, 10:15:23 INFO - "files": [ 10:15:23 INFO - { 10:15:23 INFO - "url": null, 10:15:23 INFO - "name": "https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:15:23 INFO - } 10:15:23 INFO - ], 10:15:23 INFO - "repository": "", 10:15:23 INFO - "rev": "b9e69115c83246737582ccf0577ba2e20d1a76a9", 10:15:23 INFO - "who": "philringnalda@gmail.com", 10:15:23 INFO - "when": 1448561499, 10:15:23 INFO - "number": 6712022, 10:15:23 INFO - "comments": "Back out 4aad8e3db7e9 (bug 384336) for Valgrind leaks and a variety of mochitest bustage\nCLOSED TREE", 10:15:23 INFO - "project": "", 10:15:23 INFO - "at": "Thu 26 Nov 2015 10:11:39", 10:15:23 INFO - "branch": "fx-team-linux64-talos", 10:15:23 INFO - "revlink": "", 10:15:23 INFO - "properties": [ 10:15:23 INFO - [ 10:15:23 INFO - "buildid", 10:15:23 INFO - "20151126090112", 10:15:23 INFO - "Change" 10:15:23 INFO - ], 10:15:23 INFO - [ 10:15:23 INFO - "builduid", 10:15:23 INFO - "aa9a9d29ae2e496ebb39bf697d5eab22", 10:15:23 INFO - "Change" 10:15:23 INFO - ], 10:15:23 INFO - [ 10:15:23 INFO - "pgo_build", 10:15:23 INFO - "False", 10:15:23 INFO - "Change" 10:15:23 INFO - ] 10:15:23 INFO - ], 10:15:23 INFO - "revision": "b9e69115c83246737582ccf0577ba2e20d1a76a9" 10:15:23 INFO - } 10:15:23 INFO - ], 10:15:23 INFO - "revision": "b9e69115c83246737582ccf0577ba2e20d1a76a9" 10:15:23 INFO - } 10:15:23 INFO - } 10:15:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:15:23 INFO - Running post-action listener: _resource_record_post_action 10:15:23 INFO - ##### 10:15:23 INFO - ##### Running download-and-extract step. 10:15:23 INFO - ##### 10:15:23 INFO - Running pre-action listener: _resource_record_pre_action 10:15:23 INFO - Running main action method: download_and_extract 10:15:23 INFO - mkdir: /builds/slave/test/build/tests 10:15:23 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')]} 10:15:23 INFO - https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/test_packages.json 10:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/test_packages.json 10:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:15:23 INFO - Downloaded 1302 bytes. 10:15:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:15:23 INFO - Using the following test package requirements: 10:15:23 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:23 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:23 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'jsshell-linux-x86_64.zip'], 10:15:23 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:23 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:23 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:23 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:23 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:23 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:23 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:23 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')]} 10:15:23 INFO - https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:25 INFO - Downloaded 21515226 bytes. 10:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:15:26 INFO - Return code: 0 10:15:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:26 INFO - https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:28 INFO - Downloaded 21515226 bytes. 10:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:15:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:15:30 INFO - Return code: 0 10:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:30 INFO - https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:15:31 INFO - Downloaded 11131728 bytes. 10:15:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:15:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:15:31 INFO - Return code: 0 10:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:31 INFO - https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:15:32 INFO - Downloaded 56869331 bytes. 10:15:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:15:32 INFO - mkdir: /builds/slave/test/properties 10:15:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:32 INFO - Contents: 10:15:32 INFO - build_url:https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - Running post-action listener: set_extra_try_arguments 10:15:32 INFO - ##### 10:15:32 INFO - ##### Running populate-webroot step. 10:15:32 INFO - ##### 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: populate_webroot 10:15:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:15:32 INFO - '../fennec_ids.txt'], 10:15:32 INFO - 'tests': ['tcheck2']}, 10:15:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:32 INFO - '--tppagecycles', 10:15:32 INFO - '7'], 10:15:32 INFO - 'tests': ['tsvgm']}}, 10:15:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:15:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:15:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'other': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'other_l64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'other_nol64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore']}, 10:15:32 INFO - 'svgr': {'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--e10s'], 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}, 10:15:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--e10s', 10:15:32 INFO - '--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}}, 10:15:32 INFO - 'talos.zip': {'path': '', 10:15:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - ##### 10:15:32 INFO - ##### Running create-virtualenv step. 10:15:32 INFO - ##### 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: create_virtualenv 10:15:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:32 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 10:15:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:32 INFO - Using real prefix '/usr' 10:15:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:35 INFO - Installing pip.................done. 10:15:35 INFO - Return code: 0 10:15:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:35 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 10:15:35 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 10:15:35 INFO - Using env: {'DISPLAY': ':0', 10:15:35 INFO - 'HOME': '/home/cltbld', 10:15:35 INFO - 'LANG': 'en_US.UTF-8', 10:15:35 INFO - 'LANGUAGE': 'en_US:en', 10:15:35 INFO - 'LOGNAME': 'cltbld', 10:15:35 INFO - 'MAIL': '/var/mail/cltbld', 10:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:35 INFO - 'MOZ_NO_REMOTE': '1', 10:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:35 INFO - 'NO_EM_RESTART': '1', 10:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:35 INFO - 'PWD': '/builds/slave/test', 10:15:35 INFO - 'SHELL': '/bin/bash', 10:15:35 INFO - 'SHLVL': '1', 10:15:35 INFO - 'TERM': 'linux', 10:15:35 INFO - 'TMOUT': '86400', 10:15:35 INFO - 'USER': 'cltbld', 10:15:35 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:35 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 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 10:15:35 INFO - Cleaning up... 10:15:35 INFO - Return code: 0 10:15:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:35 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 10:15:35 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 10:15:35 INFO - Using env: {'DISPLAY': ':0', 10:15:35 INFO - 'HOME': '/home/cltbld', 10:15:35 INFO - 'LANG': 'en_US.UTF-8', 10:15:35 INFO - 'LANGUAGE': 'en_US:en', 10:15:35 INFO - 'LOGNAME': 'cltbld', 10:15:35 INFO - 'MAIL': '/var/mail/cltbld', 10:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:35 INFO - 'MOZ_NO_REMOTE': '1', 10:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:35 INFO - 'NO_EM_RESTART': '1', 10:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:35 INFO - 'PWD': '/builds/slave/test', 10:15:35 INFO - 'SHELL': '/bin/bash', 10:15:35 INFO - 'SHLVL': '1', 10:15:35 INFO - 'TERM': 'linux', 10:15:35 INFO - 'TMOUT': '86400', 10:15:35 INFO - 'USER': 'cltbld', 10:15:35 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:35 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 INFO - Downloading/unpacking psutil>=0.7.1 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:37 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:15:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:37 INFO - Installing collected packages: psutil 10:15:37 INFO - Running setup.py install for psutil 10:15:37 INFO - building 'psutil._psutil_linux' extension 10:15:37 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 10:15:37 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 10:15:37 INFO - building 'psutil._psutil_posix' extension 10:15:37 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 10:15:37 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 10:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:37 INFO - Successfully installed psutil 10:15:37 INFO - Cleaning up... 10:15:37 INFO - Return code: 0 10:15:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:37 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:37 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 10:15:37 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 10:15:37 INFO - Using env: {'DISPLAY': ':0', 10:15:37 INFO - 'HOME': '/home/cltbld', 10:15:37 INFO - 'LANG': 'en_US.UTF-8', 10:15:37 INFO - 'LANGUAGE': 'en_US:en', 10:15:37 INFO - 'LOGNAME': 'cltbld', 10:15:37 INFO - 'MAIL': '/var/mail/cltbld', 10:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:37 INFO - 'MOZ_NO_REMOTE': '1', 10:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:37 INFO - 'NO_EM_RESTART': '1', 10:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:37 INFO - 'PWD': '/builds/slave/test', 10:15:37 INFO - 'SHELL': '/bin/bash', 10:15:37 INFO - 'SHLVL': '1', 10:15:37 INFO - 'TERM': 'linux', 10:15:37 INFO - 'TMOUT': '86400', 10:15:37 INFO - 'USER': 'cltbld', 10:15:37 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:37 INFO - '_': '/tools/buildbot/bin/python'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:15:38 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 10:15:38 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 10:15:38 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 10:15:38 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 10:15:38 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 10:15:38 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 10:15:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:39 INFO - Installing collected packages: mozsystemmonitor 10:15:39 INFO - Running setup.py install for mozsystemmonitor 10:15:39 INFO - Successfully installed mozsystemmonitor 10:15:39 INFO - Cleaning up... 10:15:39 INFO - Return code: 0 10:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:39 INFO - Using env: {'DISPLAY': ':0', 10:15:39 INFO - 'HOME': '/home/cltbld', 10:15:39 INFO - 'LANG': 'en_US.UTF-8', 10:15:39 INFO - 'LANGUAGE': 'en_US:en', 10:15:39 INFO - 'LOGNAME': 'cltbld', 10:15:39 INFO - 'MAIL': '/var/mail/cltbld', 10:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:39 INFO - 'MOZ_NO_REMOTE': '1', 10:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:39 INFO - 'NO_EM_RESTART': '1', 10:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:39 INFO - 'PWD': '/builds/slave/test', 10:15:39 INFO - 'SHELL': '/bin/bash', 10:15:39 INFO - 'SHLVL': '1', 10:15:39 INFO - 'TERM': 'linux', 10:15:39 INFO - 'TMOUT': '86400', 10:15:39 INFO - 'USER': 'cltbld', 10:15:39 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:39 INFO - '_': '/tools/buildbot/bin/python'} 10:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:41 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 10:15:41 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 10:15:41 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 10:15:41 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 10:15:41 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 10:15:41 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 10:15:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:42 INFO - Downloading docopt-0.6.1.tar.gz 10:15:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:42 INFO - Running setup.py install for blobuploader 10:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:42 INFO - Running setup.py install for requests 10:15:42 INFO - Running setup.py install for docopt 10:15:43 INFO - Successfully installed blobuploader requests docopt 10:15:43 INFO - Cleaning up... 10:15:43 INFO - Return code: 0 10:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:43 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:43 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 10:15:43 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 10:15:43 INFO - Using env: {'DISPLAY': ':0', 10:15:43 INFO - 'HOME': '/home/cltbld', 10:15:43 INFO - 'LANG': 'en_US.UTF-8', 10:15:43 INFO - 'LANGUAGE': 'en_US:en', 10:15:43 INFO - 'LOGNAME': 'cltbld', 10:15:43 INFO - 'MAIL': '/var/mail/cltbld', 10:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:43 INFO - 'MOZ_NO_REMOTE': '1', 10:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:43 INFO - 'NO_EM_RESTART': '1', 10:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:43 INFO - 'PWD': '/builds/slave/test', 10:15:43 INFO - 'SHELL': '/bin/bash', 10:15:43 INFO - 'SHLVL': '1', 10:15:43 INFO - 'TERM': 'linux', 10:15:43 INFO - 'TMOUT': '86400', 10:15:43 INFO - 'USER': 'cltbld', 10:15:43 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:43 INFO - '_': '/tools/buildbot/bin/python'} 10:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:43 INFO - Running setup.py (path:/tmp/pip-UEUt1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:43 INFO - Running setup.py (path:/tmp/pip-ZU3Nqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:43 INFO - Running setup.py (path:/tmp/pip-uX3RyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:43 INFO - Running setup.py (path:/tmp/pip-rQmeBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:43 INFO - Running setup.py (path:/tmp/pip-EDr1oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:43 INFO - Running setup.py (path:/tmp/pip-9VTOEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:43 INFO - Running setup.py (path:/tmp/pip-gm_Ggw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:43 INFO - Running setup.py (path:/tmp/pip-ghcdGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:43 INFO - Running setup.py (path:/tmp/pip-tS1SAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:44 INFO - Running setup.py (path:/tmp/pip-apDClE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:44 INFO - Running setup.py (path:/tmp/pip-NGGIi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:44 INFO - Running setup.py (path:/tmp/pip-UNtofu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:44 INFO - Running setup.py (path:/tmp/pip-IAU8W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:44 INFO - Running setup.py (path:/tmp/pip-JzZBUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:44 INFO - Running setup.py (path:/tmp/pip-YZWhy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:44 INFO - Running setup.py (path:/tmp/pip-UY8eFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:44 INFO - Running setup.py (path:/tmp/pip-kEdrfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:44 INFO - Running setup.py install for manifestparser 10:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozcrash 10:15:44 INFO - Running setup.py install for mozdebug 10:15:44 INFO - Running setup.py install for mozdevice 10:15:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozfile 10:15:45 INFO - Running setup.py install for mozhttpd 10:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozinfo 10:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozInstall 10:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozleak 10:15:45 INFO - Running setup.py install for mozlog 10:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for moznetwork 10:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozprocess 10:15:45 INFO - Running setup.py install for mozprofile 10:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Running setup.py install for mozrunner 10:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:46 INFO - Running setup.py install for mozscreenshot 10:15:46 INFO - Running setup.py install for moztest 10:15:46 INFO - Running setup.py install for mozversion 10:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:46 INFO - Cleaning up... 10:15:46 INFO - Return code: 0 10:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:46 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:46 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 10:15:46 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 10:15:46 INFO - Using env: {'DISPLAY': ':0', 10:15:46 INFO - 'HOME': '/home/cltbld', 10:15:46 INFO - 'LANG': 'en_US.UTF-8', 10:15:46 INFO - 'LANGUAGE': 'en_US:en', 10:15:46 INFO - 'LOGNAME': 'cltbld', 10:15:46 INFO - 'MAIL': '/var/mail/cltbld', 10:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:46 INFO - 'MOZ_NO_REMOTE': '1', 10:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:46 INFO - 'NO_EM_RESTART': '1', 10:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:46 INFO - 'PWD': '/builds/slave/test', 10:15:46 INFO - 'SHELL': '/bin/bash', 10:15:46 INFO - 'SHLVL': '1', 10:15:46 INFO - 'TERM': 'linux', 10:15:46 INFO - 'TMOUT': '86400', 10:15:46 INFO - 'USER': 'cltbld', 10:15:46 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:46 INFO - '_': '/tools/buildbot/bin/python'} 10:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 INFO - Running setup.py (path:/tmp/pip-duPP8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 INFO - Running setup.py (path:/tmp/pip-fuCf5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 INFO - Running setup.py (path:/tmp/pip-kW8hlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 INFO - Running setup.py (path:/tmp/pip-p_Mx2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:46 INFO - Running setup.py (path:/tmp/pip-xUEL5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:46 INFO - Running setup.py (path:/tmp/pip-0sl464-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:46 INFO - Running setup.py (path:/tmp/pip-_cYNZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:47 INFO - Running setup.py (path:/tmp/pip-Bp_zMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:47 INFO - Running setup.py (path:/tmp/pip-ngU1Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:47 INFO - Running setup.py (path:/tmp/pip-ZdeWrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 INFO - Running setup.py (path:/tmp/pip-jHQYVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 INFO - Running setup.py (path:/tmp/pip-FYtyNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 INFO - Running setup.py (path:/tmp/pip-8tAr31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 INFO - Running setup.py (path:/tmp/pip-YaiYs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 INFO - Running setup.py (path:/tmp/pip-_eIt2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:47 INFO - Running setup.py (path:/tmp/pip-T_2B4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:47 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)) 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:47 INFO - Running setup.py (path:/tmp/pip-yJ9k2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:47 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)) 10:15:47 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)) 10:15:47 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)) 10:15:47 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)) 10:15:47 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)) 10:15:47 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)) 10:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:49 INFO - Downloading blessings-1.5.1.tar.gz 10:15:49 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 10:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:49 INFO - Installing collected packages: blessings 10:15:49 INFO - Running setup.py install for blessings 10:15:49 INFO - Successfully installed blessings 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:50 INFO - Reading from file tmpfile_stdout 10:15:50 INFO - Current package versions: 10:15:50 INFO - argparse == 1.2.1 10:15:50 INFO - blessings == 1.5.1 10:15:50 INFO - blobuploader == 1.2.4 10:15:50 INFO - docopt == 0.6.1 10:15:50 INFO - manifestparser == 1.1 10:15:50 INFO - mozInstall == 1.12 10:15:50 INFO - mozcrash == 0.16 10:15:50 INFO - mozdebug == 0.1 10:15:50 INFO - mozdevice == 0.47 10:15:50 INFO - mozfile == 1.2 10:15:50 INFO - mozhttpd == 0.7 10:15:50 INFO - mozinfo == 0.9 10:15:50 INFO - mozleak == 0.1 10:15:50 INFO - mozlog == 3.1 10:15:50 INFO - moznetwork == 0.27 10:15:50 INFO - mozprocess == 0.22 10:15:50 INFO - mozprofile == 0.27 10:15:50 INFO - mozrunner == 6.11 10:15:50 INFO - mozscreenshot == 0.1 10:15:50 INFO - mozsystemmonitor == 0.0 10:15:50 INFO - moztest == 0.7 10:15:50 INFO - mozversion == 1.4 10:15:50 INFO - psutil == 3.1.1 10:15:50 INFO - requests == 1.2.3 10:15:50 INFO - wsgiref == 0.1.2 10:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:50 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 10:15:50 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 10:15:50 INFO - Using env: {'DISPLAY': ':0', 10:15:50 INFO - 'HOME': '/home/cltbld', 10:15:50 INFO - 'LANG': 'en_US.UTF-8', 10:15:50 INFO - 'LANGUAGE': 'en_US:en', 10:15:50 INFO - 'LOGNAME': 'cltbld', 10:15:50 INFO - 'MAIL': '/var/mail/cltbld', 10:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:50 INFO - 'MOZ_NO_REMOTE': '1', 10:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:50 INFO - 'NO_EM_RESTART': '1', 10:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:50 INFO - 'PWD': '/builds/slave/test', 10:15:50 INFO - 'SHELL': '/bin/bash', 10:15:50 INFO - 'SHLVL': '1', 10:15:50 INFO - 'TERM': 'linux', 10:15:50 INFO - 'TMOUT': '86400', 10:15:50 INFO - 'USER': 'cltbld', 10:15:50 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:50 INFO - '_': '/tools/buildbot/bin/python'} 10:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 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)) 10:15:50 INFO - Cleaning up... 10:15:50 INFO - Return code: 0 10:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 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 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:50 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 10:15:50 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 10:15:50 INFO - Using env: {'DISPLAY': ':0', 10:15:50 INFO - 'HOME': '/home/cltbld', 10:15:50 INFO - 'LANG': 'en_US.UTF-8', 10:15:50 INFO - 'LANGUAGE': 'en_US:en', 10:15:50 INFO - 'LOGNAME': 'cltbld', 10:15:50 INFO - 'MAIL': '/var/mail/cltbld', 10:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:50 INFO - 'MOZ_NO_REMOTE': '1', 10:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:50 INFO - 'NO_EM_RESTART': '1', 10:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:50 INFO - 'PWD': '/builds/slave/test', 10:15:50 INFO - 'SHELL': '/bin/bash', 10:15:50 INFO - 'SHLVL': '1', 10:15:50 INFO - 'TERM': 'linux', 10:15:50 INFO - 'TMOUT': '86400', 10:15:50 INFO - 'USER': 'cltbld', 10:15:50 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:50 INFO - '_': '/tools/buildbot/bin/python'} 10:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:50 INFO - Downloading/unpacking jsonschema 10:15:50 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 10:15:50 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 10:15:50 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 10:15:50 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 10:15:50 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 10:15:50 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 10:15:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:52 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 10:15:52 INFO - Downloading/unpacking functools32 (from jsonschema) 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:52 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:52 INFO - warning: no files found matching '*.txt' 10:15:52 INFO - no previously-included directories found matching 'build' 10:15:52 INFO - no previously-included directories found matching 'dist' 10:15:52 INFO - no previously-included directories found matching '.git*' 10:15:52 INFO - Installing collected packages: jsonschema, functools32 10:15:52 INFO - Running setup.py install for functools32 10:15:52 INFO - warning: no files found matching '*.txt' 10:15:52 INFO - no previously-included directories found matching 'build' 10:15:52 INFO - no previously-included directories found matching 'dist' 10:15:52 INFO - no previously-included directories found matching '.git*' 10:15:52 INFO - Successfully installed jsonschema functools32 10:15:52 INFO - Cleaning up... 10:15:52 INFO - Return code: 0 10:15:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd710157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2786240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', '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 10:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:15:52 INFO - Using env: {'DISPLAY': ':0', 10:15:52 INFO - 'HOME': '/home/cltbld', 10:15:52 INFO - 'LANG': 'en_US.UTF-8', 10:15:52 INFO - 'LANGUAGE': 'en_US:en', 10:15:52 INFO - 'LOGNAME': 'cltbld', 10:15:52 INFO - 'MAIL': '/var/mail/cltbld', 10:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:52 INFO - 'MOZ_NO_REMOTE': '1', 10:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:52 INFO - 'NO_EM_RESTART': '1', 10:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:52 INFO - 'PWD': '/builds/slave/test', 10:15:52 INFO - 'SHELL': '/bin/bash', 10:15:52 INFO - 'SHLVL': '1', 10:15:52 INFO - 'TERM': 'linux', 10:15:52 INFO - 'TMOUT': '86400', 10:15:52 INFO - 'USER': 'cltbld', 10:15:52 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:52 INFO - '_': '/tools/buildbot/bin/python'} 10:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:52 INFO - Downloading/unpacking flake8 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:15:54 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 10:15:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:15:54 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 10:15:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 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 10:15:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:15:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:55 INFO - no previously-included directories found matching 'docs/_build' 10:15:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:15:55 INFO - Running setup.py install for pep8 10:15:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:55 INFO - no previously-included directories found matching 'docs/_build' 10:15:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:15:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:15:55 INFO - Cleaning up... 10:15:55 INFO - Return code: 0 10:15:55 INFO - Running post-action listener: _resource_record_post_action 10:15:55 INFO - Running post-action listener: _start_resource_monitoring 10:15:55 INFO - Starting resource monitoring. 10:15:55 INFO - ##### 10:15:55 INFO - ##### Running install step. 10:15:55 INFO - ##### 10:15:55 INFO - Running pre-action listener: _resource_record_pre_action 10:15:55 INFO - Running main action method: install 10:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:55 INFO - Reading from file tmpfile_stdout 10:15:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:55 INFO - Reading from file tmpfile_stdout 10:15:55 INFO - Output received: 10:15:55 INFO - Usage: mozinstall [options] installer 10:15:55 INFO - Options: 10:15:55 INFO - -h, --help show this help message and exit 10:15:55 INFO - -d DEST, --destination=DEST 10:15:55 INFO - Directory to install application into. [default: 10:15:55 INFO - "/builds/slave/test"] 10:15:55 INFO - --app=APP Application being installed. [default: firefox] 10:15:55 INFO - mkdir: /builds/slave/test/build/application 10:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:16:10 INFO - Reading from file tmpfile_stdout 10:16:10 INFO - Output received: 10:16:10 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:10 INFO - Running post-action listener: _resource_record_post_action 10:16:10 INFO - ##### 10:16:10 INFO - ##### Running run-tests step. 10:16:10 INFO - ##### 10:16:10 INFO - Running pre-action listener: _resource_record_pre_action 10:16:10 INFO - Running main action method: run_tests 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:10 INFO - Python 2.7.3 10:16:10 INFO - Return code: 0 10:16:10 INFO - grabbing minidump binary from tooltool 10:16: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')]} 10:16:10 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 0x28150b0>, '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 0x2815fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2816440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:10 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 10:16:10 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 10:16:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:10 INFO - Return code: 0 10:16:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:16:11 INFO - Return code: 0 10:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 10:16:11 INFO - mozversion INFO | application_buildid: 20151126090112 10:16:11 INFO - mozversion INFO | application_changeset: b9e69115c83246737582ccf0577ba2e20d1a76a9 10:16:11 INFO - mozversion INFO | application_display_name: Nightly 10:16:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:11 INFO - mozversion INFO | application_name: Firefox 10:16:11 INFO - mozversion INFO | application_remotingname: firefox 10:16:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:16:11 INFO - mozversion INFO | application_vendor: Mozilla 10:16:11 INFO - mozversion INFO | application_version: 45.0a1 10:16:11 INFO - mozversion INFO | platform_buildid: 20151126090112 10:16:11 INFO - mozversion INFO | platform_changeset: b9e69115c83246737582ccf0577ba2e20d1a76a9 10:16:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:16:11 INFO - mozversion INFO | platform_version: 45.0a1 10:16:11 INFO - 2015-11-26 10:16:11,203 DEBUG : using testdate: 1448561771 10:16:11 INFO - 2015-11-26 10:16:11,203 DEBUG : actual date: 1448561771 10:16:11 INFO - 2015-11-26 10:16:11,212 INFO : starting webserver on 'localhost:52252' 10:16:11 INFO - 2015-11-26 10:16:11,213 INFO : Starting test suite talos-linux64-ix-034.e 10:16:11 INFO - 2015-11-26 10:16:11,213 INFO : Starting test dromaeo_css 10:16:11 INFO - 2015-11-26 10:16:11,214 DEBUG : operating with platform_type : linux_ 10:16:11 INFO - 2015-11-26 10:16:11,214 INFO : Initialising browser for dromaeo_css test... 10:16:11 INFO - 2015-11-26 10:16:11,230 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_siPY/profile http://localhost:52252/getInfo.html 10:16:16 INFO - 2015-11-26 10:16:16,051 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:16 INFO - 2015-11-26 10:16:16,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:16 INFO - 2015-11-26 10:16:16,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:16 INFO - 2015-11-26 10:16:16,052 DEBUG : BROWSER_OUTPUT: __metrics 10:16:17 INFO - 2015-11-26 10:16:17,158 INFO : Browser initialized. 10:16:17 INFO - 2015-11-26 10:16:17,158 INFO : Running cycle 1/1 for dromaeo_css test... 10:16:17 INFO - 2015-11-26 10:16:17,158 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_siPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:29 INFO - 2015-11-26 10:16:29,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 138289152 10:16:29 INFO - 2015-11-26 10:16:29,074 DEBUG : BROWSER_OUTPUT: 10:17:18 INFO - 2015-11-26 10:17:18,703 DEBUG : BROWSER_OUTPUT: 1448561838697 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] 10:19:30 INFO - 2015-11-26 10:19:30,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52252/tests/dromaeo/cssquery-ext.html) 10:19:31 INFO - 2015-11-26 10:19:31,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 144052224 10:19:31 INFO - 2015-11-26 10:19:31,742 DEBUG : BROWSER_OUTPUT: 10:22:33 INFO - 2015-11-26 10:22:33,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-ext.html (next: http://localhost:52252/tests/dromaeo/cssquery-jquery.html) 10:22:34 INFO - 2015-11-26 10:22:34,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 10:22:34 INFO - 2015-11-26 10:22:34,478 DEBUG : BROWSER_OUTPUT: 10:25:36 INFO - 2015-11-26 10:25:36,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52252/tests/dromaeo/cssquery-mootools.html) 10:25:36 INFO - 2015-11-26 10:25:36,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 142176256 10:25:36 INFO - 2015-11-26 10:25:36,891 DEBUG : BROWSER_OUTPUT: 10:28:38 INFO - 2015-11-26 10:28:38,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52252/tests/dromaeo/cssquery-prototype.html) 10:28:39 INFO - 2015-11-26 10:28:39,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 10:28:39 INFO - 2015-11-26 10:28:39,234 DEBUG : BROWSER_OUTPUT: 10:31:41 INFO - 2015-11-26 10:31:41,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52252/tests/dromaeo/cssquery-yui.html) 10:31:42 INFO - 2015-11-26 10:31:42,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 10:31:42 INFO - 2015-11-26 10:31:42,409 DEBUG : BROWSER_OUTPUT: 10:34:44 INFO - 2015-11-26 10:34:44,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/dromaeo/cssquery-yui.html (next: http://localhost:52252/tests/dromaeo/cssquery-dojo.html) 10:34:45 INFO - 2015-11-26 10:34:45,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 144404480 10:34:45 INFO - 2015-11-26 10:34:45,091 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,092 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:34:45 INFO - 2015-11-26 10:34:45,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:34:45 INFO - 2015-11-26 10:34:45,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:34:45 INFO - 2015-11-26 10:34:45,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:34:45 INFO - 2015-11-26 10:34:45,093 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2692.46150769846;2742.1499335206076;2786.359137398398;2786.679531853836;2813.3810561676437;4650.953490465095;4836.322914791932;4864.391951006124;4884.829030983917;4901.901961960763;4765.666403351766;4769.379980602525;4816.325714399987;4833.057553777015;4876.463589005216;4461.040876211622;4461.353103799947;4501.189785838547;4505.121501307246;4611.354410382549;4555.658325625592;4555.794989225493;4587.564181402778;4604.286335617984;4631.560001799824;4265.0830071534765;4369.082492676542;4411.757353345564;4493.6405087593075;4519.728816271035;4503.459584849839;4512.142692888341;4519.977400113011;4526.615237704799;4568.8400905968465;4474.485434175079;4489.057297967431;4500.302453119772;4505.909881802379;4535.863924082283;4518.774061296955;4542.250528662799;4625.514320996314;4677.508861569554;4731.124741922756;5187.636865419422;5212.348456442945;5228.895422091537;5229.738513074331;5258.684478931276;5121.871953201163;5281.63028587999;5283.577313814885;5284.180951952453;5287.68273903567;4762.071396077801;4799.544043315879;4824.396950381202;4835.032993401333;4878.243872199815;5275.736213189325;5317.9202311965355;5336.839894803162;5345.144776835766;5385.488378604026;4852.8301509447;4968.552830245223;5091.261767043832;5092.567131793765;5109.540141387219;5078.162103252922;5158.690478571222;5161.81933632321;5177.430482646906;5222.086134926372;5106.744662766847;5132.589392848563;5152.536271735562;5168.095583272912;5198.688078715213;4865.683730557503;4963.950360496421;4978.626603004789;5107.182850743863;5123.129068058439;4199;4240.660747140283;4248.723832950848;4295.634871035934;4330.458692663417;3786.1859700164596;3788.1855401088897;3797.734158608926;3828.3109040373;3840.9039774005873;4372.803223854934;4529.5243999380245;4538.500764915857;4540;4577.885552861205;5066.695998240118;5093.134167191586;5141.228815677603;5153;5194.168932970707;4500.549945005539;4519.276915693539;4536.206163921366;4538.069695712371;4560.794764235618;4462.7768611569945;4588.105319462673;4622.791974361162;4640.767961601907;4676.158291507561;4808.134535783593;4815.975920120377;4874.976254986493;4885.804567817389;4905.411350637875;5192.5586325162785;5199.610029247746;5201.037808005531;5226.2421948816445;5247.816326428557;4688.460827004938;4804.543568361;4813.205821039489;4922.82770103059;4923.630727695366;5046.041252162077;5070.847874563769;5071.721055341992;5077;5086.135356989246;5182.844514664566;5261.263423120843;5279.128943724242;5289.68261904287;5355.651882627617;5010.423801262901;5040.495950405077;5042.991401719744;5051.696898185974;5077.898442031064;4828.903421931612;4942.851714448572;4961.578265847444;5004.374453193351;5052.72210028452;4847.636427267898;4865.781039853145;4885.926711099408;4919.409670839522;4923;5075.264086707333;5115.897682046412;5135.820246291362;5155.355580552431;5156.819511317086;4748.928766068442;4886.975565122151;4972.2790195422185;5007.949920500749;5021.84934451967 10:34:45 INFO - 2015-11-26 10:34:45,093 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.1556749308543;566.354356034121;573.4724053870439;574.6322353693637;578.0895090232882;36445.45331820025;36565.45151822718;36760.448593271125;36792.264154716926;36904.26191476172;39673.60326396735;39808.80095599518;40165.59834401655;40270.19459610814;40341.59658403415;7867.1739467355965;7961.442699011042;7965.084015338223;7991.041075071;8043.798905027363;7895.210478952087;7970.202979702012;7990.520568765893;8006.759797206093;8031.799205019863;7931.206879312052;7941.64262608184;8016.118226995026;8025.0771161316325;8036.879446808302;7939.325157361631;7990.12108668046;7998.1601931797195;8026.43814932955;8057.879131813057;7929.920700792976;8039.155888631668;8051;8053.838923221561;8054.838903221903;37409;37730.43404348937;37804.24391512182;37834.81082594569;37922.24155516902;2451.497443024176;2906.0264811288243;2929.1651879214533;2949.8967536136347;3007.1579957611903;25640.260431432886;27436.862815685992;27549.862250688617;27708.445831083467;28579.857100714573;3407.386670399327;3407.6592340765974;3417.9829100854336;3507.4448602595708;3569.089882080079;193523;194194.99999999857;194387;195220;195677;47061;47997.76001119972;52306.47693523016;55535.722321388945;56334.7183264081;51808.740956294976;52132;52525.474745252825;52628.73685631624;52680.20979685308;13596.320183990762;13597.252151131783;13741.381637826322;13775.448982040807;13777.586672399644;9568.760780980392;9569.61721531131;9614.375065620712;9654.03459654043;9656.179224765974;18906.621867562848;19163.233470661016;19167.52081197981;19203;19316;7224.963875180591;7417.480776345604;7439.888401673979;7458.4033277337685;7560.58416787071;851.714675583674;854.0903937306748;926.5645146781002;927.2303987690201;967.4388854464394;27040.459190816466;27059.458810824068;27326.863365683046;27456.862715686693;27538.586921196198;927.2322118476343;963.9084286992725;986.7039888033705;1020.1074060197327;1080.9471911225571;14339.713205736036;14588.635284117981;14621.853781462261;14744.41022359115;14984.40062397492;317456;320907;322941;322942;322997;48994.755026224644;49050.754746226754;49404.50595494071;49533.257001145015;49569.752151239016;1204.8614409343038;1212.5210541835925;1216.391804097951;1226.0988173692328;1234.7900856854535;27643.723562764117;27883.302917427227;28319.43361132807;29020.709792901802;30078.398432031674;44063.77968110267;44611.77694111638;45042;45092.32361514645;45142.09715805731;259896;260415;261911;262364;262395;37174.628253717114;41566.79216603898;42261.72371668644;42467;42684.57315426806;45642;45805.96134425144;45943.3108503366;46091.539084608725;46428.071438571715;33135.668643314224;33291.334173316885;33979.66020339864;34163.14592135217;34308.82845585756;34218.657813421545;34315.14212144716;34667.653323466446;34777.82611087029;34962.300753985284;37730.43404348882;37771.2445751078;38323.80838095792;38563.03592410212;38843.80578097091;28042;28909.421811564072;33911.491327630596;35423.46864797082;35452.64547354494;23850.88074559616;23889.163879264142;24195;24304;24384.51230975406 10:34:45 INFO - 2015-11-26 10:34:45,093 DEBUG : BROWSER_OUTPUT: |2;jquery.html;312.5546096812042;324.0747665415238;324.9857571028708;325.8012612306493;327.4564223389173;14640.194789286585;15152.924235378821;15711.764323535157;15924.84075159251;16380.180990950465;15380.61548461289;15449.45926892559;15500.457483988062;15501.922490387533;15695.058296502219;5255.185446255827;5464.098423760075;5466.753996070166;5467.808626698066;5484.670919744828;5347.59893008024;5355.758990845421;5679.886402271952;5680.488756011958;5710.77156913723;3941.1723538057045;4035.6569691576105;5680;5695.430456954313;6457.160569126007;6610.636414997173;6633.2703402625675;6654.800355989328;6659.3007734187695;6668.599884006951;6307.842303942392;6522.282548919615;6546.494306309528;6562.146920900253;6589.110470086573;20373.898130509402;20872.37382878516;21166.788332116637;21199.68200476994;21967.560648786934;1792.417464324087;1838.9264429422808;1863.1615772902248;1980.2870966452065;2122.1193204819983;12254.877451225551;12780;13001.284929328978;13184.736305273937;13258.602241932662;1615.1681883829838;1639.4507839873656;1699.9320027199021;1730.835570620789;1759.2171483689763;50393.496065039246;50677.493225068014;51184.744076279756;51322.23016654753;58829.41170588282;14844.777328340084;15355.692886142215;15493.457728979432;15520.379184832706;15531.223438828014;23150.3054908353;23193.884030580077;23249.18627848051;23376.532469350517;23419.53160936806;8610.655573777103;8673.306135509145;8696.869546956801;8698.434601750865;8752.47485150893;7175.569465832067;7260.745873894494;7282.96358518204;7299.5620262784405;7304.086989126359;7589.962050189824;7645.082590089225;7673.884891726629;7677.0403699537555;7705.267999540035;3098.1325228935934;3189.1229911773985;3210.5344725014743;3246.431874422014;3293.7859039162377;348.2217244458633;358.2852209841331;393.8129388540478;402.24177425553046;408.4628713242077;9913.801723965624;10213.438260895573;10246.692599222035;10315.535800888978;10492.317999330018;386.82399508223693;398.21750260737787;398.42029846573166;398.9660878825274;413.95682879144385;5335.306410166653;5513.448655134454;5516.696581688046;5625.859353516113;5663.348714897757;510115;517510;525286;526983;530961;71462.28537714557;73812;74529;75663;75967;398.7308566717454;402.7281584930219;406.2626333205282;410.17554715022425;410.6345352636216;9473.384230025027;9509.952450237704;9530.475823829756;9720.75698107553;9730.75673108178;29933.850330748206;31521.684783151875;31961.200969975936;34844.303113938084;35369;42091.15817683691;42494.36258456187;44254.336184956606;44770;45295;8763.649454021768;8793.340499462694;8865.822683546421;8964.193222609996;9000.279977601907;10599.099076578577;10638.41488718128;10654.094401975919;10739.570417183537;11243.4378281084;13056.477740890257;13104.279264640156;13130.146540474838;14063.859361406256;14140.292985350485;13308.201507909556;13436.328183590977;13461.528846490326;13933.72132557323;14165.504207352693;13631.04582679203;13747.656308592364;14212.360443780262;14315.212663303619;14395.136291822524;8343.916560834314;8358.205970432798;8366;8792.736217913473;8806.911930880866;9115.817683646157;12954.093213475344;13042.282674452996;13069.281189534668;13644.522441714493 10:34:45 INFO - 2015-11-26 10:34:45,093 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1471.9696212651147;1577.2113943028485;1647.1599484263027;1656.8177500474947;1690.9999999999993;6662.433693136077;6712.832179195522;6868.519203655746;6908.654567271635;6909.309069093095;6758.966205168979;6790.592564446137;6830.897536536956;6831.419329357011;6835.350641689044;1969.5765410436754;1998.9000549972443;2003.168684995725;2005.3683089826732;2010.1456880825663;2005.6490114230023;2020.4241791089541;2026.0781344488223;2029.8376129909573;2039.3677959832426;1921.6733155363622;1950.3661310074212;1964.9901750491229;1967.4884530022155;1984.5038740314922;1967.0558132096603;1987.9801201988012;1989.7114918336904;1994.4914046918088;1995.670714332148;1982.742243508349;2041.1835265893612;2042.5404284036122;2048.5083579940856;2056.7840376760373;6612.636305003223;6676.132102826601;6679.365460281314;6679.833004174934;6683.5655682380975;3983.6813054955824;4071.7353372030725;4080.0615858352744;4088.6729061674996;4103.035786590149;2612.58198688209;2621.9774288027684;2680.2495301315466;2685.0333879803256;2686.462707458516;825.1588853885114;831.7920519870032;839.2572573272637;845.7420486751538;855.8117214212863;8583.313334933191;8619.353548483889;8656.956715216447;8673.04596494385;8675.913240867574;3503.1067077894972;3548.6628770266784;3567.250877315793;3601.3877640801124;3612.1330880588994;7212.567245965259;7219.205887352387;7226.205117437078;7231.421486281085;7284.307990740871;3821.923561528754;3823.789691566935;3826.445165450994;3835.271298453285;3861;3512.1395258161915;3554;3556.253186830743;3563.2160924596546;3575.982120089435;3024.2892920163745;3052.404781067715;3052.9694703052687;3065.3103051813164;3066.1874603229717;873.6505397840788;879.6613303877925;885.7608445719749;897.7261935109724;898.2499612823235;915.56053094515;926.5182105305204;929.972100836976;978.4520668425704;1012.9290949633603;6153.692315384303;6176.8764624707255;6202.658853762996;6215.192025036717;6218.471429928416;1001.2290536287164;1012.7518757904213;1014.9035841595037;1018.4856647393167;1026.2457094035879;4827.806887724451;4842.225243960949;4867.805287788448;4868.586170175504;4879.170541007966;7781.105172905189;7916.327112195528;7977.920220797834;7981.72063977758;8035.67857285702;7993.8401231976195;8089.838203235902;8098.5545794981845;8117.269445749911;8170.488459634987;6285.182926219562;6339.968300158377;6352.333005034498;6355.046742988497;6378.075179099004;5890.440408161217;5920.496757775637;5931.051031834886;5969.134475501115;5985.521158307238;7009;7086.610236437045;7094.858102838018;7110.182329032227;7211.134663840373;7075.681594328371;7230.168530618836;7253.709851605877;7266.382357499671;7361.1166659999;5909.5863289569315;6007.729652165575;6009.699515024144;6034.758609655564;6042.90935635957;6384.425401713868;6416.807495775134;6433.967830160819;6461.030845373231;6464.773732919325;5988.401159883977;6162.630242185483;6195.039768835838;6240.594361366497;6308.211473565804;5822.184894114743;5865.648061116347;5976.581639285382;6069.484093852072;6118.60229085108;5999;6024.337322894566;6067.302260240129;6080.179175811386;6094.268687757321;5648.4633959773755;5661.065924122474;5662.7734890603915;5678.346990096192;5685.914711279252;5548.861278468071;5568.972155139199;5724.313082430135;5729.369769325454;5742.5405967521665 10:34:45 INFO - 2015-11-26 10:34:45,094 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.0188167756338;297.61161684002366;301.3972055888224;302.92729744861225;305.92046068022336;5561.6941068241285;5580.972095139524;5692.601517893744;5708.914366284509;5730.398308177644;5557.972210138943;5567.248421463101;5585.1063829787245;5594.608377413582;5610.438956104387;4051.2910240707906;4350.934735978963;4352.869413917588;4359.564043595647;4364.585364390394;4174.269502837006;4231.513375961757;4356.194104090738;4362.411074504933;4362.847300344489;4291.163223171483;4294.871153865373;4316.503602085769;4316.82732690692;4322.1571793500125;4305.182015417076;4315.266404711207;4316.762578058206;4335.572079635414;4338.761368124752;3800.7529510581726;3803.9239215215816;3810.6760925321382;3812.9809350953346;3820.675242604354;5247.737613119329;5414.377346605112;5445.346558413015;5463.043967305745;5468.179773034077;4876.390451193601;4889.5354941280875;4900.117978763821;4912.975435122838;4918.5573298403315;5900.908331958602;5902.409759024106;5908.793192238294;5912.940870591282;5914.083317085859;3993.880183594497;3998.5601583825755;3999.7800120993334;4002.2595819773146;4004.4593979812644;5928.347881733049;6188.659623720693;6193.0710393440895;6221.346758590328;6226.252849658024;4133.586641335903;4139;4140.296149654566;4143.295639741251;4150.522689890641;4202.579742025834;4207.5161356444405;4210.473690788652;4216.7259128156575;4226;4860.36815214027;4863.902721945612;4867.123917694778;4872.537108974641;4877.6341774367065;5737.225474560881;5847.444492773265;5890.3815099414805;5890.823275301748;5907.616004959664;1468.8237411510688;1482.8739557137549;1484.065039025407;1486.762118061105;1487.1597547385693;979.7599588100961;987.6888780034266;997.7405874472689;1006.4665727164468;1009.7980403919246;5161.535461808456;5161.767720452589;5163.251328557413;5178.741062946838;5193.246979187997;6036.698165091728;6152.384761523812;6200.81397558074;6241.032639940817;6275.058741188858;5168.53483186515;5187.636865419385;5188.610854185951;5196.272521846944;5214.9478505214465;3307.1566750478955;3355.4295769719206;3355.6476569959805;3367.9326413471595;3369.646187150314;5702.572307076985;5841.620294680917;5855.238818953594;5865.618734782225;5868.882622347529;6354.4281014708895;6359.904601430982;6395.936040639627;6402.03969404593;6406;5798.5651076168615;5822.70886455684;5827.417258274223;5834.591578589543;5842.6202296849715;5980.282366116094;6195;6202.627842329474;6207.472364849038;6214.098955651315;6032.487238584769;6036.879262414639;6039.5470339723815;6043.335233124265;6061.181740465157;5804.506616937608;5831.70841457917;5831.708414579339;5838.211841401527;5850.561207909339;4044.4539987101366;4092.161106973004;4097.651699605448;4098.856540021085;4101.507819061731;6052.394760523913;6207.81376558704;6210.937890621217;6214.658193799384;6217.968910155601;5962.970185149046;5972.850678732892;5978.133170690313;5979.4917432018765;5982.970085149546;5936.821895343147;5951.702414879325;5959.91060134107;5983.910241346471;5993.0710739835395;5737.799177028951;5826.096954971986;5848.824535263949;5864.648121112747;5866;6005.399460054135;6010.098485227076;6019.51843852482;6030.125631783455;6030.7889223876955;5719.142128680731;5831.620944638585;5849.64902105875;5851.180834683233;5855.912161317498 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: |5;yui.html;703.6692754405427;741.7478057460463;766.3294617209941;767.2136060537948;781.4920301803828;11647.359395233269;11749.647510574676;11853.703657408569;11957.880421195785;11997.820032699505;10871.782564348709;10929.617463388764;12944.482220711183;12972.091953563255;13010.544630937919;758;758.5107605594388;760.9992859389912;763.4159867701213;768.6003278295283;788.1409263902345;789.4197764643012;796.5698522797683;796.7092011415849;797.2306724011328;811.6996711216858;815.2947700239309;817.1215942861447;819.2053707903324;821.2280456371022;805.1626308639009;805.3154818404367;805.8227190018157;810.2626609785096;812.0174588747623;599.1342510072947;600.1687662587304;600.8798240351904;601.2574470528937;604.2326245668021;11888.346140962243;11915.285082894967;11988.220765650205;12001.51993920242;12019.579314723942;10687.893121068846;11020.834687479693;11172.888271117346;11308.151888608305;11727.4136293185;9288.11762882525;9312.72061838146;9385.10841470066;9465.195458386046;9845.80308393828;3194.185482701919;3227.3061291822137;3260.96739032609;3263.7878537894962;3285.342931413703;42974.14051718948;43148.78425607852;43470;43906.780466097465;43988.3401748974;9138.223251023737;9351.579178936965;9355.672551460666;9379.296552758571;9425.905740942502;16027;16274.349026038826;16300.755488667679;16347.18264086791;16376;6411.775587854496;6423.261324947597;6460.903086453707;6525.641089740015;6587.440067594212;3508.3334166508794;3589.246258285737;3596.928061438809;3631.092226943264;3651.72612054097;2661.161734053767;2663.6537250157357;2669.8798554065115;2697.4470233602456;2706.4992976299054;488.2773495227084;495.9925601115986;498.5014985014985;500.12228538913973;506.1420891588722;483.1568912248079;494.77487743076813;497.29880867976703;548.9286392768994;549.1323708540497;7516.47384683067;7613.428992825449;7662.65518051689;7684.193159718149;7933.127355990837;454.3933848312474;465.6251717367552;543.5162705192382;569.900267453194;610.7618028968617;3730.7948062856804;3799.411091280856;3860.9806950965626;3926.823292951824;4010.438538604598;45888.08223835505;46751.29873051907;47393;47425.28862067072;47516.762416187696;43084;43497.56502434935;43960.3405948911;44476.55523444724;44521.10957780891;37104.5882017668;38788.61211387906;39020.609793902266;39754.403683944765;40977.79511102366;8065.354771618374;8100.351971842357;8143.18568143181;8143.226393492609;8516.147021041485;31433;31476.842615786776;31886;32123.35753284968;32392.380380980387;38981.80509097436;39431.80284098561;39923.60076399199;40059.59940400559;40180.79909600433;10164.847527287244;10198.235132365251;10230.437325947145;10255.282130250811;10347.84478232812;10956.178286628694;11145.108391328513;11338.716532086764;11707.648770536898;11985.981191598463;10894.61868834587;10907.400092994962;10994.945025274823;11257.943710281395;11530.59642912494;10670.35977841332;10841.566337346418;10906.291091079054;10930.070943969851;10958.12335013213;11031.613893513688;11034.834477483004;11039.889601103887;11055.83416248773;11088.445577721242;8961.372703910663;9022.278217742696;9273.350865439354;9376.671816486663;9476.810463790824;8389;8591.957040214758;8817.382783205114;8880.955595221982;8923.553822308988 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1448562885084__endTimestamp 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,095 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4774.57 Median:4874.98 stddev:493.52 (10.1%) stddev-sans-first:467.23 10:34:45 INFO - 2015-11-26 10:34:45,096 DEBUG : BROWSER_OUTPUT: Values: 2692.5 2742.1 2786.4 2786.7 2813.4 4651.0 4836.3 4864.4 4884.8 4901.9 4765.7 4769.4 4816.3 4833.1 4876.5 4461.0 4461.4 4501.2 4505.1 4611.4 4555.7 4555.8 4587.6 4604.3 4631.6 4265.1 4369.1 4411.8 4493.6 4519.7 4503.5 4512.1 4520.0 4526.6 4568.8 4474.5 4489.1 4500.3 4505.9 4535.9 4518.8 4542.3 4625.5 4677.5 4731.1 5187.6 5212.3 5228.9 5229.7 5258.7 5121.9 5281.6 5283.6 5284.2 5287.7 4762.1 4799.5 4824.4 4835.0 4878.2 5275.7 5317.9 5336.8 5345.1 5385.5 4852.8 4968.6 5091.3 5092.6 5109.5 5078.2 5158.7 5161.8 5177.4 5222.1 5106.7 5132.6 5152.5 5168.1 5198.7 4865.7 4964.0 4978.6 5107.2 5123.1 4199.0 4240.7 4248.7 4295.6 4330.5 3786.2 3788.2 3797.7 3828.3 3840.9 4372.8 4529.5 4538.5 4540.0 4577.9 5066.7 5093.1 5141.2 5153.0 5194.2 4500.5 4519.3 4536.2 4538.1 4560.8 4462.8 4588.1 4622.8 4640.8 4676.2 4808.1 4816.0 4875.0 4885.8 4905.4 5192.6 5199.6 5201.0 5226.2 5247.8 4688.5 4804.5 4813.2 4922.8 4923.6 5046.0 5070.8 5071.7 5077.0 5086.1 5182.8 5261.3 5279.1 5289.7 5355.7 5010.4 5040.5 5043.0 5051.7 5077.9 4828.9 4942.9 4961.6 5004.4 5052.7 4847.6 4865.8 4885.9 4919.4 4923.0 5075.3 5115.9 5135.8 5155.4 5156.8 4748.9 4887.0 4972.3 5007.9 5021.8 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42730.23 Median:37750.84 stddev:69090.08 (183.0%) stddev-sans-first:69211.34 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: Values: 559.2 566.4 573.5 574.6 578.1 36445.5 36565.5 36760.4 36792.3 36904.3 39673.6 39808.8 40165.6 40270.2 40341.6 7867.2 7961.4 7965.1 7991.0 8043.8 7895.2 7970.2 7990.5 8006.8 8031.8 7931.2 7941.6 8016.1 8025.1 8036.9 7939.3 7990.1 7998.2 8026.4 8057.9 7929.9 8039.2 8051.0 8053.8 8054.8 37409.0 37730.4 37804.2 37834.8 37922.2 2451.5 2906.0 2929.2 2949.9 3007.2 25640.3 27436.9 27549.9 27708.4 28579.9 3407.4 3407.7 3418.0 3507.4 3569.1 193523.0 194195.0 194387.0 195220.0 195677.0 47061.0 47997.8 52306.5 55535.7 56334.7 51808.7 52132.0 52525.5 52628.7 52680.2 13596.3 13597.3 13741.4 13775.4 13777.6 9568.8 9569.6 9614.4 9654.0 9656.2 18906.6 19163.2 19167.5 19203.0 19316.0 7225.0 7417.5 7439.9 7458.4 7560.6 851.7 854.1 926.6 927.2 967.4 27040.5 27059.5 27326.9 27456.9 27538.6 927.2 963.9 986.7 1020.1 1080.9 14339.7 14588.6 14621.9 14744.4 14984.4 317456.0 320907.0 322941.0 322942.0 322997.0 48994.8 49050.8 49404.5 49533.3 49569.8 1204.9 1212.5 1216.4 1226.1 1234.8 27643.7 27883.3 28319.4 29020.7 30078.4 44063.8 44611.8 45042.0 45092.3 45142.1 259896.0 260415.0 261911.0 262364.0 262395.0 37174.6 41566.8 42261.7 42467.0 42684.6 45642.0 45806.0 45943.3 46091.5 46428.1 33135.7 33291.3 33979.7 34163.1 34308.8 34218.7 34315.1 34667.7 34777.8 34962.3 37730.4 37771.2 38323.8 38563.0 38843.8 28042.0 28909.4 33911.5 35423.5 35452.6 23850.9 23889.2 24195.0 24304.0 24384.5 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27708.75 Median:398.85 stddev:85192.37 (21359.6%) stddev-sans-first:85406.52 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: Values: 312.6 324.1 325.0 325.8 327.5 14640.2 15152.9 15711.8 15924.8 16380.2 15380.6 15449.5 15500.5 15501.9 15695.1 5255.2 5464.1 5466.8 5467.8 5484.7 5347.6 5355.8 5679.9 5680.5 5710.8 3941.2 4035.7 5680.0 5695.4 6457.2 6610.6 6633.3 6654.8 6659.3 6668.6 6307.8 6522.3 6546.5 6562.1 6589.1 20373.9 20872.4 21166.8 21199.7 21967.6 1792.4 1838.9 1863.2 1980.3 2122.1 12254.9 12780.0 13001.3 13184.7 13258.6 1615.2 1639.5 1699.9 1730.8 1759.2 50393.5 50677.5 51184.7 51322.2 58829.4 14844.8 15355.7 15493.5 15520.4 15531.2 23150.3 23193.9 23249.2 23376.5 23419.5 8610.7 8673.3 8696.9 8698.4 8752.5 7175.6 7260.7 7283.0 7299.6 7304.1 7590.0 7645.1 7673.9 7677.0 7705.3 3098.1 3189.1 3210.5 3246.4 3293.8 348.2 358.3 393.8 402.2 408.5 9913.8 10213.4 10246.7 10315.5 10492.3 386.8 398.2 398.4 399.0 414.0 5335.3 5513.4 5516.7 5625.9 5663.3 510115.0 517510.0 525286.0 526983.0 530961.0 71462.3 73812.0 74529.0 75663.0 75967.0 398.7 402.7 406.3 410.2 410.6 9473.4 9510.0 9530.5 9720.8 9730.8 29933.9 31521.7 31961.2 34844.3 35369.0 42091.2 42494.4 44254.3 44770.0 45295.0 8763.6 8793.3 8865.8 8964.2 9000.3 10599.1 10638.4 10654.1 10739.6 11243.4 13056.5 13104.3 13130.1 14063.9 14140.3 13308.2 13436.3 13461.5 13933.7 14165.5 13631.0 13747.7 14212.4 14315.2 14395.1 8343.9 8358.2 8366.0 8792.7 8806.9 9115.8 12954.1 13042.3 13069.3 13644.5 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,097 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4662.94 Median:5993.70 stddev:2371.79 (39.6%) stddev-sans-first:2366.32 10:34:45 INFO - 2015-11-26 10:34:45,099 DEBUG : BROWSER_OUTPUT: Values: 1472.0 1577.2 1647.2 1656.8 1691.0 6662.4 6712.8 6868.5 6908.7 6909.3 6759.0 6790.6 6830.9 6831.4 6835.4 1969.6 1998.9 2003.2 2005.4 2010.1 2005.6 2020.4 2026.1 2029.8 2039.4 1921.7 1950.4 1965.0 1967.5 1984.5 1967.1 1988.0 1989.7 1994.5 1995.7 1982.7 2041.2 2042.5 2048.5 2056.8 6612.6 6676.1 6679.4 6679.8 6683.6 3983.7 4071.7 4080.1 4088.7 4103.0 2612.6 2622.0 2680.2 2685.0 2686.5 825.2 831.8 839.3 845.7 855.8 8583.3 8619.4 8657.0 8673.0 8675.9 3503.1 3548.7 3567.3 3601.4 3612.1 7212.6 7219.2 7226.2 7231.4 7284.3 3821.9 3823.8 3826.4 3835.3 3861.0 3512.1 3554.0 3556.3 3563.2 3576.0 3024.3 3052.4 3053.0 3065.3 3066.2 873.7 879.7 885.8 897.7 898.2 915.6 926.5 930.0 978.5 1012.9 6153.7 6176.9 6202.7 6215.2 6218.5 1001.2 1012.8 1014.9 1018.5 1026.2 4827.8 4842.2 4867.8 4868.6 4879.2 7781.1 7916.3 7977.9 7981.7 8035.7 7993.8 8089.8 8098.6 8117.3 8170.5 6285.2 6340.0 6352.3 6355.0 6378.1 5890.4 5920.5 5931.1 5969.1 5985.5 7009.0 7086.6 7094.9 7110.2 7211.1 7075.7 7230.2 7253.7 7266.4 7361.1 5909.6 6007.7 6009.7 6034.8 6042.9 6384.4 6416.8 6434.0 6461.0 6464.8 5988.4 6162.6 6195.0 6240.6 6308.2 5822.2 5865.6 5976.6 6069.5 6118.6 5999.0 6024.3 6067.3 6080.2 6094.3 5648.5 5661.1 5662.8 5678.3 5685.9 5548.9 5569.0 5724.3 5729.4 5742.5 10:34:45 INFO - 2015-11-26 10:34:45,099 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,099 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4898.21 Median:5583.04 stddev:1465.08 (26.2%) stddev-sans-first:1427.82 10:34:45 INFO - 2015-11-26 10:34:45,099 DEBUG : BROWSER_OUTPUT: Values: 292.0 297.6 301.4 302.9 305.9 5561.7 5581.0 5692.6 5708.9 5730.4 5558.0 5567.2 5585.1 5594.6 5610.4 4051.3 4350.9 4352.9 4359.6 4364.6 4174.3 4231.5 4356.2 4362.4 4362.8 4291.2 4294.9 4316.5 4316.8 4322.2 4305.2 4315.3 4316.8 4335.6 4338.8 3800.8 3803.9 3810.7 3813.0 3820.7 5247.7 5414.4 5445.3 5463.0 5468.2 4876.4 4889.5 4900.1 4913.0 4918.6 5900.9 5902.4 5908.8 5912.9 5914.1 3993.9 3998.6 3999.8 4002.3 4004.5 5928.3 6188.7 6193.1 6221.3 6226.3 4133.6 4139.0 4140.3 4143.3 4150.5 4202.6 4207.5 4210.5 4216.7 4226.0 4860.4 4863.9 4867.1 4872.5 4877.6 5737.2 5847.4 5890.4 5890.8 5907.6 1468.8 1482.9 1484.1 1486.8 1487.2 979.8 987.7 997.7 1006.5 1009.8 5161.5 5161.8 5163.3 5178.7 5193.2 6036.7 6152.4 6200.8 6241.0 6275.1 5168.5 5187.6 5188.6 5196.3 5214.9 3307.2 3355.4 3355.6 3367.9 3369.6 5702.6 5841.6 5855.2 5865.6 5868.9 6354.4 6359.9 6395.9 6402.0 6406.0 5798.6 5822.7 5827.4 5834.6 5842.6 5980.3 6195.0 6202.6 6207.5 6214.1 6032.5 6036.9 6039.5 6043.3 6061.2 5804.5 5831.7 5831.7 5838.2 5850.6 4044.5 4092.2 4097.7 4098.9 4101.5 6052.4 6207.8 6210.9 6214.7 6218.0 5963.0 5972.9 5978.1 5979.5 5983.0 5936.8 5951.7 5959.9 5983.9 5993.1 5737.8 5826.1 5848.8 5864.6 5866.0 6005.4 6010.1 6019.5 6030.1 6030.8 5719.1 5831.6 5849.6 5851.2 5855.9 10:34:45 INFO - 2015-11-26 10:34:45,100 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,100 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12270.88 Median:43933.56 stddev:13691.50 (31.2%) stddev-sans-first:13702.35 10:34:45 INFO - 2015-11-26 10:34:45,100 DEBUG : BROWSER_OUTPUT: Values: 703.7 741.7 766.3 767.2 781.5 11647.4 11749.6 11853.7 11957.9 11997.8 10871.8 10929.6 12944.5 12972.1 13010.5 758.0 758.5 761.0 763.4 768.6 788.1 789.4 796.6 796.7 797.2 811.7 815.3 817.1 819.2 821.2 805.2 805.3 805.8 810.3 812.0 599.1 600.2 600.9 601.3 604.2 11888.3 11915.3 11988.2 12001.5 12019.6 10687.9 11020.8 11172.9 11308.2 11727.4 9288.1 9312.7 9385.1 9465.2 9845.8 3194.2 3227.3 3261.0 3263.8 3285.3 42974.1 43148.8 43470.0 43906.8 43988.3 9138.2 9351.6 9355.7 9379.3 9425.9 16027.0 16274.3 16300.8 16347.2 16376.0 6411.8 6423.3 6460.9 6525.6 6587.4 3508.3 3589.2 3596.9 3631.1 3651.7 2661.2 2663.7 2669.9 2697.4 2706.5 488.3 496.0 498.5 500.1 506.1 483.2 494.8 497.3 548.9 549.1 7516.5 7613.4 7662.7 7684.2 7933.1 454.4 465.6 543.5 569.9 610.8 3730.8 3799.4 3861.0 3926.8 4010.4 45888.1 46751.3 47393.0 47425.3 47516.8 43084.0 43497.6 43960.3 44476.6 44521.1 37104.6 38788.6 39020.6 39754.4 40977.8 8065.4 8100.4 8143.2 8143.2 8516.1 31433.0 31476.8 31886.0 32123.4 32392.4 38981.8 39431.8 39923.6 40059.6 40180.8 10164.8 10198.2 10230.4 10255.3 10347.8 10956.2 11145.1 11338.7 11707.6 11986.0 10894.6 10907.4 10994.9 11257.9 11530.6 10670.4 10841.6 10906.3 10930.1 10958.1 11031.6 11034.8 11039.9 11055.8 11088.4 8961.4 9022.3 9273.4 9376.7 9476.8 8389.0 8592.0 8817.4 8881.0 8923.6 10:34:45 INFO - 2015-11-26 10:34:45,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:34:45 INFO - 2015-11-26 10:34:45,100 DEBUG : BROWSER_OUTPUT: 10:34:45 INFO - 2015-11-26 10:34:45,802 INFO : Browser exited with error code: 0 10:34:45 INFO - 2015-11-26 10:34:45,820 INFO : Completed test dromaeo_css (00:18:34) 10:34:45 INFO - 2015-11-26 10:34:45,820 INFO : Starting test kraken 10:34:45 INFO - 2015-11-26 10:34:45,820 DEBUG : operating with platform_type : linux_ 10:34:45 INFO - 2015-11-26 10:34:45,821 INFO : Initialising browser for kraken test... 10:34:45 INFO - 2015-11-26 10:34:45,827 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aWV1L/profile http://localhost:52252/getInfo.html 10:34:50 INFO - 2015-11-26 10:34:50,915 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:34:50 INFO - 2015-11-26 10:34:50,915 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:34:50 INFO - 2015-11-26 10:34:50,915 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:34:50 INFO - 2015-11-26 10:34:50,915 DEBUG : BROWSER_OUTPUT: __metrics 10:34:52 INFO - 2015-11-26 10:34:52,042 INFO : Browser initialized. 10:34:52 INFO - 2015-11-26 10:34:52,042 INFO : Running cycle 1/1 for kraken test... 10:34:52 INFO - 2015-11-26 10:34:52,042 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aWV1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:35:03 INFO - 2015-11-26 10:35:03,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 140304384 10:35:03 INFO - 2015-11-26 10:35:03,912 DEBUG : BROWSER_OUTPUT: 10:35:06 INFO - 2015-11-26 10:35:06,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:07 INFO - 2015-11-26 10:35:07,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 140128256 10:35:07 INFO - 2015-11-26 10:35:07,142 DEBUG : BROWSER_OUTPUT: 10:35:09 INFO - 2015-11-26 10:35:09,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-dft) 10:35:10 INFO - 2015-11-26 10:35:10,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 140267520 10:35:10 INFO - 2015-11-26 10:35:10,528 DEBUG : BROWSER_OUTPUT: 10:35:13 INFO - 2015-11-26 10:35:13,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-fft) 10:35:14 INFO - 2015-11-26 10:35:14,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 134774784 10:35:14 INFO - 2015-11-26 10:35:14,028 DEBUG : BROWSER_OUTPUT: 10:35:16 INFO - 2015-11-26 10:35:16,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52252/tests/kraken/driver.html?testName=audio-oscillator) 10:35:16 INFO - 2015-11-26 10:35:16,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 135471104 10:35:16 INFO - 2015-11-26 10:35:16,666 DEBUG : BROWSER_OUTPUT: 10:35:18 INFO - 2015-11-26 10:35:18,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:19 INFO - 2015-11-26 10:35:19,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 136822784 10:35:19 INFO - 2015-11-26 10:35:19,520 DEBUG : BROWSER_OUTPUT: 10:35:22 INFO - 2015-11-26 10:35:22,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:23 INFO - 2015-11-26 10:35:23,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 137220096 10:35:23 INFO - 2015-11-26 10:35:23,172 DEBUG : BROWSER_OUTPUT: 10:35:26 INFO - 2015-11-26 10:35:26,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52252/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:27 INFO - 2015-11-26 10:35:27,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 135090176 10:35:27 INFO - 2015-11-26 10:35:27,257 DEBUG : BROWSER_OUTPUT: 10:35:30 INFO - 2015-11-26 10:35:30,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52252/tests/kraken/driver.html?testName=json-parse-financial) 10:35:30 INFO - 2015-11-26 10:35:30,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 135856128 10:35:30 INFO - 2015-11-26 10:35:30,760 DEBUG : BROWSER_OUTPUT: 10:35:32 INFO - 2015-11-26 10:35:32,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:33 INFO - 2015-11-26 10:35:33,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 138231808 10:35:33 INFO - 2015-11-26 10:35:33,142 DEBUG : BROWSER_OUTPUT: 10:35:35 INFO - 2015-11-26 10:35:35,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:35 INFO - 2015-11-26 10:35:35,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 137576448 10:35:35 INFO - 2015-11-26 10:35:35,661 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-26 10:35:37,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:38 INFO - 2015-11-26 10:35:38,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 136577024 10:35:38 INFO - 2015-11-26 10:35:38,426 DEBUG : BROWSER_OUTPUT: 10:35:41 INFO - 2015-11-26 10:35:41,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:41 INFO - 2015-11-26 10:35:41,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 136650752 10:35:41 INFO - 2015-11-26 10:35:41,644 DEBUG : BROWSER_OUTPUT: 10:35:44 INFO - 2015-11-26 10:35:44,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:44 INFO - 2015-11-26 10:35:44,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 10:35:44 INFO - 2015-11-26 10:35:44,894 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52252/tests/kraken/driver.html?testName=ai-astar) 10:35:46 INFO - 2015-11-26 10:35:46,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 138682368 10:35:46 INFO - 2015-11-26 10:35:46,906 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;114;114;113;124;114;112;113;113 10:35:46 INFO - 2015-11-26 10:35:46,910 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;134;168;165;132;155;160;148;170;131 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;163;161;161;163;168;163;164;164 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;73;74;128;73;79;71;73;85 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;125;95;94;94;132;94;96;128 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;112;109;110;110;110 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;148;148;148;148;146;148;148;148 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;95;96;96;97;97;96;96 10:35:46 INFO - 2015-11-26 10:35:46,911 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;79;75;75;76;74;75;77;74;72 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;71;70;69;69;70;69 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;91;84;84;83;91;84;87;84;84 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;126;131;118;130;139;123;128;134;130 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;153;146;152;154;148;151;147;151;146 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;70;71;69;70;69;70;69;69 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:35:46 INFO - 2015-11-26 10:35:46,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 10:35:46 INFO - 2015-11-26 10:35:46,913 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:35:46 INFO - 2015-11-26 10:35:46,913 DEBUG : BROWSER_OUTPUT: __startTimestamp1448562946908__endTimestamp 10:35:46 INFO - 2015-11-26 10:35:46,913 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,920 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:35:46 INFO - 2015-11-26 10:35:46,921 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:35:46 INFO - 2015-11-26 10:35:46,921 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,921 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:4.16 (3.6%) stddev-sans-first:4.41 10:35:46 INFO - 2015-11-26 10:35:46,921 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 114.0 114.0 113.0 124.0 114.0 112.0 113.0 113.0 10:35:46 INFO - 2015-11-26 10:35:46,922 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,922 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.50 Median:161.00 stddev:15.28 (9.5%) stddev-sans-first:15.81 10:35:46 INFO - 2015-11-26 10:35:46,922 DEBUG : BROWSER_OUTPUT: Values: 162.0 134.0 168.0 165.0 132.0 155.0 160.0 148.0 170.0 131.0 10:35:46 INFO - 2015-11-26 10:35:46,922 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,922 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:2.01 (1.2%) stddev-sans-first:2.13 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 163.0 161.0 161.0 163.0 168.0 163.0 164.0 164.0 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:17.44 (23.9%) stddev-sans-first:18.20 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 74.0 128.0 73.0 79.0 71.0 73.0 85.0 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,923 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:94.00 stddev:16.47 (17.5%) stddev-sans-first:17.02 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 125.0 95.0 94.0 94.0 132.0 94.0 96.0 128.0 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 112.0 109.0 110.0 110.0 110.0 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 148.0 148.0 148.0 148.0 146.0 148.0 148.0 148.0 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 95.0 96.0 96.0 97.0 97.0 96.0 96.0 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,924 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:75.00 stddev:1.87 (2.5%) stddev-sans-first:1.99 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: Values: 75.0 79.0 75.0 75.0 76.0 74.0 75.0 77.0 74.0 72.0 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 71.0 70.0 69.0 69.0 70.0 69.0 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.00 stddev:3.10 (3.7%) stddev-sans-first:3.15 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: Values: 83.0 91.0 84.0 84.0 83.0 91.0 84.0 87.0 84.0 84.0 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,925 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:130.50 stddev:5.79 (4.4%) stddev-sans-first:6.10 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: Values: 131.0 126.0 131.0 118.0 130.0 139.0 123.0 128.0 134.0 130.0 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:151.50 stddev:3.33 (2.2%) stddev-sans-first:3.07 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: Values: 155.0 153.0 146.0 152.0 154.0 148.0 151.0 147.0 151.0 146.0 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.79 (1.1%) stddev-sans-first:0.71 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 71.0 69.0 70.0 69.0 70.0 69.0 69.0 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:35:46 INFO - 2015-11-26 10:35:46,926 DEBUG : BROWSER_OUTPUT: 10:35:47 INFO - 2015-11-26 10:35:47,842 INFO : Browser exited with error code: 0 10:35:47 INFO - 2015-11-26 10:35:47,892 INFO : Completed test kraken (00:01:02) 10:35:47 INFO - 2015-11-26 10:35:47,893 INFO : Starting test v8_7 10:35:47 INFO - 2015-11-26 10:35:47,893 DEBUG : operating with platform_type : linux_ 10:35:47 INFO - 2015-11-26 10:35:47,893 INFO : Initialising browser for v8_7 test... 10:35:47 INFO - 2015-11-26 10:35:47,899 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAQ7uA/profile http://localhost:52252/getInfo.html 10:35:53 INFO - 2015-11-26 10:35:53,084 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:35:53 INFO - 2015-11-26 10:35:53,085 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:35:53 INFO - 2015-11-26 10:35:53,085 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:35:53 INFO - 2015-11-26 10:35:53,085 DEBUG : BROWSER_OUTPUT: __metrics 10:35:54 INFO - 2015-11-26 10:35:54,286 INFO : Browser initialized. 10:35:54 INFO - 2015-11-26 10:35:54,286 INFO : Running cycle 1/1 for v8_7 test... 10:35:54 INFO - 2015-11-26 10:35:54,286 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAQ7uA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:36:06 INFO - 2015-11-26 10:36:06,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 138231808 10:36:06 INFO - 2015-11-26 10:36:06,194 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52252/tests/v8_7/run.html (next: http://localhost:52252/tests/v8_7/run.html) 10:36:27 INFO - 2015-11-26 10:36:27,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 136880128 10:36:27 INFO - 2015-11-26 10:36:27,772 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |0;Richards;167.0843776106934 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.20458891013385 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |5;Earley;697.8367062107467 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |6;Boyer;12670.886075949367 10:36:27 INFO - 2015-11-26 10:36:27,774 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: |8;Splay;617.283950617284 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1448562987772__endTimestamp 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: Values: 167.1 10:36:27 INFO - 2015-11-26 10:36:27,775 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: Values: 191.2 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: Values: 277.7 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: Values: 5196.9 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,776 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,777 DEBUG : BROWSER_OUTPUT: Values: 1056.0 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.84 Median:697.84 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: Values: 697.8 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12670.89 Median:12670.89 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: Values: 12670.9 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,778 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: Values: 25743.6 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: Values: 617.3 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 10:36:27 INFO - 2015-11-26 10:36:27,779 DEBUG : BROWSER_OUTPUT: Values: 4854.4 10:36:27 INFO - 2015-11-26 10:36:27,780 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:36:27 INFO - 2015-11-26 10:36:27,780 DEBUG : BROWSER_OUTPUT: 10:36:28 INFO - 2015-11-26 10:36:28,682 INFO : Browser exited with error code: 0 10:36:28 INFO - 2015-11-26 10:36:28,696 INFO : Completed test v8_7 (00:00:40) 10:36:28 INFO - 2015-11-26 10:36:28,864 INFO : Completed test suite (00:20:17) 10:36:28 INFO - 2015-11-26 10:36:28,864 DEBUG : Working with test: dromaeo_css 10:36:28 INFO - 2015-11-26 10:36:28,864 DEBUG : Generating results file: dromaeo_css 10:36:28 INFO - 2015-11-26 10:36:28,865 DEBUG : Working with test: kraken 10:36:28 INFO - 2015-11-26 10:36:28,866 DEBUG : Generating results file: kraken 10:36:28 INFO - 2015-11-26 10:36:28,866 INFO : javascript benchmark 10:36:28 INFO - 2015-11-26 10:36:28,866 DEBUG : Working with test: v8_7 10:36:28 INFO - 2015-11-26 10:36:28,866 DEBUG : Generating results file: v8_7 10:36:28 INFO - 2015-11-26 10:36:28,867 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:29 INFO - 2015-11-26 10:36:29,011 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:36:29 INFO - 2015-11-26 10:36:29,011 DEBUG : process_Request line: dromaeo_css 6348.31 graph.html#tests=[[72,132,43]] 10:36:29 INFO - 2015-11-26 10:36:29,012 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:29 INFO - 2015-11-26 10:36:29,047 DEBUG : process_Request line: kraken 1548.30 graph.html#tests=[[232,132,43]] 10:36:29 INFO - 2015-11-26 10:36:29,047 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:29 INFO - 2015-11-26 10:36:29,080 DEBUG : process_Request line: v8_7 21251.38 graph.html#tests=[[230,132,43]] 10:36:29 INFO - 2015-11-26 10:36:29,081 INFO : javascript benchmark 10:36:29 INFO - 2015-11-26 10:36:29,085 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2692.46150769846, 2742.1499335206076, 2786.359137398398, 2786.679531853836, 2813.3810561676437, 4650.953490465095, 4836.322914791932, 4864.391951006124, 4884.829030983917, 4901.901961960763, 4765.666403351766, 4769.379980602525, 4816.325714399987, 4833.057553777015, 4876.463589005216, 4461.040876211622, 4461.353103799947, 4501.189785838547, 4505.121501307246, 4611.354410382549, 4555.658325625592, 4555.794989225493, 4587.564181402778, 4604.286335617984, 4631.560001799824, 4265.0830071534765, 4369.082492676542, 4411.757353345564, 4493.6405087593075, 4519.728816271035, 4503.459584849839, 4512.142692888341, 4519.977400113011, 4526.615237704799, 4568.8400905968465, 4474.485434175079, 4489.057297967431, 4500.302453119772, 4505.909881802379, 4535.863924082283, 4518.774061296955, 4542.250528662799, 4625.514320996314, 4677.508861569554, 4731.124741922756, 5187.636865419422, 5212.348456442945, 5228.895422091537, 5229.738513074331, 5258.684478931276, 5121.871953201163, 5281.63028587999, 5283.577313814885, 5284.180951952453, 5287.68273903567, 4762.071396077801, 4799.544043315879, 4824.396950381202, 4835.032993401333, 4878.243872199815, 5275.736213189325, 5317.9202311965355, 5336.839894803162, 5345.144776835766, 5385.488378604026, 4852.8301509447, 4968.552830245223, 5091.261767043832, 5092.567131793765, 5109.540141387219, 5078.162103252922, 5158.690478571222, 5161.81933632321, 5177.430482646906, 5222.086134926372, 5106.744662766847, 5132.589392848563, 5152.536271735562, 5168.095583272912, 5198.688078715213, 4865.683730557503, 4963.950360496421, 4978.626603004789, 5107.182850743863, 5123.129068058439, 4199.0, 4240.660747140283, 4248.723832950848, 4295.634871035934, 4330.458692663417, 3786.1859700164596, 3788.1855401088897, 3797.734158608926, 3828.3109040373, 3840.9039774005873, 4372.803223854934, 4529.5243999380245, 4538.500764915857, 4540.0, 4577.885552861205, 5066.695998240118, 5093.134167191586, 5141.228815677603, 5153.0, 5194.168932970707, 4500.549945005539, 4519.276915693539, 4536.206163921366, 4538.069695712371, 4560.794764235618, 4462.7768611569945, 4588.105319462673, 4622.791974361162, 4640.767961601907, 4676.158291507561, 4808.134535783593, 4815.975920120377, 4874.976254986493, 4885.804567817389, 4905.411350637875, 5192.5586325162785, 5199.610029247746, 5201.037808005531, 5226.2421948816445, 5247.816326428557, 4688.460827004938, 4804.543568361, 4813.205821039489, 4922.82770103059, 4923.630727695366, 5046.041252162077, 5070.847874563769, 5071.721055341992, 5077.0, 5086.135356989246, 5182.844514664566, 5261.263423120843, 5279.128943724242, 5289.68261904287, 5355.651882627617, 5010.423801262901, 5040.495950405077, 5042.991401719744, 5051.696898185974, 5077.898442031064, 4828.903421931612, 4942.851714448572, 4961.578265847444, 5004.374453193351, 5052.72210028452, 4847.636427267898, 4865.781039853145, 4885.926711099408, 4919.409670839522, 4923.0, 5075.264086707333, 5115.897682046412, 5135.820246291362, 5155.355580552431, 5156.819511317086, 4748.928766068442, 4886.975565122151, 4972.2790195422185, 5007.949920500749, 5021.84934451967], "unit": "ms", "name": "dojo.html", "value": 4744.090605074185}, {"lowerIsBetter": false, "replicates": [559.1556749308543, 566.354356034121, 573.4724053870439, 574.6322353693637, 578.0895090232882, 36445.45331820025, 36565.45151822718, 36760.448593271125, 36792.264154716926, 36904.26191476172, 39673.60326396735, 39808.80095599518, 40165.59834401655, 40270.19459610814, 40341.59658403415, 7867.1739467355965, 7961.442699011042, 7965.084015338223, 7991.041075071, 8043.798905027363, 7895.210478952087, 7970.202979702012, 7990.520568765893, 8006.759797206093, 8031.799205019863, 7931.206879312052, 7941.64262608184, 8016.118226995026, 8025.0771161316325, 8036.879446808302, 7939.325157361631, 7990.12108668046, 7998.1601931797195, 8026.43814932955, 8057.879131813057, 7929.920700792976, 8039.155888631668, 8051.0, 8053.838923221561, 8054.838903221903, 37409.0, 37730.43404348937, 37804.24391512182, 37834.81082594569, 37922.24155516902, 2451.497443024176, 2906.0264811288243, 2929.1651879214533, 2949.8967536136347, 3007.1579957611903, 25640.260431432886, 27436.862815685992, 27549.862250688617, 27708.445831083467, 28579.857100714573, 3407.386670399327, 3407.6592340765974, 3417.9829100854336, 3507.4448602595708, 3569.089882080079, 193523.0, 194194.99999999857, 194387.0, 195220.0, 195677.0, 47061.0, 47997.76001119972, 52306.47693523016, 55535.722321388945, 56334.7183264081, 51808.740956294976, 52132.0, 52525.474745252825, 52628.73685631624, 52680.20979685308, 13596.320183990762, 13597.252151131783, 13741.381637826322, 13775.448982040807, 13777.586672399644, 9568.760780980392, 9569.61721531131, 9614.375065620712, 9654.03459654043, 9656.179224765974, 18906.621867562848, 19163.233470661016, 19167.52081197981, 19203.0, 19316.0, 7224.963875180591, 7417.480776345604, 7439.888401673979, 7458.4033277337685, 7560.58416787071, 851.714675583674, 854.0903937306748, 926.5645146781002, 927.2303987690201, 967.4388854464394, 27040.459190816466, 27059.458810824068, 27326.863365683046, 27456.862715686693, 27538.586921196198, 927.2322118476343, 963.9084286992725, 986.7039888033705, 1020.1074060197327, 1080.9471911225571, 14339.713205736036, 14588.635284117981, 14621.853781462261, 14744.41022359115, 14984.40062397492, 317456.0, 320907.0, 322941.0, 322942.0, 322997.0, 48994.755026224644, 49050.754746226754, 49404.50595494071, 49533.257001145015, 49569.752151239016, 1204.8614409343038, 1212.5210541835925, 1216.391804097951, 1226.0988173692328, 1234.7900856854535, 27643.723562764117, 27883.302917427227, 28319.43361132807, 29020.709792901802, 30078.398432031674, 44063.77968110267, 44611.77694111638, 45042.0, 45092.32361514645, 45142.09715805731, 259896.0, 260415.0, 261911.0, 262364.0, 262395.0, 37174.628253717114, 41566.79216603898, 42261.72371668644, 42467.0, 42684.57315426806, 45642.0, 45805.96134425144, 45943.3108503366, 46091.539084608725, 46428.071438571715, 33135.668643314224, 33291.334173316885, 33979.66020339864, 34163.14592135217, 34308.82845585756, 34218.657813421545, 34315.14212144716, 34667.653323466446, 34777.82611087029, 34962.300753985284, 37730.43404348882, 37771.2445751078, 38323.80838095792, 38563.03592410212, 38843.80578097091, 28042.0, 28909.421811564072, 33911.491327630596, 35423.46864797082, 35452.64547354494, 23850.88074559616, 23889.163879264142, 24195.0, 24304.0, 24384.51230975406], "unit": "ms", "name": "ext.html", "value": 17366.824798155056}, {"lowerIsBetter": false, "replicates": [312.5546096812042, 324.0747665415238, 324.9857571028708, 325.8012612306493, 327.4564223389173, 14640.194789286585, 15152.924235378821, 15711.764323535157, 15924.84075159251, 16380.180990950465, 15380.61548461289, 15449.45926892559, 15500.457483988062, 15501.922490387533, 15695.058296502219, 5255.185446255827, 5464.098423760075, 5466.753996070166, 5467.808626698066, 5484.670919744828, 5347.59893008024, 5355.758990845421, 5679.886402271952, 5680.488756011958, 5710.77156913723, 3941.1723538057045, 4035.6569691576105, 5680.0, 5695.430456954313, 6457.160569126007, 6610.636414997173, 6633.2703402625675, 6654.800355989328, 6659.3007734187695, 6668.599884006951, 6307.842303942392, 6522.282548919615, 6546.494306309528, 6562.146920900253, 6589.110470086573, 20373.898130509402, 20872.37382878516, 21166.788332116637, 21199.68200476994, 21967.560648786934, 1792.417464324087, 1838.9264429422808, 1863.1615772902248, 1980.2870966452065, 2122.1193204819983, 12254.877451225551, 12780.0, 13001.284929328978, 13184.736305273937, 13258.602241932662, 1615.1681883829838, 1639.4507839873656, 1699.9320027199021, 1730.835570620789, 1759.2171483689763, 50393.496065039246, 50677.493225068014, 51184.744076279756, 51322.23016654753, 58829.41170588282, 14844.777328340084, 15355.692886142215, 15493.457728979432, 15520.379184832706, 15531.223438828014, 23150.3054908353, 23193.884030580077, 23249.18627848051, 23376.532469350517, 23419.53160936806, 8610.655573777103, 8673.306135509145, 8696.869546956801, 8698.434601750865, 8752.47485150893, 7175.569465832067, 7260.745873894494, 7282.96358518204, 7299.5620262784405, 7304.086989126359, 7589.962050189824, 7645.082590089225, 7673.884891726629, 7677.0403699537555, 7705.267999540035, 3098.1325228935934, 3189.1229911773985, 3210.5344725014743, 3246.431874422014, 3293.7859039162377, 348.2217244458633, 358.2852209841331, 393.8129388540478, 402.24177425553046, 408.4628713242077, 9913.801723965624, 10213.438260895573, 10246.692599222035, 10315.535800888978, 10492.317999330018, 386.82399508223693, 398.21750260737787, 398.42029846573166, 398.9660878825274, 413.95682879144385, 5335.306410166653, 5513.448655134454, 5516.696581688046, 5625.859353516113, 5663.348714897757, 510115.0, 517510.0, 525286.0, 526983.0, 530961.0, 71462.28537714557, 73812.0, 74529.0, 75663.0, 75967.0, 398.7308566717454, 402.7281584930219, 406.2626333205282, 410.17554715022425, 410.6345352636216, 9473.384230025027, 9509.952450237704, 9530.475823829756, 9720.75698107553, 9730.75673108178, 29933.850330748206, 31521.684783151875, 31961.200969975936, 34844.303113938084, 35369.0, 42091.15817683691, 42494.36258456187, 44254.336184956606, 44770.0, 45295.0, 8763.649454021768, 8793.340499462694, 8865.822683546421, 8964.193222609996, 9000.279977601907, 10599.099076578577, 10638.41488718128, 10654.094401975919, 10739.570417183537, 11243.4378281084, 13056.477740890257, 13104.279264640156, 13130.146540474838, 14063.859361406256, 14140.292985350485, 13308.201507909556, 13436.328183590977, 13461.528846490326, 13933.72132557323, 14165.504207352693, 13631.04582679203, 13747.656308592364, 14212.360443780262, 14315.212663303619, 14395.136291822524, 8343.916560834314, 8358.205970432798, 8366.0, 8792.736217913473, 8806.911930880866, 9115.817683646157, 12954.093213475344, 13042.282674452996, 13069.281189534668, 13644.522441714493], "unit": "ms", "name": "jquery.html", "value": 8160.996677968195}, {"lowerIsBetter": false, "replicates": [1471.9696212651147, 1577.2113943028485, 1647.1599484263027, 1656.8177500474947, 1690.9999999999993, 6662.433693136077, 6712.832179195522, 6868.519203655746, 6908.654567271635, 6909.309069093095, 6758.966205168979, 6790.592564446137, 6830.897536536956, 6831.419329357011, 6835.350641689044, 1969.5765410436754, 1998.9000549972443, 2003.168684995725, 2005.3683089826732, 2010.1456880825663, 2005.6490114230023, 2020.4241791089541, 2026.0781344488223, 2029.8376129909573, 2039.3677959832426, 1921.6733155363622, 1950.3661310074212, 1964.9901750491229, 1967.4884530022155, 1984.5038740314922, 1967.0558132096603, 1987.9801201988012, 1989.7114918336904, 1994.4914046918088, 1995.670714332148, 1982.742243508349, 2041.1835265893612, 2042.5404284036122, 2048.5083579940856, 2056.7840376760373, 6612.636305003223, 6676.132102826601, 6679.365460281314, 6679.833004174934, 6683.5655682380975, 3983.6813054955824, 4071.7353372030725, 4080.0615858352744, 4088.6729061674996, 4103.035786590149, 2612.58198688209, 2621.9774288027684, 2680.2495301315466, 2685.0333879803256, 2686.462707458516, 825.1588853885114, 831.7920519870032, 839.2572573272637, 845.7420486751538, 855.8117214212863, 8583.313334933191, 8619.353548483889, 8656.956715216447, 8673.04596494385, 8675.913240867574, 3503.1067077894972, 3548.6628770266784, 3567.250877315793, 3601.3877640801124, 3612.1330880588994, 7212.567245965259, 7219.205887352387, 7226.205117437078, 7231.421486281085, 7284.307990740871, 3821.923561528754, 3823.789691566935, 3826.445165450994, 3835.271298453285, 3861.0, 3512.1395258161915, 3554.0, 3556.253186830743, 3563.2160924596546, 3575.982120089435, 3024.2892920163745, 3052.404781067715, 3052.9694703052687, 3065.3103051813164, 3066.1874603229717, 873.6505397840788, 879.6613303877925, 885.7608445719749, 897.7261935109724, 898.2499612823235, 915.56053094515, 926.5182105305204, 929.972100836976, 978.4520668425704, 1012.9290949633603, 6153.692315384303, 6176.8764624707255, 6202.658853762996, 6215.192025036717, 6218.471429928416, 1001.2290536287164, 1012.7518757904213, 1014.9035841595037, 1018.4856647393167, 1026.2457094035879, 4827.806887724451, 4842.225243960949, 4867.805287788448, 4868.586170175504, 4879.170541007966, 7781.105172905189, 7916.327112195528, 7977.920220797834, 7981.72063977758, 8035.67857285702, 7993.8401231976195, 8089.838203235902, 8098.5545794981845, 8117.269445749911, 8170.488459634987, 6285.182926219562, 6339.968300158377, 6352.333005034498, 6355.046742988497, 6378.075179099004, 5890.440408161217, 5920.496757775637, 5931.051031834886, 5969.134475501115, 5985.521158307238, 7009.0, 7086.610236437045, 7094.858102838018, 7110.182329032227, 7211.134663840373, 7075.681594328371, 7230.168530618836, 7253.709851605877, 7266.382357499671, 7361.1166659999, 5909.5863289569315, 6007.729652165575, 6009.699515024144, 6034.758609655564, 6042.90935635957, 6384.425401713868, 6416.807495775134, 6433.967830160819, 6461.030845373231, 6464.773732919325, 5988.401159883977, 6162.630242185483, 6195.039768835838, 6240.594361366497, 6308.211473565804, 5822.184894114743, 5865.648061116347, 5976.581639285382, 6069.484093852072, 6118.60229085108, 5999.0, 6024.337322894566, 6067.302260240129, 6080.179175811386, 6094.268687757321, 5648.4633959773755, 5661.065924122474, 5662.7734890603915, 5678.346990096192, 5685.914711279252, 5548.861278468071, 5568.972155139199, 5724.313082430135, 5729.369769325454, 5742.5405967521665], "unit": "ms", "name": "mootools.html", "value": 3849.883529686802}, {"lowerIsBetter": false, "replicates": [292.0188167756338, 297.61161684002366, 301.3972055888224, 302.92729744861225, 305.92046068022336, 5561.6941068241285, 5580.972095139524, 5692.601517893744, 5708.914366284509, 5730.398308177644, 5557.972210138943, 5567.248421463101, 5585.1063829787245, 5594.608377413582, 5610.438956104387, 4051.2910240707906, 4350.934735978963, 4352.869413917588, 4359.564043595647, 4364.585364390394, 4174.269502837006, 4231.513375961757, 4356.194104090738, 4362.411074504933, 4362.847300344489, 4291.163223171483, 4294.871153865373, 4316.503602085769, 4316.82732690692, 4322.1571793500125, 4305.182015417076, 4315.266404711207, 4316.762578058206, 4335.572079635414, 4338.761368124752, 3800.7529510581726, 3803.9239215215816, 3810.6760925321382, 3812.9809350953346, 3820.675242604354, 5247.737613119329, 5414.377346605112, 5445.346558413015, 5463.043967305745, 5468.179773034077, 4876.390451193601, 4889.5354941280875, 4900.117978763821, 4912.975435122838, 4918.5573298403315, 5900.908331958602, 5902.409759024106, 5908.793192238294, 5912.940870591282, 5914.083317085859, 3993.880183594497, 3998.5601583825755, 3999.7800120993334, 4002.2595819773146, 4004.4593979812644, 5928.347881733049, 6188.659623720693, 6193.0710393440895, 6221.346758590328, 6226.252849658024, 4133.586641335903, 4139.0, 4140.296149654566, 4143.295639741251, 4150.522689890641, 4202.579742025834, 4207.5161356444405, 4210.473690788652, 4216.7259128156575, 4226.0, 4860.36815214027, 4863.902721945612, 4867.123917694778, 4872.537108974641, 4877.6341774367065, 5737.225474560881, 5847.444492773265, 5890.3815099414805, 5890.823275301748, 5907.616004959664, 1468.8237411510688, 1482.8739557137549, 1484.065039025407, 1486.762118061105, 1487.1597547385693, 979.7599588100961, 987.6888780034266, 997.7405874472689, 1006.4665727164468, 1009.7980403919246, 5161.535461808456, 5161.767720452589, 5163.251328557413, 5178.741062946838, 5193.246979187997, 6036.698165091728, 6152.384761523812, 6200.81397558074, 6241.032639940817, 6275.058741188858, 5168.53483186515, 5187.636865419385, 5188.610854185951, 5196.272521846944, 5214.9478505214465, 3307.1566750478955, 3355.4295769719206, 3355.6476569959805, 3367.9326413471595, 3369.646187150314, 5702.572307076985, 5841.620294680917, 5855.238818953594, 5865.618734782225, 5868.882622347529, 6354.4281014708895, 6359.904601430982, 6395.936040639627, 6402.03969404593, 6406.0, 5798.5651076168615, 5822.70886455684, 5827.417258274223, 5834.591578589543, 5842.6202296849715, 5980.282366116094, 6195.0, 6202.627842329474, 6207.472364849038, 6214.098955651315, 6032.487238584769, 6036.879262414639, 6039.5470339723815, 6043.335233124265, 6061.181740465157, 5804.506616937608, 5831.70841457917, 5831.708414579339, 5838.211841401527, 5850.561207909339, 4044.4539987101366, 4092.161106973004, 4097.651699605448, 4098.856540021085, 4101.507819061731, 6052.394760523913, 6207.81376558704, 6210.937890621217, 6214.658193799384, 6217.968910155601, 5962.970185149046, 5972.850678732892, 5978.133170690313, 5979.4917432018765, 5982.970085149546, 5936.821895343147, 5951.702414879325, 5959.91060134107, 5983.910241346471, 5993.0710739835395, 5737.799177028951, 5826.096954971986, 5848.824535263949, 5864.648121112747, 5866.0, 6005.399460054135, 6010.098485227076, 6019.51843852482, 6030.125631783455, 6030.7889223876955, 5719.142128680731, 5831.620944638585, 5849.64902105875, 5851.180834683233, 5855.912161317498], "unit": "ms", "name": "prototype.html", "value": 4418.115116550321}, {"lowerIsBetter": false, "replicates": [703.6692754405427, 741.7478057460463, 766.3294617209941, 767.2136060537948, 781.4920301803828, 11647.359395233269, 11749.647510574676, 11853.703657408569, 11957.880421195785, 11997.820032699505, 10871.782564348709, 10929.617463388764, 12944.482220711183, 12972.091953563255, 13010.544630937919, 758.0, 758.5107605594388, 760.9992859389912, 763.4159867701213, 768.6003278295283, 788.1409263902345, 789.4197764643012, 796.5698522797683, 796.7092011415849, 797.2306724011328, 811.6996711216858, 815.2947700239309, 817.1215942861447, 819.2053707903324, 821.2280456371022, 805.1626308639009, 805.3154818404367, 805.8227190018157, 810.2626609785096, 812.0174588747623, 599.1342510072947, 600.1687662587304, 600.8798240351904, 601.2574470528937, 604.2326245668021, 11888.346140962243, 11915.285082894967, 11988.220765650205, 12001.51993920242, 12019.579314723942, 10687.893121068846, 11020.834687479693, 11172.888271117346, 11308.151888608305, 11727.4136293185, 9288.11762882525, 9312.72061838146, 9385.10841470066, 9465.195458386046, 9845.80308393828, 3194.185482701919, 3227.3061291822137, 3260.96739032609, 3263.7878537894962, 3285.342931413703, 42974.14051718948, 43148.78425607852, 43470.0, 43906.780466097465, 43988.3401748974, 9138.223251023737, 9351.579178936965, 9355.672551460666, 9379.296552758571, 9425.905740942502, 16027.0, 16274.349026038826, 16300.755488667679, 16347.18264086791, 16376.0, 6411.775587854496, 6423.261324947597, 6460.903086453707, 6525.641089740015, 6587.440067594212, 3508.3334166508794, 3589.246258285737, 3596.928061438809, 3631.092226943264, 3651.72612054097, 2661.161734053767, 2663.6537250157357, 2669.8798554065115, 2697.4470233602456, 2706.4992976299054, 488.2773495227084, 495.9925601115986, 498.5014985014985, 500.12228538913973, 506.1420891588722, 483.1568912248079, 494.77487743076813, 497.29880867976703, 548.9286392768994, 549.1323708540497, 7516.47384683067, 7613.428992825449, 7662.65518051689, 7684.193159718149, 7933.127355990837, 454.3933848312474, 465.6251717367552, 543.5162705192382, 569.900267453194, 610.7618028968617, 3730.7948062856804, 3799.411091280856, 3860.9806950965626, 3926.823292951824, 4010.438538604598, 45888.08223835505, 46751.29873051907, 47393.0, 47425.28862067072, 47516.762416187696, 43084.0, 43497.56502434935, 43960.3405948911, 44476.55523444724, 44521.10957780891, 37104.5882017668, 38788.61211387906, 39020.609793902266, 39754.403683944765, 40977.79511102366, 8065.354771618374, 8100.351971842357, 8143.18568143181, 8143.226393492609, 8516.147021041485, 31433.0, 31476.842615786776, 31886.0, 32123.35753284968, 32392.380380980387, 38981.80509097436, 39431.80284098561, 39923.60076399199, 40059.59940400559, 40180.79909600433, 10164.847527287244, 10198.235132365251, 10230.437325947145, 10255.282130250811, 10347.84478232812, 10956.178286628694, 11145.108391328513, 11338.716532086764, 11707.648770536898, 11985.981191598463, 10894.61868834587, 10907.400092994962, 10994.945025274823, 11257.943710281395, 11530.59642912494, 10670.35977841332, 10841.566337346418, 10906.291091079054, 10930.070943969851, 10958.12335013213, 11031.613893513688, 11034.834477483004, 11039.889601103887, 11055.83416248773, 11088.445577721242, 8961.372703910663, 9022.278217742696, 9273.350865439354, 9376.671816486663, 9476.810463790824, 8389.0, 8591.957040214758, 8817.382783205114, 8880.955595221982, 8923.553822308988], "unit": "ms", "name": "yui.html", "value": 5722.706432479721}], "name": "dromaeo_css", "value": 6348.310516124832}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 114.0, 114.0, 113.0, 124.0, 114.0, 112.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 168.0, 165.0, 132.0, 155.0, 160.0, 148.0, 170.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 163.0, 161.0, 161.0, 163.0, 168.0, 163.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 74.0, 128.0, 73.0, 79.0, 71.0, 73.0, 85.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 125.0, 95.0, 94.0, 94.0, 132.0, 94.0, 96.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 112.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 146.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 79.0, 75.0, 75.0, 76.0, 74.0, 75.0, 77.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 84.0, 84.0, 83.0, 91.0, 84.0, 87.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [131.0, 126.0, 131.0, 118.0, 130.0, 139.0, 123.0, 128.0, 134.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [155.0, 153.0, 146.0, 152.0, 154.0, 148.0, 151.0, 147.0, 151.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1548.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [697.8367062107467], "unit": "score", "name": "Earley", "value": 955.041479}, {"lowerIsBetter": false, "replicates": [12670.886075949367], "unit": "score", "name": "Boyer", "value": 52.597979020979054}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21251.378998206823}]} 10:36:29 INFO - RETURN: dromaeo_css: 6348.31 10:36:29 INFO - RETURN: kraken: 1548.30 10:36:29 INFO - RETURN: v8_7: 21251.38 10:36:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21251.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6348.31"}}} 10:36:29 INFO - Return code: 0 10:36:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:36:29 INFO - # TBPL SUCCESS # 10:36:29 INFO - Running post-action listener: _resource_record_post_action 10:36:29 INFO - Running post-run listener: _resource_record_post_run 10:36:30 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 45056; Write bytes: 501075968; Read time: 68; Write time: 466952 10:36:30 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 229855232; Read time: 0; Write time: 306948 10:36:30 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 45056; Write bytes: 270684160; Read time: 68; Write time: 159956 10:36:30 INFO - Running post-run listener: _upload_blobber_files 10:36:30 INFO - Blob upload gear active. 10:36:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:36:30 INFO - Copying logs to upload dir... 10:36:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.078223 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-26 10:36:30.336671) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:36:30.340364) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009917 build_url: 'https://queue.taskcluster.net/v1/task/0kR4NFKQS96EUZTEj0-aiw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:36:30.398959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:36:30.399672) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1448561714.301158-274695678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:36:30.450999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 10:36:30.451346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 10:36:30.451685) ========= ========= Total master_lag: 0.23 =========