builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1449109898.79 results: success (0) buildid: 20151202174426 builduid: 08b038fbbe30434a8cf3efdb8bb5246b revision: 89e666316ea0c2cc12976b2bd7f6dc54c566e94f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:38.793237) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:38.794010) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:38.794458) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:38.843034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:38.843636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.059187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.059494) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004720 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.132839) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.133171) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.133620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.133925) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 18:31:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.7M=0s 2015-12-02 18:31:39 (64.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.229190 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.688729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.689050) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.749001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:39.749354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 89e666316ea0c2cc12976b2bd7f6dc54c566e94f --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 89e666316ea0c2cc12976b2bd7f6dc54c566e94f --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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 18:31:39,898 truncating revision to first 12 chars 2015-12-02 18:31:39,898 Setting DEBUG logging. 2015-12-02 18:31:39,898 attempt 1/10 2015-12-02 18:31:39,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/89e666316ea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 18:31:40,127 unpacking tar archive at: fx-team-89e666316ea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504087 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:40.300464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:40.300966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:40.316266) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:40.316661) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 18:31:40.317140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 18:31:40.317485) ========= /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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:40 INFO - MultiFileLogger online at 20151202 18:31:40 in /builds/slave/test 18:31:40 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 18:31:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:40 INFO - {'append_to_log': False, 18:31:40 INFO - 'base_work_dir': '/builds/slave/test', 18:31:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:31:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:40 INFO - 'branch': 'Fx-Team-Non-PGO', 18:31:40 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:40 INFO - 'config_files': ('talos/linux_config.py',), 18:31:40 INFO - 'default_actions': ('clobber', 18:31:40 INFO - 'read-buildbot-config', 18:31:40 INFO - 'download-and-extract', 18:31:40 INFO - 'populate-webroot', 18:31:40 INFO - 'create-virtualenv', 18:31:40 INFO - 'install', 18:31:40 INFO - 'run-tests'), 18:31:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:40 INFO - 'download_minidump_stackwalk': True, 18:31:40 INFO - 'download_symbols': 'ondemand', 18:31:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:40 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:40 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:40 INFO - 'installer_path': 'installer.exe', 18:31:40 INFO - 'log_level': 'info', 18:31:40 INFO - 'log_name': 'talos', 18:31:40 INFO - 'log_to_console': True, 18:31:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:40 INFO - 'opt_config_files': (), 18:31:40 INFO - 'pip_index': False, 18:31:40 INFO - 'sps_profile': False, 18:31:40 INFO - 'sps_profile_interval': 0, 18:31:40 INFO - 'suite': 'dromaeojs-e10s', 18:31:40 INFO - 'system_bits': '64', 18:31:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:40 INFO - 'title': 'talos-linux64-ix-068', 18:31:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:40 INFO - 'use_talos_json': True, 18:31:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:40 INFO - 'work_dir': 'build'} 18:31:40 INFO - ##### 18:31:40 INFO - ##### Running clobber step. 18:31:40 INFO - ##### 18:31:40 INFO - Running pre-action listener: _resource_record_pre_action 18:31:40 INFO - Running main action method: clobber 18:31:40 INFO - rmtree: /builds/slave/test/build 18:31:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:40 INFO - Running post-action listener: _resource_record_post_action 18:31:40 INFO - ##### 18:31:40 INFO - ##### Running read-buildbot-config step. 18:31:40 INFO - ##### 18:31:40 INFO - Running pre-action listener: _resource_record_pre_action 18:31:40 INFO - Running main action method: read_buildbot_config 18:31:40 INFO - Using buildbot properties: 18:31:40 INFO - { 18:31:40 INFO - "properties": { 18:31:40 INFO - "buildnumber": 786, 18:31:40 INFO - "product": "firefox", 18:31:40 INFO - "script_repo_revision": "production", 18:31:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:31:40 INFO - "repository": "", 18:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:31:40 INFO - "buildid": "20151202174426", 18:31:40 INFO - "slavename": "talos-linux64-ix-068", 18:31:40 INFO - "pgo_build": "False", 18:31:40 INFO - "basedir": "/builds/slave/test", 18:31:40 INFO - "project": "", 18:31:40 INFO - "platform": "ubuntu64_hw", 18:31:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:31:40 INFO - "slavebuilddir": "test", 18:31:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:31:40 INFO - "branch": "fx-team", 18:31:40 INFO - "repo_path": "integration/fx-team", 18:31:40 INFO - "stage_platform": "linux64", 18:31:40 INFO - "builduid": "08b038fbbe30434a8cf3efdb8bb5246b", 18:31:40 INFO - "revision": "89e666316ea0c2cc12976b2bd7f6dc54c566e94f" 18:31:40 INFO - }, 18:31:40 INFO - "sourcestamp": { 18:31:40 INFO - "repository": "", 18:31:40 INFO - "hasPatch": false, 18:31:40 INFO - "project": "", 18:31:40 INFO - "branch": "fx-team-linux64-talos", 18:31:40 INFO - "changes": [ 18:31:40 INFO - { 18:31:40 INFO - "category": null, 18:31:40 INFO - "files": [ 18:31:40 INFO - { 18:31:40 INFO - "url": null, 18:31:40 INFO - "name": "https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:31:40 INFO - } 18:31:40 INFO - ], 18:31:40 INFO - "repository": "", 18:31:40 INFO - "rev": "89e666316ea0c2cc12976b2bd7f6dc54c566e94f", 18:31:40 INFO - "who": "maglione.k@gmail.com", 18:31:40 INFO - "when": 1449109853, 18:31:40 INFO - "number": 6737024, 18:31:40 INFO - "comments": "Bug 1190688: Part 2 - [webext] Add tests for executeScript permission checks. r=billm", 18:31:40 INFO - "project": "", 18:31:40 INFO - "at": "Wed 02 Dec 2015 18:30:53", 18:31:40 INFO - "branch": "fx-team-linux64-talos", 18:31:40 INFO - "revlink": "", 18:31:40 INFO - "properties": [ 18:31:40 INFO - [ 18:31:40 INFO - "buildid", 18:31:40 INFO - "20151202174426", 18:31:40 INFO - "Change" 18:31:40 INFO - ], 18:31:40 INFO - [ 18:31:40 INFO - "builduid", 18:31:40 INFO - "08b038fbbe30434a8cf3efdb8bb5246b", 18:31:40 INFO - "Change" 18:31:40 INFO - ], 18:31:40 INFO - [ 18:31:40 INFO - "pgo_build", 18:31:40 INFO - "False", 18:31:40 INFO - "Change" 18:31:40 INFO - ] 18:31:40 INFO - ], 18:31:40 INFO - "revision": "89e666316ea0c2cc12976b2bd7f6dc54c566e94f" 18:31:40 INFO - } 18:31:40 INFO - ], 18:31:40 INFO - "revision": "89e666316ea0c2cc12976b2bd7f6dc54c566e94f" 18:31:40 INFO - } 18:31:40 INFO - } 18:31:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:31:40 INFO - Running post-action listener: _resource_record_post_action 18:31:40 INFO - ##### 18:31:40 INFO - ##### Running download-and-extract step. 18:31:40 INFO - ##### 18:31:40 INFO - Running pre-action listener: _resource_record_pre_action 18:31:40 INFO - Running main action method: download_and_extract 18:31:40 INFO - mkdir: /builds/slave/test/build/tests 18:31:40 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')]} 18:31:40 INFO - https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/test_packages.json 18:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/test_packages.json 18:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:31:41 INFO - Downloaded 1302 bytes. 18:31:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:31:41 INFO - Using the following test package requirements: 18:31:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:31:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'jsshell-linux-x86_64.zip'], 18:31:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:31:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:31:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:31:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:31:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:31:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:41 INFO - https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:42 INFO - Downloaded 21774978 bytes. 18:31:42 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 18:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:42 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 18:31:43 INFO - Return code: 0 18:31:43 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 18:31: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')]} 18:31:43 INFO - https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:44 INFO - Downloaded 21774978 bytes. 18:31:44 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 18:31:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:31:44 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 18:31:45 INFO - Return code: 0 18:31:45 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')]} 18:31:45 INFO - https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:47 INFO - Downloaded 11132001 bytes. 18:31:47 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 18:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:47 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 18:31:47 INFO - Return code: 0 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:47 INFO - https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/huCfBHN4TeyFLG5HtrhfRQ/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 18:31:53 INFO - Downloaded 57680976 bytes. 18:31:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:31:53 INFO - mkdir: /builds/slave/test/properties 18:31:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:53 INFO - Contents: 18:31:53 INFO - build_url:https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:31:53 INFO - Running post-action listener: _resource_record_post_action 18:31:53 INFO - Running post-action listener: set_extra_try_arguments 18:31:53 INFO - ##### 18:31:53 INFO - ##### Running populate-webroot step. 18:31:53 INFO - ##### 18:31:53 INFO - Running pre-action listener: _resource_record_pre_action 18:31:53 INFO - Running main action method: populate_webroot 18:31:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:31:53 INFO - '../fennec_ids.txt'], 18:31:53 INFO - 'tests': ['tcheck2']}, 18:31:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:53 INFO - '--tppagecycles', 18:31:53 INFO - '7'], 18:31:53 INFO - 'tests': ['tsvgm']}}, 18:31:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:31:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:31:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:31:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'tests': ['damp', 'tps']}, 18:31:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['damp', 'tps']}, 18:31:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:53 INFO - 'other': {'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'other_l64': {'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'other_nol64': {'tests': ['a11yr', 18:31:53 INFO - 'ts_paint', 18:31:53 INFO - 'tpaint', 18:31:53 INFO - 'sessionrestore', 18:31:53 INFO - 'sessionrestore_no_auto_restore']}, 18:31:53 INFO - 'svgr': {'tests': ['tsvgx', 18:31:53 INFO - 'tsvgr_opacity', 18:31:53 INFO - 'tart', 18:31:53 INFO - 'tscrollx', 18:31:53 INFO - 'cart']}, 18:31:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['tsvgx', 18:31:53 INFO - 'tsvgr_opacity', 18:31:53 INFO - 'tart', 18:31:53 INFO - 'tscrollx', 18:31:53 INFO - 'cart']}, 18:31:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'tests': ['tp5o']}, 18:31:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'talos_options': ['--e10s'], 18:31:53 INFO - 'tests': ['tp5o']}, 18:31:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'talos_options': ['--xperf_path', 18:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:53 INFO - 'tests': ['tp5n']}, 18:31:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:53 INFO - 'talos_options': ['--e10s', 18:31:53 INFO - '--xperf_path', 18:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:53 INFO - 'tests': ['tp5n']}}, 18:31:53 INFO - 'talos.zip': {'path': '', 18:31:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:53 INFO - Running post-action listener: _resource_record_post_action 18:31:53 INFO - ##### 18:31:53 INFO - ##### Running create-virtualenv step. 18:31:53 INFO - ##### 18:31:53 INFO - Running pre-action listener: _resource_record_pre_action 18:31:53 INFO - Running main action method: create_virtualenv 18:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:53 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 18:31:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:53 INFO - Using real prefix '/usr' 18:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:55 INFO - Installing pip.................done. 18:31:55 INFO - Return code: 0 18:31:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:55 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')]} 18:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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')]} 18:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:31:55 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 18:31:55 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 18:31:55 INFO - Using env: {'DISPLAY': ':0', 18:31:55 INFO - 'HOME': '/home/cltbld', 18:31:55 INFO - 'LANG': 'en_US.UTF-8', 18:31:55 INFO - 'LANGUAGE': 'en_US:en', 18:31:55 INFO - 'LOGNAME': 'cltbld', 18:31:55 INFO - 'MAIL': '/var/mail/cltbld', 18:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:55 INFO - 'MOZ_NO_REMOTE': '1', 18:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:55 INFO - 'NO_EM_RESTART': '1', 18:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:55 INFO - 'PWD': '/builds/slave/test', 18:31:55 INFO - 'SHELL': '/bin/bash', 18:31:55 INFO - 'SHLVL': '1', 18:31:55 INFO - 'TERM': 'linux', 18:31:55 INFO - 'TMOUT': '86400', 18:31:55 INFO - 'USER': 'cltbld', 18:31:55 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:55 INFO - '_': '/tools/buildbot/bin/python'} 18:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:55 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 18:31:55 INFO - Cleaning up... 18:31:55 INFO - Return code: 0 18:31:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:31:55 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')]} 18:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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')]} 18:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:31:55 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 18:31:55 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 18:31:55 INFO - Using env: {'DISPLAY': ':0', 18:31:55 INFO - 'HOME': '/home/cltbld', 18:31:55 INFO - 'LANG': 'en_US.UTF-8', 18:31:55 INFO - 'LANGUAGE': 'en_US:en', 18:31:55 INFO - 'LOGNAME': 'cltbld', 18:31:55 INFO - 'MAIL': '/var/mail/cltbld', 18:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:55 INFO - 'MOZ_NO_REMOTE': '1', 18:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:55 INFO - 'NO_EM_RESTART': '1', 18:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:55 INFO - 'PWD': '/builds/slave/test', 18:31:55 INFO - 'SHELL': '/bin/bash', 18:31:55 INFO - 'SHLVL': '1', 18:31:55 INFO - 'TERM': 'linux', 18:31:55 INFO - 'TMOUT': '86400', 18:31:55 INFO - 'USER': 'cltbld', 18:31:55 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:55 INFO - '_': '/tools/buildbot/bin/python'} 18:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:56 INFO - Downloading/unpacking psutil>=0.7.1 18:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:31:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:57 INFO - Installing collected packages: psutil 18:31:57 INFO - Running setup.py install for psutil 18:31:57 INFO - building 'psutil._psutil_linux' extension 18:31:57 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 18:31:58 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 18:31:58 INFO - building 'psutil._psutil_posix' extension 18:31:58 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 18:31:58 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 18:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:58 INFO - Successfully installed psutil 18:31:58 INFO - Cleaning up... 18:31:58 INFO - Return code: 0 18:31:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:31:58 INFO - Using env: {'DISPLAY': ':0', 18:31:58 INFO - 'HOME': '/home/cltbld', 18:31:58 INFO - 'LANG': 'en_US.UTF-8', 18:31:58 INFO - 'LANGUAGE': 'en_US:en', 18:31:58 INFO - 'LOGNAME': 'cltbld', 18:31:58 INFO - 'MAIL': '/var/mail/cltbld', 18:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:58 INFO - 'MOZ_NO_REMOTE': '1', 18:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:58 INFO - 'NO_EM_RESTART': '1', 18:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:58 INFO - 'PWD': '/builds/slave/test', 18:31:58 INFO - 'SHELL': '/bin/bash', 18:31:58 INFO - 'SHLVL': '1', 18:31:58 INFO - 'TERM': 'linux', 18:31:58 INFO - 'TMOUT': '86400', 18:31:58 INFO - 'USER': 'cltbld', 18:31:58 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:58 INFO - '_': '/tools/buildbot/bin/python'} 18:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:32:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:32:00 INFO - Installing collected packages: mozsystemmonitor 18:32:00 INFO - Running setup.py install for mozsystemmonitor 18:32:00 INFO - Successfully installed mozsystemmonitor 18:32:00 INFO - Cleaning up... 18:32:00 INFO - Return code: 0 18:32:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:00 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 18:32:00 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 18:32:00 INFO - Using env: {'DISPLAY': ':0', 18:32:00 INFO - 'HOME': '/home/cltbld', 18:32:00 INFO - 'LANG': 'en_US.UTF-8', 18:32:00 INFO - 'LANGUAGE': 'en_US:en', 18:32:00 INFO - 'LOGNAME': 'cltbld', 18:32:00 INFO - 'MAIL': '/var/mail/cltbld', 18:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:00 INFO - 'MOZ_NO_REMOTE': '1', 18:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:00 INFO - 'NO_EM_RESTART': '1', 18:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:00 INFO - 'PWD': '/builds/slave/test', 18:32:00 INFO - 'SHELL': '/bin/bash', 18:32:00 INFO - 'SHLVL': '1', 18:32:00 INFO - 'TERM': 'linux', 18:32:00 INFO - 'TMOUT': '86400', 18:32:00 INFO - 'USER': 'cltbld', 18:32:00 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:00 INFO - '_': '/tools/buildbot/bin/python'} 18:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:00 INFO - Downloading/unpacking blobuploader==1.2.4 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:32:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:32:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:03 INFO - Downloading docopt-0.6.1.tar.gz 18:32:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:32:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:32:03 INFO - Running setup.py install for blobuploader 18:32:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:32:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:32:03 INFO - Running setup.py install for requests 18:32:03 INFO - Running setup.py install for docopt 18:32:03 INFO - Successfully installed blobuploader requests docopt 18:32:03 INFO - Cleaning up... 18:32:03 INFO - Return code: 0 18:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:03 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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:03 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 18:32:03 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 18:32:03 INFO - Using env: {'DISPLAY': ':0', 18:32:03 INFO - 'HOME': '/home/cltbld', 18:32:03 INFO - 'LANG': 'en_US.UTF-8', 18:32:03 INFO - 'LANGUAGE': 'en_US:en', 18:32:03 INFO - 'LOGNAME': 'cltbld', 18:32:03 INFO - 'MAIL': '/var/mail/cltbld', 18:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:03 INFO - 'MOZ_NO_REMOTE': '1', 18:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:03 INFO - 'NO_EM_RESTART': '1', 18:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:03 INFO - 'PWD': '/builds/slave/test', 18:32:03 INFO - 'SHELL': '/bin/bash', 18:32:03 INFO - 'SHLVL': '1', 18:32:03 INFO - 'TERM': 'linux', 18:32:03 INFO - 'TMOUT': '86400', 18:32:03 INFO - 'USER': 'cltbld', 18:32:03 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:03 INFO - '_': '/tools/buildbot/bin/python'} 18:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:03 INFO - Running setup.py (path:/tmp/pip-v__b3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:04 INFO - Running setup.py (path:/tmp/pip-QFpsiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:04 INFO - Running setup.py (path:/tmp/pip-bVByyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:04 INFO - Running setup.py (path:/tmp/pip-uteqH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:04 INFO - Running setup.py (path:/tmp/pip-uNaSd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:04 INFO - Running setup.py (path:/tmp/pip-rsFNMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:04 INFO - Running setup.py (path:/tmp/pip-aoBs8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:04 INFO - Running setup.py (path:/tmp/pip-8RpUiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:04 INFO - Running setup.py (path:/tmp/pip-A_ifG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:04 INFO - Running setup.py (path:/tmp/pip-ifZFKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:04 INFO - Running setup.py (path:/tmp/pip-IsIwPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:04 INFO - Running setup.py (path:/tmp/pip-ZbmtB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:04 INFO - Running setup.py (path:/tmp/pip-CTSMls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:04 INFO - Running setup.py (path:/tmp/pip-JV18GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:04 INFO - Running setup.py (path:/tmp/pip-12B_rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:05 INFO - Running setup.py (path:/tmp/pip-3BCHsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:05 INFO - Running setup.py (path:/tmp/pip-iZXSiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:32:05 INFO - Running setup.py install for manifestparser 18:32:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Running setup.py install for mozcrash 18:32:05 INFO - Running setup.py install for mozdebug 18:32:05 INFO - Running setup.py install for mozdevice 18:32:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Running setup.py install for mozfile 18:32:05 INFO - Running setup.py install for mozhttpd 18:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Running setup.py install for mozinfo 18:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Running setup.py install for mozInstall 18:32:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:32:05 INFO - Running setup.py install for mozleak 18:32:06 INFO - Running setup.py install for mozlog 18:32:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Running setup.py install for moznetwork 18:32:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Running setup.py install for mozprocess 18:32:06 INFO - Running setup.py install for mozprofile 18:32:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Running setup.py install for mozrunner 18:32:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Running setup.py install for mozscreenshot 18:32:06 INFO - Running setup.py install for moztest 18:32:06 INFO - Running setup.py install for mozversion 18:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:32:06 INFO - Cleaning up... 18:32:06 INFO - Return code: 0 18:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:06 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 18:32:06 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 18:32:06 INFO - Using env: {'DISPLAY': ':0', 18:32:06 INFO - 'HOME': '/home/cltbld', 18:32:06 INFO - 'LANG': 'en_US.UTF-8', 18:32:06 INFO - 'LANGUAGE': 'en_US:en', 18:32:06 INFO - 'LOGNAME': 'cltbld', 18:32:06 INFO - 'MAIL': '/var/mail/cltbld', 18:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:06 INFO - 'MOZ_NO_REMOTE': '1', 18:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:06 INFO - 'NO_EM_RESTART': '1', 18:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:06 INFO - 'PWD': '/builds/slave/test', 18:32:06 INFO - 'SHELL': '/bin/bash', 18:32:06 INFO - 'SHLVL': '1', 18:32:06 INFO - 'TERM': 'linux', 18:32:06 INFO - 'TMOUT': '86400', 18:32:06 INFO - 'USER': 'cltbld', 18:32:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:06 INFO - '_': '/tools/buildbot/bin/python'} 18:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:07 INFO - Running setup.py (path:/tmp/pip-CMWWOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:07 INFO - Running setup.py (path:/tmp/pip-aDHgn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:07 INFO - Running setup.py (path:/tmp/pip-sG9KL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:07 INFO - Running setup.py (path:/tmp/pip-JHk_RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:07 INFO - Running setup.py (path:/tmp/pip-XdY3ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:07 INFO - Running setup.py (path:/tmp/pip-kfheII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:07 INFO - Running setup.py (path:/tmp/pip-oXFJaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:07 INFO - Running setup.py (path:/tmp/pip-MtbnM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:07 INFO - Running setup.py (path:/tmp/pip-0mMFOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:07 INFO - Running setup.py (path:/tmp/pip-LEl553-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:07 INFO - Running setup.py (path:/tmp/pip-V9pbI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:07 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)) 18:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:07 INFO - Running setup.py (path:/tmp/pip-QB3781-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:08 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)) 18:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:08 INFO - Running setup.py (path:/tmp/pip-qBvPtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:08 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)) 18:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:08 INFO - Running setup.py (path:/tmp/pip-UeqjTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:08 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)) 18:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:08 INFO - Running setup.py (path:/tmp/pip-GHwUWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:08 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)) 18:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:08 INFO - Running setup.py (path:/tmp/pip-2yCH4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:08 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)) 18:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:08 INFO - Running setup.py (path:/tmp/pip-KbuDSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:08 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)) 18:32:08 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)) 18:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:32:08 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)) 18:32:08 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)) 18:32:08 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)) 18:32:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:10 INFO - Downloading blessings-1.5.1.tar.gz 18:32:10 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 18:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:32:10 INFO - Installing collected packages: blessings 18:32:10 INFO - Running setup.py install for blessings 18:32:10 INFO - Successfully installed blessings 18:32:10 INFO - Cleaning up... 18:32:10 INFO - Return code: 0 18:32:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:10 INFO - Reading from file tmpfile_stdout 18:32:10 INFO - Current package versions: 18:32:10 INFO - argparse == 1.2.1 18:32:10 INFO - blessings == 1.5.1 18:32:10 INFO - blobuploader == 1.2.4 18:32:10 INFO - docopt == 0.6.1 18:32:10 INFO - manifestparser == 1.1 18:32:10 INFO - mozInstall == 1.12 18:32:10 INFO - mozcrash == 0.16 18:32:10 INFO - mozdebug == 0.1 18:32:10 INFO - mozdevice == 0.47 18:32:10 INFO - mozfile == 1.2 18:32:10 INFO - mozhttpd == 0.7 18:32:10 INFO - mozinfo == 0.9 18:32:10 INFO - mozleak == 0.1 18:32:10 INFO - mozlog == 3.1 18:32:10 INFO - moznetwork == 0.27 18:32:10 INFO - mozprocess == 0.22 18:32:10 INFO - mozprofile == 0.27 18:32:10 INFO - mozrunner == 6.11 18:32:10 INFO - mozscreenshot == 0.1 18:32:10 INFO - mozsystemmonitor == 0.0 18:32:10 INFO - moztest == 0.7 18:32:10 INFO - mozversion == 1.4 18:32:10 INFO - psutil == 3.1.1 18:32:10 INFO - requests == 1.2.3 18:32:10 INFO - wsgiref == 0.1.2 18:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32: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')]} 18:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32: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')]} 18:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:10 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 18:32:10 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 18:32:10 INFO - Using env: {'DISPLAY': ':0', 18:32:10 INFO - 'HOME': '/home/cltbld', 18:32:10 INFO - 'LANG': 'en_US.UTF-8', 18:32:10 INFO - 'LANGUAGE': 'en_US:en', 18:32:10 INFO - 'LOGNAME': 'cltbld', 18:32:10 INFO - 'MAIL': '/var/mail/cltbld', 18:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:10 INFO - 'MOZ_NO_REMOTE': '1', 18:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:10 INFO - 'NO_EM_RESTART': '1', 18:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:10 INFO - 'PWD': '/builds/slave/test', 18:32:10 INFO - 'SHELL': '/bin/bash', 18:32:10 INFO - 'SHLVL': '1', 18:32:10 INFO - 'TERM': 'linux', 18:32:10 INFO - 'TMOUT': '86400', 18:32:10 INFO - 'USER': 'cltbld', 18:32:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:10 INFO - '_': '/tools/buildbot/bin/python'} 18:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 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)) 18:32:10 INFO - Cleaning up... 18:32:10 INFO - Return code: 0 18:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:32: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')]} 18:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32: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')]} 18:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:32:10 INFO - Using env: {'DISPLAY': ':0', 18:32:10 INFO - 'HOME': '/home/cltbld', 18:32:10 INFO - 'LANG': 'en_US.UTF-8', 18:32:10 INFO - 'LANGUAGE': 'en_US:en', 18:32:10 INFO - 'LOGNAME': 'cltbld', 18:32:10 INFO - 'MAIL': '/var/mail/cltbld', 18:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:10 INFO - 'MOZ_NO_REMOTE': '1', 18:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:10 INFO - 'NO_EM_RESTART': '1', 18:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:10 INFO - 'PWD': '/builds/slave/test', 18:32:10 INFO - 'SHELL': '/bin/bash', 18:32:10 INFO - 'SHLVL': '1', 18:32:10 INFO - 'TERM': 'linux', 18:32:10 INFO - 'TMOUT': '86400', 18:32:10 INFO - 'USER': 'cltbld', 18:32:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:10 INFO - '_': '/tools/buildbot/bin/python'} 18:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:11 INFO - Downloading/unpacking jsonschema 18:32:11 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 18:32:11 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 18:32:11 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 18:32:11 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 18:32:11 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 18:32:11 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 18:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:32:12 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 18:32:12 INFO - Downloading/unpacking functools32 (from jsonschema) 18:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:32:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:32:12 INFO - warning: no files found matching '*.txt' 18:32:12 INFO - no previously-included directories found matching 'build' 18:32:12 INFO - no previously-included directories found matching 'dist' 18:32:12 INFO - no previously-included directories found matching '.git*' 18:32:12 INFO - Installing collected packages: jsonschema, functools32 18:32:13 INFO - Running setup.py install for functools32 18:32:13 INFO - warning: no files found matching '*.txt' 18:32:13 INFO - no previously-included directories found matching 'build' 18:32:13 INFO - no previously-included directories found matching 'dist' 18:32:13 INFO - no previously-included directories found matching '.git*' 18:32:13 INFO - Successfully installed jsonschema functools32 18:32:13 INFO - Cleaning up... 18:32:13 INFO - Return code: 0 18:32:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:32:13 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')]} 18:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:13 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')]} 18:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:13 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 0x7facd9d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', '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 18:32:13 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 18:32:13 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 18:32:13 INFO - Using env: {'DISPLAY': ':0', 18:32:13 INFO - 'HOME': '/home/cltbld', 18:32:13 INFO - 'LANG': 'en_US.UTF-8', 18:32:13 INFO - 'LANGUAGE': 'en_US:en', 18:32:13 INFO - 'LOGNAME': 'cltbld', 18:32:13 INFO - 'MAIL': '/var/mail/cltbld', 18:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:13 INFO - 'MOZ_NO_REMOTE': '1', 18:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:13 INFO - 'NO_EM_RESTART': '1', 18:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:13 INFO - 'PWD': '/builds/slave/test', 18:32:13 INFO - 'SHELL': '/bin/bash', 18:32:13 INFO - 'SHLVL': '1', 18:32:13 INFO - 'TERM': 'linux', 18:32:13 INFO - 'TMOUT': '86400', 18:32:13 INFO - 'USER': 'cltbld', 18:32:13 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:13 INFO - '_': '/tools/buildbot/bin/python'} 18:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:13 INFO - Downloading/unpacking flake8 18:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:32:15 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 18:32:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:32:15 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 18:32:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 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 18:32:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:15 INFO - no previously-included directories found matching 'docs/_build' 18:32:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:32:15 INFO - Running setup.py install for pep8 18:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:15 INFO - no previously-included directories found matching 'docs/_build' 18:32:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:32:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:32:15 INFO - Cleaning up... 18:32:15 INFO - Return code: 0 18:32:15 INFO - Running post-action listener: _resource_record_post_action 18:32:15 INFO - Running post-action listener: _start_resource_monitoring 18:32:15 INFO - Starting resource monitoring. 18:32:15 INFO - ##### 18:32:15 INFO - ##### Running install step. 18:32:15 INFO - ##### 18:32:15 INFO - Running pre-action listener: _resource_record_pre_action 18:32:15 INFO - Running main action method: install 18:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:16 INFO - Reading from file tmpfile_stdout 18:32:16 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:16 INFO - Reading from file tmpfile_stdout 18:32:16 INFO - Output received: 18:32:16 INFO - Usage: mozinstall [options] installer 18:32:16 INFO - Options: 18:32:16 INFO - -h, --help show this help message and exit 18:32:16 INFO - -d DEST, --destination=DEST 18:32:16 INFO - Directory to install application into. [default: 18:32:16 INFO - "/builds/slave/test"] 18:32:16 INFO - --app=APP Application being installed. [default: firefox] 18:32:16 INFO - mkdir: /builds/slave/test/build/application 18:32:16 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'] 18:32:16 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 18:32:30 INFO - Reading from file tmpfile_stdout 18:32:30 INFO - Output received: 18:32:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:30 INFO - Running post-action listener: _resource_record_post_action 18:32:30 INFO - ##### 18:32:30 INFO - ##### Running run-tests step. 18:32:30 INFO - ##### 18:32:30 INFO - Running pre-action listener: _resource_record_pre_action 18:32:30 INFO - Running main action method: run_tests 18:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:30 INFO - Python 2.7.3 18:32:30 INFO - Return code: 0 18:32:30 INFO - grabbing minidump binary from tooltool 18:32: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')]} 18:32:30 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 0x1e850b0>, '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 0x1e85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:30 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 18:32:30 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 18:32:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:30 INFO - Return code: 0 18:32:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:32:31 INFO - Return code: 0 18:32:31 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/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test/build 18:32:31 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/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 18:32:31 INFO - Using env: {'DISPLAY': ':0', 18:32:31 INFO - 'HOME': '/home/cltbld', 18:32:31 INFO - 'LANG': 'en_US.UTF-8', 18:32:31 INFO - 'LANGUAGE': 'en_US:en', 18:32:31 INFO - 'LOGNAME': 'cltbld', 18:32:31 INFO - 'MAIL': '/var/mail/cltbld', 18:32:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:31 INFO - 'MOZ_NO_REMOTE': '1', 18:32:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:31 INFO - 'NO_EM_RESTART': '1', 18:32:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:31 INFO - 'PWD': '/builds/slave/test', 18:32:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:31 INFO - 'SHELL': '/bin/bash', 18:32:31 INFO - 'SHLVL': '1', 18:32:31 INFO - 'TERM': 'linux', 18:32:31 INFO - 'TMOUT': '86400', 18:32:31 INFO - 'USER': 'cltbld', 18:32:31 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147', 18:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:31 INFO - '_': '/tools/buildbot/bin/python'} 18:32:31 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/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 18:32:31 INFO - mozversion INFO | application_buildid: 20151202174426 18:32:31 INFO - mozversion INFO | application_changeset: 89e666316ea0c2cc12976b2bd7f6dc54c566e94f 18:32:31 INFO - mozversion INFO | application_display_name: Nightly 18:32:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:31 INFO - mozversion INFO | application_name: Firefox 18:32:31 INFO - mozversion INFO | application_remotingname: firefox 18:32:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:32:31 INFO - mozversion INFO | application_vendor: Mozilla 18:32:31 INFO - mozversion INFO | application_version: 45.0a1 18:32:31 INFO - mozversion INFO | platform_buildid: 20151202174426 18:32:31 INFO - mozversion INFO | platform_changeset: 89e666316ea0c2cc12976b2bd7f6dc54c566e94f 18:32:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:32:31 INFO - mozversion INFO | platform_version: 45.0a1 18:32:31 INFO - 2015-12-02 18:32:31,989 DEBUG : using testdate: 1449109951 18:32:31 INFO - 2015-12-02 18:32:31,990 DEBUG : actual date: 1449109951 18:32:31 INFO - 2015-12-02 18:32:31,998 INFO : starting webserver on 'localhost:50252' 18:32:31 INFO - 2015-12-02 18:32:31,999 INFO : Starting test suite talos-linux64-ix-068.e 18:32:31 INFO - 2015-12-02 18:32:31,999 INFO : Starting test dromaeo_css 18:32:31 INFO - 2015-12-02 18:32:31,999 DEBUG : operating with platform_type : linux_ 18:32:31 INFO - 2015-12-02 18:32:31,999 INFO : Initialising browser for dromaeo_css test... 18:32:32 INFO - 2015-12-02 18:32:32,008 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoaUgRx/profile http://localhost:50252/getInfo.html 18:32:36 INFO - 2015-12-02 18:32:36,535 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:32:36 INFO - 2015-12-02 18:32:36,535 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:32:36 INFO - 2015-12-02 18:32:36,535 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:32:36 INFO - 2015-12-02 18:32:36,535 DEBUG : BROWSER_OUTPUT: __metrics 18:32:36 INFO - 2015-12-02 18:32:36,657 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:32:37 INFO - 2015-12-02 18:32:37,605 INFO : Browser initialized. 18:32:37 INFO - 2015-12-02 18:32:37,606 INFO : Running cycle 1/1 for dromaeo_css test... 18:32:37 INFO - 2015-12-02 18:32:37,606 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoaUgRx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:32:49 INFO - 2015-12-02 18:32:49,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 143122432 18:32:49 INFO - 2015-12-02 18:32:49,623 DEBUG : BROWSER_OUTPUT: 18:33:39 INFO - 2015-12-02 18:33:39,239 DEBUG : BROWSER_OUTPUT: 1449110019236 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] 18:35:51 INFO - 2015-12-02 18:35:51,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50252/tests/dromaeo/cssquery-ext.html) 18:35:52 INFO - 2015-12-02 18:35:52,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 146608128 18:35:52 INFO - 2015-12-02 18:35:52,258 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2015-12-02 18:38:54,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-ext.html (next: http://localhost:50252/tests/dromaeo/cssquery-jquery.html) 18:38:54 INFO - 2015-12-02 18:38:54,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 145182720 18:38:54 INFO - 2015-12-02 18:38:54,949 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-12-02 18:41:56,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50252/tests/dromaeo/cssquery-mootools.html) 18:41:57 INFO - 2015-12-02 18:41:57,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 146325504 18:41:57 INFO - 2015-12-02 18:41:57,303 DEBUG : BROWSER_OUTPUT: 18:44:59 INFO - 2015-12-02 18:44:59,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50252/tests/dromaeo/cssquery-prototype.html) 18:44:59 INFO - 2015-12-02 18:44:59,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 144728064 18:44:59 INFO - 2015-12-02 18:44:59,690 DEBUG : BROWSER_OUTPUT: 18:48:02 INFO - 2015-12-02 18:48:02,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50252/tests/dromaeo/cssquery-yui.html) 18:48:03 INFO - 2015-12-02 18:48:03,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 145076224 18:48:03 INFO - 2015-12-02 18:48:03,006 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-yui.html (next: http://localhost:50252/tests/dromaeo/cssquery-dojo.html) 18:51:05 INFO - 2015-12-02 18:51:05,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 148512768 18:51:05 INFO - 2015-12-02 18:51:05,893 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:51:05 INFO - 2015-12-02 18:51:05,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2647.1264482720703;2707.28257011892;2733.0844167203986;2740.7670348020406;2752.724727527247;4595.333676616897;4726.243800991838;4761.0715910397485;4819.662623616348;4859.854204373874;4707.552782485667;4727.8818029549275;4728.148933192024;4862.343583616211;4872.171730805762;4344.717593356438;4416.97791511042;4418.646508279338;4478.462584489866;4504.7747612619405;4227.260229459847;4449.977750111261;4491.281394976804;4496.100779844044;4506.932396014046;4255.638270747006;4332.436783218193;4343.283358245885;4345.47854257488;4372.2130016597;4339.60943515082;4345.217860785057;4361.760103194355;4398.164348773723;4405.185040767468;4185.958140418587;4290.528041915387;4297.05464797744;4330.242207613655;4450.198964186445;4508.819647214107;4544.295634176675;4547;4596.655250856199;4601.102784956935;5022.824201152942;5023.673461225008;5026.547610715017;5071.1632580624155;5082.593392528589;4908.190148625508;5003.799848006075;5035.1188542005;5106.744662766847;5136.280920671109;4757.762111894461;4767.046590681808;4781.569658730731;4788.904221915577;4814.927776083362;5251.711155886386;5266;5269.525742683177;5272.420033796279;5278.261043453919;4836.516348365135;4923.212286034289;4965.3048573199785;5049.7727602257255;5053.267276244924;5110.207917772751;5112.36095488064;5124.436312005676;5133.922991155136;5156.097682905552;5049.2426136079885;5050.267711181858;5053.393592768891;5054.595632349403;5070.062038522811;4872.4883887192045;4882.731449770296;4974.1543937530705;4981.302617633534;5006.349174607278;4183.3515805050265;4194.580541945781;4231.069164783743;4233.5131459881895;4261.850835220815;3679.1537946272506;3683.5763887152784;3688.6680198782237;3705.40713485841;3712.535933008374;4142.2958097123565;4298.914021719548;4354.586314300136;4413.955860441419;4420.31485119807;5089.465606111305;5091.363579552556;5093.490650934951;5106.642535022587;5175.430702622709;4384.298512238027;4413.889652758707;4414.337849322563;4428.778561071934;4445.333200019958;4334.19817333788;4370.606645401929;4421.027373977719;4444.666650001198;4477.955220447819;4877.512248775094;4883.536064073907;4885.193942999365;4909.607231421478;4929.260610908393;5033.597312214941;5148.819791307286;5152.9742351288005;5164.741762911764;5209.453007434165;4902.044101400335;4905.6075513958085;4910.484399138182;4915.877103072452;4920.384951881015;4957.925631115464;5031.572316353005;5059.747012649426;5071.923921141112;5081.669691470042;5065.56942659878;5073.644844860824;5105.055564720538;5124.897502050013;5173.32746742921;4882.95117048825;4912.214045752662;4928.926066109083;4935.703857768545;4973.577245934136;4672.719636821802;4781.067691800065;4891.853244402673;4993.750312484289;5008.974955125201;4743.573078422958;4796.400449943757;4829.710217386968;4842.370491836039;4856.854294371175;4967.975160124321;4988.45127036033;4990.4011518618;4993.4257560379565;5029.4216165140015;4649.628029757544;4683.9226977794615;4740.146773580788;4746.406699162605;4758.976205118952 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.517772659829;583.6439771739239;588.8792797476518;590.7312172961304;591.9112133180024;36079.2784144317;36854.8157259214;37001.25997480049;37066.44400333994;37108;40544.189116217654;40776.59223407765;41167.58832411675;41225.793871030604;41226;7821.335186509139;7965.203479652017;8011.679532818709;8028.799280018017;8032.799180020488;7764.883526747103;7865.292123708865;7894.763157105267;7914.208579142098;7924.683012679486;7858.528488290721;7865.370770338388;7929.167437419074;7954.9602251988945;7962.800929976768;7886.211378862096;7911.802204944894;7977.641006154737;7984.8403031939615;8009.038915330139;7805.882911756328;7864;7908.169642187545;7938.24586664266;7982.600869956537;37484.81257593722;37896.431553526716;38199.427008594896;38247.80876095629;38322.61677383218;2303.4126297793955;2697.757201851823;2803.355228297503;2915.620969274002;3050.42042012017;26935.46129077427;27140.59289110645;27156.59265111005;27333.316667083283;27372;3120.8439578021007;3187.490001599756;3189.5056266278766;3258.5438038674606;3303.8513266903046;215405;218464;218612;219167;219176;50297;51047;56257;61447;62593.68703156546;56811.71594142086;57280.14079788807;57428.13857792137;57542.42457575454;57600;13633.25017124048;13770.93114534441;13824.723505529833;13851;13935.442582296595;9710.70867873965;9769.364991275545;9836.262280329003;9859.50702464874;9944.303898727165;19090.52273693169;19148;19319.517012074528;19403.514912127026;19443.513912152026;7510.887336689954;7802;7925.48484348527;7978.840423191504;8026.9598652007535;849.9702510412106;900.8603666431713;902.1970446302796;927.1377618814568;1024.9538770755335;25978.350541236243;26129.608055879176;26255.606165907528;26278;26327.73672263291;933.272047802715;962.4610218277647;990.3909095905966;1053.710229686827;1054.8839627640953;13873.37569809361;13931.442742290397;14021.088629239066;14064.2967851607;14095.859041409454;260365;263171;264227;265159;265908;44988.77505612451;45026.099478010256;45177.32234016427;45339.54660453419;45519.77240113844;1178.3519064514483;1194.6774370919802;1199.9220050696676;1205.3009254632293;1221.9389030548436;25029.624555632043;25756.356091097125;25796.35509112287;25812.741872581035;25840;40577.1884562313;40753;40899;40986;41002.1799564013;240321;241953;242712;242940;243106;29742.851285743433;41551;42263.7886810564;42456;42575.787121065434;38784.6121538781;38961.6103838958;39339.80330098331;40007.1998560033;40367.79816100901;33501.66498334985;33656.83171584224;34006.48990265099;34290.256779457086;36417.63582364142;33591.83204083964;33739;34007.659923401436;34083.65916340805;34101.147471312426;33821.66178338185;34013.82993085019;34219.82890085533;34308.31383372368;34433.655663443045;30074.24814379658;30392.289195174784;30437.239069023453;30867.382652347278;31214.687853121177;24197;24424;24665.876670616533;24768.876155619106;25069.87465062663 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.069694159412;332.1182261096789;335.1554083709053;335.4130272023958;336.9022983334833;14913.179775112365;15237.542873713792;15776.684466310668;15807.367705291803;16440.588985275375;15401.614959625987;15578.065316081014;15695.37218511261;15746.7954486372;15906.045637261772;4340.175366680329;4361.389405483219;4394.560543945596;4423.955760442403;4434.97782511087;4547.45430548333;4569.474510431293;4573.3368661544055;4581.129585378784;4583.587477127058;4557.293619488984;4609.838655647053;4773.379460670108;4882.633802464829;4892.486288939664;4861.854144375674;4877.634177436688;4887.755612219393;4897.6326775491625;4914.852554423373;6030.728617212236;6283.214598175228;6285.528585356116;6285.748570057192;6312.179416675849;19156.80843191564;19229.711554326695;19332.32336868217;19618.607627847363;19692.40922772305;1946.9610607787765;1988.7116368126685;2018.2431588154443;2054.5685406064745;2064.380685794256;12494.058935361238;13163.407646655924;13420.932895335558;13641.113327633671;13835.169889806644;1827.6436094961489;1891.328578354678;1904.6857268550673;1908.5133291010843;1908.8568357373113;60501;62503.93724407899;62919.37080629181;63434;64019.6799016002;15534.300956456986;15603.375864965501;15692.450764223197;15736.842631573538;15739.449119281;23082.422939426313;23351.416214594432;23513.529729405316;23569.646455303184;23625.054997799896;8590.355723320776;8635.266002389742;8664.220220180214;8667.306615470747;8762.38663293576;7230.74692385764;7297.416206703451;7383.929330247084;7451.180370159278;7471.8505629887095;7636.961815191;7707.11368192665;7772.727954521564;7825;7946.483478573874;2974.2267010577407;3007.578938948549;3016.7284944355115;3081.9213275353895;3089.258577941278;358.1351037245024;358.19942428671897;371.34828376199596;388.3049341678421;402.19962275072396;9388.248940084777;9453.52732363379;9517.381370210915;9872.950635246922;9960.80078398428;388.9241597888441;390.98045097745;394.0149625935162;398.12214067980034;407.97394552699393;4800.639952003614;5340.679559226459;5411.621186516984;5413.810516631899;5446.128619420873;499555;511750;521333;540574;543859;70933.64533177404;75260;76278.23721762712;77584.61207693926;79024.60487697525;414.5460720511036;423.40088774384515;434.3289617540844;435.7124297963329;436.91261747650594;9340.906590934004;9341.159295663423;9437.433753974783;9597.808043839224;9623.663171788954;33176;33594.65621375118;33643.3271334567;34317.48523772195;34388;43360;44492.77753611211;45080.323795143755;45375.77312113418;46071.308930366744;8817.559122043744;9029;9265.351425400157;9367.765805854635;9371.250299976122;16238.269277882287;16355.754663679816;16505.092219928018;16619.252133654256;16751.91624041872;13048.54330098442;13137.868621313664;13749.656258593615;13812.516561920285;13896.37466313998;13138.277394743382;13239.536616218385;13294.734105318033;13400.93299533496;13456.730865382442;13047.478100876238;13968.58094257174;14018.579442616738;14032.78950815759;14149.151050936976;8548.572571371282;8654.82690346177;8747.562621869009;9055.320850936074;9063.320250981335;13191.934040329737;13302.46790128384;13321.866781332063;13851.30743462843;14395.85604143987 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1449.9927500362496;1616.7170745119604;1690.6111594333304;1715.7169067103928;1716.9828301716987;6027.336992930774;6248.125262463247;6725.2938441463675;6932;6991.126109236346;6790.660466976656;6966.895496567543;7058.717651293942;7076.15086189658;7085.681144348504;1997.0913234478278;2036.1855257896887;2041.1529215375601;2044.4377796106041;2045.2228153301724;1985.0967809646647;2006.3278801601407;2015.8185763281301;2073.0360382422173;2078.896055197242;1998.4504261328107;2045.826104781088;2069.7205877206534;2072.3057775645175;2077.034179106715;2023.03905644819;2048.8873111978837;2049.2212959075605;2052.035543294649;2058.938231853047;1952.3557226115347;1990.2735501541977;2008.106392655269;2012.0442789674933;2017.0620661392377;6957.8956315655305;7032.648367581652;7057;7059.611721355323;7060.117485314336;3950.644442000234;4027.3153563894207;4028.798560072014;4032.6370626643743;4035.778032208227;2386.140989243871;2451.63225516174;2689.1125928443566;2749.1065403743864;2761.2130542795408;850.37497439382;872.4590753732663;885.4819930340758;909.8635204719279;914.40563633638;8959.910400895973;9162.26701863856;9187.943386510504;9240.075992400773;9263.953680231556;3657.7988210648136;3708.647678470541;3756.286305601927;3774.8490060397826;3783.5459744830796;7721.884171737428;7723.922760772432;7768.184340644264;7779.8833017504785;7785;4107;4111.301078816608;4116.403121547359;4138.255114079434;4145.2952997990415;3789.280036793056;3790.3556395412847;3795.2788970095594;3797;3812.6187381262207;3040.8327541985404;3042.5284080967485;3076.200187951149;3092.412441636127;3100.162956001912;924.5562130177552;945.9148676619;952.7475219066953;960.0351646595127;963.9036096390305;1122.2985633978763;1134;1144.5936692474218;1187.352892673495;1198.1433275208267;6702.162229721285;6759.763408280785;6770.5599136056;6774.220964589037;6801;398;399.2613664720302;402.1253773043677;403.2258064516136;404.7996241860239;5188.481151884781;5230.764615592308;5296.417394086648;5315.946840531546;5322.456487618547;7536.472446928772;7637.961810190914;8152.83694326122;8186.7953301167945;8444;8287.046989596152;8288.875666865002;8297.087320394752;8305.95847020761;8307.875381869277;6510.381513756186;6638.070670106189;6688.398044176048;6737.124173857465;6769.1876974763345;6758.053872457762;6763.797086087426;6812.557183783038;6817.181938167451;6823.93176068233;7485.737999170003;7550.5469671819865;7657.234276572298;7664.69341226367;7704.92295077042;7757.65090570937;7776.377889768692;7908.762737117896;7959.721409750631;7961.124276329483;6032.54755893301;6117.602355846856;6135.233095863017;6172.259328880563;6178.783742568989;6882.03651488782;6960.060391847036;6987.161540615159;6998.790036298919;6999.965000174967;6468.288488266381;6511.609303441619;6621.1392518972225;6681.532292739462;6689.130413046468;6463.418292353711;6476.870462590816;6501.512386570931;6590.308017658077;6639.302873198245;6568.408843204134;6639.70121344531;6665.133532640726;6683.064370987969;6694.799156025327;5680.460356266148;5952.642841429528;6011.308699499614;6015.248093988252;6033.095035744674;5802.216700745515;5857.47282744555;5863.501602363676;5919.792807251725;5948.078047902582 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.89060157140284;297.1783019949839;300.8781443515377;303.7372672638169;304.23940149625935;5459.454054594544;5515.255440515529;5515.972420137894;5523.143912693534;5668.546516278698;5507.807226747064;5527.198556209347;5549.5837812164045;5585.609007369486;5595.244641973342;4104.507459104897;4232.682548808836;4256.446661933945;4271.359296105578;4278.507971583261;4202.2856114460465;4232.851850185244;4247.277962746341;4255.234057869582;4257.191133684605;4197.496300443936;4209.326507758759;4209.768462734548;4213.199492096492;4226.133642603274;4222.303319952204;4233.068724880522;4235.131797981422;4245;4246.957530424718;3679.1354031802507;3681.4845921571;3681.650243226889;3683.521142251517;3688.61269566697;5179.585633149339;5224.268602395668;5344.866378340534;5346.572274218053;5351.812686555952;4843.321934929113;4853.781579828881;4857.222844344888;4860.222364421676;4865.6107511399005;5827.125931110325;5845.5908086433965;5848.824535263949;5849.473547380713;5878.470937615635;3794;3945.940810887839;3947.940780888289;3949.624785645359;3953.6639385652256;6089.756409743605;6131.325554189036;6152.2002139722;6153.784617538409;6158.045502947006;4051.756894586334;4059.3707975263883;4075.673946084306;4076.6343275002614;4090.7136500444685;4143.751374917515;4148.23257697327;4148.585141485827;4149.170165966819;4149.91700165995;4708.552687494683;4798.088363210979;4798.2802579613335;4803.639727020487;4809.759512024385;5796.1595568642315;5806;5809.041508151192;5817.88364232713;5825.970870145622;1450.7026059657744;1471.1246808149135;1471.9484818031317;1472.1608683050558;1479.733647943359;953.4946478366477;957.3250858144991;965.3966271080575;979.2655508368723;987.1461186074138;5092.10888094582;5094.083065048327;5102.209157580581;5110.029094472038;5110.156824124052;6052.969735151384;6064.666443345658;6070.453659170607;6072.815800918778;6076.696165191723;5083.161278389024;5096.108181068298;5103.744812759422;5104.106781313255;5109.667871588409;3172.2862355969723;3255.3977514159483;3270.5421241026274;3283.326917981808;3290.1116698491273;5554.50009499147;5767.711614419346;5775.16260142277;5781.161731548902;5787.5080618147085;6099.634021958696;6155.199824022849;6338.524610654219;6349.8730025400155;6355.3009168991375;5798.217240672455;5804.622699524517;5809.3609702932645;5828.0966450200285;5852.209951656557;6131.386861313833;6141.631502109888;6142.78500252489;6148.1699970503405;6154.815355539341;5765.365809761007;5916.526677865846;5978.491828194478;5983.880322393441;5993.760249589967;5815.156802263733;5816.1857339973285;5829.941700583109;5843.444872737083;5844.912326315194;4076.612721791425;4123.711340206157;4124.216398884202;4125.071858831739;4133.503979522477;5983.850403739767;6104.542159337979;6107.144999700135;6137.294211165773;6137.877242455215;5861.677607731615;5865;5891.05743081105;5903.380145084876;5912.142739302863;5858.209141765978;5883.2057672213705;5884.735186916513;5886.23478947734;5895.675737834289;5607.971960140173;5747.7413516391025;5751.252337196138;5752.769889204553;5771.220885180447;5905.675187864536;5905.734241959036;5907.143464197581;5913.46778789911;5924.022536281465;5746.16680581305;5750.367459579526;5758.856028599319;5759.251297331488;5768.451997060272 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: |5;yui.html;791.0823444804029;803.3653413803094;805.7904944714372;813.5688085314778;815.6003558256455;10289.228307876901;10517.158627309816;10537.578496860117;10565.049145576897;10584.947075264623;11944.984676302525;11977.221480603777;11978.341191234478;12002.45988930498;12050;598.8832177725345;627.1063734178799;768.6464226455837;818.1899919080098;820.327331588098;802.9879551806728;806.0045843383417;814.222417591199;816.6447595296065;818.4271010292819;839.7816567692413;844.7507985144397;846.2299307630058;847.063994286314;852.688768599463;834.56185502611;837.5728378526934;841.9031811341713;842.4566154830131;842.9199226073513;625.2184769038702;625.4683519008852;625.5527297981919;627.9403456671608;628.4940622798646;11835.171537992344;11904.702382440422;11945.820812687816;11949.462274197682;11956.043516518657;11012.944935275273;11151.107911367071;11155.553777848876;11427;11508.712282192928;9651.276154288456;9750.561224744833;9939.204863610894;9959.103680668775;10064.69805905824;3284.917877053069;3306.057773534555;3321.4353559894635;3336.5662463879785;3409.6590340965954;41890.999999999694;42373.15253694909;42390.152196956195;42545.149097017886;42620.147597047886;9404.38871473352;9495.192908602847;9517.191038761644;9541;9692.854607180898;16226.594335141715;16272.43046493367;16290.592735181715;16297.755533667005;16351.918240408722;5984.132300816357;6112.786052488142;6152.600080994721;6184;6273.654948977759;3569.446735755962;3644.489771432002;3693.575238847513;3720.925581488355;3737.084414318455;2850.7576855967477;2887.20601834493;2887.8556072196307;2905.622269105003;2906.5785461108444;498.8004798080797;499.8900241946766;505.05806670559144;510.50226029620825;511.6546331226482;569.2457493820704;576.1473019930443;583.5710752596838;608.6104892868568;624.54720327762;7602.391808655294;7852.489588176751;7891.171427000082;8011.198880112059;8032.357411407073;485.7595490232287;486.6252985201375;585.3853453873415;591.7573794744134;620.7951376045894;3717.9070523237137;3901.2782635212575;3949.150932549516;4006.899827504336;4070.531888832822;54501.72749136229;54561.45438545564;54697.812087516846;54755;54851.451485485435;48457.757711211925;49121;49266;49446.752766236656;49484.257736133986;42488.3626745599;42972.78513607412;43031.13937721228;43464.78267608705;43924.56075439269;8021.558814265038;8032.3975701823765;8147.75556733299;8216;8386.622601982803;31154.22114447157;31663.52504712477;31923.68076319207;32477.675223247465;32677.509837351983;39710.80144599374;42413.36379954365;42456.1508769829;42534.57465425306;42614.36078458888;9988.05113514215;10045.899541004497;10096.899031009596;10246.692599222035;10320.587176513156;11356.54573817038;11479.885201148216;11617.244879082833;12300.077494187793;12310.446029928853;10654.62708805188;10944.945275273572;10995.065419439117;11084.722881928017;11302.265352752045;10126.392416455037;10497.47512624381;10633.415162166155;11164.274322169033;11173.776524469302;10766.515506802056;10862.891371086187;10907.345559266469;11097.278676885977;11549.249298795552;9333.85999210026;9399.295052870926;9428.245740340893;9570.377925434825;9738.707838764849;8883.600237989434;8888.511131887808;8901.109889011048;9144.26845852317;9184.816303674022 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,342 18:51:05 INFO - 2015-12-02 18:51:05,894 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: __startTimestamp1449111065887__endTimestamp 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,895 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4682.07 Median:4836.52 stddev:495.46 (10.2%) stddev-sans-first:470.57 18:51:05 INFO - 2015-12-02 18:51:05,896 DEBUG : BROWSER_OUTPUT: Values: 2647.1 2707.3 2733.1 2740.8 2752.7 4595.3 4726.2 4761.1 4819.7 4859.9 4707.6 4727.9 4728.1 4862.3 4872.2 4344.7 4417.0 4418.6 4478.5 4504.8 4227.3 4450.0 4491.3 4496.1 4506.9 4255.6 4332.4 4343.3 4345.5 4372.2 4339.6 4345.2 4361.8 4398.2 4405.2 4186.0 4290.5 4297.1 4330.2 4450.2 4508.8 4544.3 4547.0 4596.7 4601.1 5022.8 5023.7 5026.5 5071.2 5082.6 4908.2 5003.8 5035.1 5106.7 5136.3 4757.8 4767.0 4781.6 4788.9 4814.9 5251.7 5266.0 5269.5 5272.4 5278.3 4836.5 4923.2 4965.3 5049.8 5053.3 5110.2 5112.4 5124.4 5133.9 5156.1 5049.2 5050.3 5053.4 5054.6 5070.1 4872.5 4882.7 4974.2 4981.3 5006.3 4183.4 4194.6 4231.1 4233.5 4261.9 3679.2 3683.6 3688.7 3705.4 3712.5 4142.3 4298.9 4354.6 4414.0 4420.3 5089.5 5091.4 5093.5 5106.6 5175.4 4384.3 4413.9 4414.3 4428.8 4445.3 4334.2 4370.6 4421.0 4444.7 4478.0 4877.5 4883.5 4885.2 4909.6 4929.3 5033.6 5148.8 5153.0 5164.7 5209.5 4902.0 4905.6 4910.5 4915.9 4920.4 4957.9 5031.6 5059.7 5071.9 5081.7 5065.6 5073.6 5105.1 5124.9 5173.3 4883.0 4912.2 4928.9 4935.7 4973.6 4672.7 4781.1 4891.9 4993.8 5009.0 4743.6 4796.4 4829.7 4842.4 4856.9 4968.0 4988.5 4990.4 4993.4 5029.4 4649.6 4683.9 4740.1 4746.4 4759.0 18:51:05 INFO - 2015-12-02 18:51:05,896 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,896 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40823.08 Median:36928.04 stddev:62994.29 (170.6%) stddev-sans-first:63098.53 18:51:05 INFO - 2015-12-02 18:51:05,896 DEBUG : BROWSER_OUTPUT: Values: 577.5 583.6 588.9 590.7 591.9 36079.3 36854.8 37001.3 37066.4 37108.0 40544.2 40776.6 41167.6 41225.8 41226.0 7821.3 7965.2 8011.7 8028.8 8032.8 7764.9 7865.3 7894.8 7914.2 7924.7 7858.5 7865.4 7929.2 7955.0 7962.8 7886.2 7911.8 7977.6 7984.8 8009.0 7805.9 7864.0 7908.2 7938.2 7982.6 37484.8 37896.4 38199.4 38247.8 38322.6 2303.4 2697.8 2803.4 2915.6 3050.4 26935.5 27140.6 27156.6 27333.3 27372.0 3120.8 3187.5 3189.5 3258.5 3303.9 215405.0 218464.0 218612.0 219167.0 219176.0 50297.0 51047.0 56257.0 61447.0 62593.7 56811.7 57280.1 57428.1 57542.4 57600.0 13633.3 13770.9 13824.7 13851.0 13935.4 9710.7 9769.4 9836.3 9859.5 9944.3 19090.5 19148.0 19319.5 19403.5 19443.5 7510.9 7802.0 7925.5 7978.8 8027.0 850.0 900.9 902.2 927.1 1025.0 25978.4 26129.6 26255.6 26278.0 26327.7 933.3 962.5 990.4 1053.7 1054.9 13873.4 13931.4 14021.1 14064.3 14095.9 260365.0 263171.0 264227.0 265159.0 265908.0 44988.8 45026.1 45177.3 45339.5 45519.8 1178.4 1194.7 1199.9 1205.3 1221.9 25029.6 25756.4 25796.4 25812.7 25840.0 40577.2 40753.0 40899.0 40986.0 41002.2 240321.0 241953.0 242712.0 242940.0 243106.0 29742.9 41551.0 42263.8 42456.0 42575.8 38784.6 38961.6 39339.8 40007.2 40367.8 33501.7 33656.8 34006.5 34290.3 36417.6 33591.8 33739.0 34007.7 34083.7 34101.1 33821.7 34013.8 34219.8 34308.3 34433.7 30074.2 30392.3 30437.2 30867.4 31214.7 24197.0 24424.0 24665.9 24768.9 25069.9 18:51:05 INFO - 2015-12-02 18:51:05,896 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,897 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28166.23 Median:418.97 stddev:85561.62 (20421.7%) stddev-sans-first:85776.11 18:51:05 INFO - 2015-12-02 18:51:05,898 DEBUG : BROWSER_OUTPUT: Values: 331.1 332.1 335.2 335.4 336.9 14913.2 15237.5 15776.7 15807.4 16440.6 15401.6 15578.1 15695.4 15746.8 15906.0 4340.2 4361.4 4394.6 4424.0 4435.0 4547.5 4569.5 4573.3 4581.1 4583.6 4557.3 4609.8 4773.4 4882.6 4892.5 4861.9 4877.6 4887.8 4897.6 4914.9 6030.7 6283.2 6285.5 6285.7 6312.2 19156.8 19229.7 19332.3 19618.6 19692.4 1947.0 1988.7 2018.2 2054.6 2064.4 12494.1 13163.4 13420.9 13641.1 13835.2 1827.6 1891.3 1904.7 1908.5 1908.9 60501.0 62503.9 62919.4 63434.0 64019.7 15534.3 15603.4 15692.5 15736.8 15739.4 23082.4 23351.4 23513.5 23569.6 23625.1 8590.4 8635.3 8664.2 8667.3 8762.4 7230.7 7297.4 7383.9 7451.2 7471.9 7637.0 7707.1 7772.7 7825.0 7946.5 2974.2 3007.6 3016.7 3081.9 3089.3 358.1 358.2 371.3 388.3 402.2 9388.2 9453.5 9517.4 9873.0 9960.8 388.9 391.0 394.0 398.1 408.0 4800.6 5340.7 5411.6 5413.8 5446.1 499555.0 511750.0 521333.0 540574.0 543859.0 70933.6 75260.0 76278.2 77584.6 79024.6 414.5 423.4 434.3 435.7 436.9 9340.9 9341.2 9437.4 9597.8 9623.7 33176.0 33594.7 33643.3 34317.5 34388.0 43360.0 44492.8 45080.3 45375.8 46071.3 8817.6 9029.0 9265.4 9367.8 9371.3 16238.3 16355.8 16505.1 16619.3 16751.9 13048.5 13137.9 13749.7 13812.5 13896.4 13138.3 13239.5 13294.7 13400.9 13456.7 13047.5 13968.6 14018.6 14032.8 14149.2 8548.6 8654.8 8747.6 9055.3 9063.3 13191.9 13302.5 13321.9 13851.3 14395.9 18:51:05 INFO - 2015-12-02 18:51:05,898 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,898 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4889.82 Median:6213.45 stddev:2550.23 (41.0%) stddev-sans-first:2544.28 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: Values: 1450.0 1616.7 1690.6 1715.7 1717.0 6027.3 6248.1 6725.3 6932.0 6991.1 6790.7 6966.9 7058.7 7076.2 7085.7 1997.1 2036.2 2041.2 2044.4 2045.2 1985.1 2006.3 2015.8 2073.0 2078.9 1998.5 2045.8 2069.7 2072.3 2077.0 2023.0 2048.9 2049.2 2052.0 2058.9 1952.4 1990.3 2008.1 2012.0 2017.1 6957.9 7032.6 7057.0 7059.6 7060.1 3950.6 4027.3 4028.8 4032.6 4035.8 2386.1 2451.6 2689.1 2749.1 2761.2 850.4 872.5 885.5 909.9 914.4 8959.9 9162.3 9187.9 9240.1 9264.0 3657.8 3708.6 3756.3 3774.8 3783.5 7721.9 7723.9 7768.2 7779.9 7785.0 4107.0 4111.3 4116.4 4138.3 4145.3 3789.3 3790.4 3795.3 3797.0 3812.6 3040.8 3042.5 3076.2 3092.4 3100.2 924.6 945.9 952.7 960.0 963.9 1122.3 1134.0 1144.6 1187.4 1198.1 6702.2 6759.8 6770.6 6774.2 6801.0 398.0 399.3 402.1 403.2 404.8 5188.5 5230.8 5296.4 5315.9 5322.5 7536.5 7638.0 8152.8 8186.8 8444.0 8287.0 8288.9 8297.1 8306.0 8307.9 6510.4 6638.1 6688.4 6737.1 6769.2 6758.1 6763.8 6812.6 6817.2 6823.9 7485.7 7550.5 7657.2 7664.7 7704.9 7757.7 7776.4 7908.8 7959.7 7961.1 6032.5 6117.6 6135.2 6172.3 6178.8 6882.0 6960.1 6987.2 6998.8 7000.0 6468.3 6511.6 6621.1 6681.5 6689.1 6463.4 6476.9 6501.5 6590.3 6639.3 6568.4 6639.7 6665.1 6683.1 6694.8 5680.5 5952.6 6011.3 6015.2 6033.1 5802.2 5857.5 5863.5 5919.8 5948.1 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4830.47 Median:5538.39 stddev:1451.92 (26.2%) stddev-sans-first:1415.39 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: Values: 287.9 297.2 300.9 303.7 304.2 5459.5 5515.3 5516.0 5523.1 5668.5 5507.8 5527.2 5549.6 5585.6 5595.2 4104.5 4232.7 4256.4 4271.4 4278.5 4202.3 4232.9 4247.3 4255.2 4257.2 4197.5 4209.3 4209.8 4213.2 4226.1 4222.3 4233.1 4235.1 4245.0 4247.0 3679.1 3681.5 3681.7 3683.5 3688.6 5179.6 5224.3 5344.9 5346.6 5351.8 4843.3 4853.8 4857.2 4860.2 4865.6 5827.1 5845.6 5848.8 5849.5 5878.5 3794.0 3945.9 3947.9 3949.6 3953.7 6089.8 6131.3 6152.2 6153.8 6158.0 4051.8 4059.4 4075.7 4076.6 4090.7 4143.8 4148.2 4148.6 4149.2 4149.9 4708.6 4798.1 4798.3 4803.6 4809.8 5796.2 5806.0 5809.0 5817.9 5826.0 1450.7 1471.1 1471.9 1472.2 1479.7 953.5 957.3 965.4 979.3 987.1 5092.1 5094.1 5102.2 5110.0 5110.2 6053.0 6064.7 6070.5 6072.8 6076.7 5083.2 5096.1 5103.7 5104.1 5109.7 3172.3 3255.4 3270.5 3283.3 3290.1 5554.5 5767.7 5775.2 5781.2 5787.5 6099.6 6155.2 6338.5 6349.9 6355.3 5798.2 5804.6 5809.4 5828.1 5852.2 6131.4 6141.6 6142.8 6148.2 6154.8 5765.4 5916.5 5978.5 5983.9 5993.8 5815.2 5816.2 5829.9 5843.4 5844.9 4076.6 4123.7 4124.2 4125.1 4133.5 5983.9 6104.5 6107.1 6137.3 6137.9 5861.7 5865.0 5891.1 5903.4 5912.1 5858.2 5883.2 5884.7 5886.2 5895.7 5608.0 5747.7 5751.3 5752.8 5771.2 5905.7 5905.7 5907.1 5913.5 5924.0 5746.2 5750.4 5758.9 5759.3 5768.5 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: 18:51:05 INFO - 2015-12-02 18:51:05,900 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12782.03 Median:24471.76 stddev:14887.01 (60.8%) stddev-sans-first:14901.54 18:51:05 INFO - 2015-12-02 18:51:05,901 DEBUG : BROWSER_OUTPUT: Values: 791.1 803.4 805.8 813.6 815.6 10289.2 10517.2 10537.6 10565.0 10584.9 11945.0 11977.2 11978.3 12002.5 12050.0 598.9 627.1 768.6 818.2 820.3 803.0 806.0 814.2 816.6 818.4 839.8 844.8 846.2 847.1 852.7 834.6 837.6 841.9 842.5 842.9 625.2 625.5 625.6 627.9 628.5 11835.2 11904.7 11945.8 11949.5 11956.0 11012.9 11151.1 11155.6 11427.0 11508.7 9651.3 9750.6 9939.2 9959.1 10064.7 3284.9 3306.1 3321.4 3336.6 3409.7 41891.0 42373.2 42390.2 42545.1 42620.1 9404.4 9495.2 9517.2 9541.0 9692.9 16226.6 16272.4 16290.6 16297.8 16351.9 5984.1 6112.8 6152.6 6184.0 6273.7 3569.4 3644.5 3693.6 3720.9 3737.1 2850.8 2887.2 2887.9 2905.6 2906.6 498.8 499.9 505.1 510.5 511.7 569.2 576.1 583.6 608.6 624.5 7602.4 7852.5 7891.2 8011.2 8032.4 485.8 486.6 585.4 591.8 620.8 3717.9 3901.3 3949.2 4006.9 4070.5 54501.7 54561.5 54697.8 54755.0 54851.5 48457.8 49121.0 49266.0 49446.8 49484.3 42488.4 42972.8 43031.1 43464.8 43924.6 8021.6 8032.4 8147.8 8216.0 8386.6 31154.2 31663.5 31923.7 32477.7 32677.5 39710.8 42413.4 42456.2 42534.6 42614.4 9988.1 10045.9 10096.9 10246.7 10320.6 11356.5 11479.9 11617.2 12300.1 12310.4 10654.6 10944.9 10995.1 11084.7 11302.3 10126.4 10497.5 10633.4 11164.3 11173.8 10766.5 10862.9 10907.3 11097.3 11549.2 9333.9 9399.3 9428.2 9570.4 9738.7 8883.6 8888.5 8901.1 9144.3 9184.8 18:51:05 INFO - 2015-12-02 18:51:05,901 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:51:05 INFO - 2015-12-02 18:51:05,901 DEBUG : BROWSER_OUTPUT: 18:51:06 INFO - 2015-12-02 18:51:06,605 INFO : Browser exited with error code: 0 18:51:06 INFO - 2015-12-02 18:51:06,627 INFO : Completed test dromaeo_css (00:18:34) 18:51:06 INFO - 2015-12-02 18:51:06,627 INFO : Starting test kraken 18:51:06 INFO - 2015-12-02 18:51:06,627 DEBUG : operating with platform_type : linux_ 18:51:06 INFO - 2015-12-02 18:51:06,627 INFO : Initialising browser for kraken test... 18:51:06 INFO - 2015-12-02 18:51:06,633 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNoUzx/profile http://localhost:50252/getInfo.html 18:51:11 INFO - 2015-12-02 18:51:11,162 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:51:11 INFO - 2015-12-02 18:51:11,162 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:51:11 INFO - 2015-12-02 18:51:11,162 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:51:11 INFO - 2015-12-02 18:51:11,162 DEBUG : BROWSER_OUTPUT: __metrics 18:51:11 INFO - 2015-12-02 18:51:11,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:51:12 INFO - 2015-12-02 18:51:12,185 INFO : Browser initialized. 18:51:12 INFO - 2015-12-02 18:51:12,186 INFO : Running cycle 1/1 for kraken test... 18:51:12 INFO - 2015-12-02 18:51:12,186 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNoUzx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:51:24 INFO - 2015-12-02 18:51:24,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 143740928 18:51:24 INFO - 2015-12-02 18:51:24,178 DEBUG : BROWSER_OUTPUT: 18:51:26 INFO - 2015-12-02 18:51:26,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:27 INFO - 2015-12-02 18:51:27,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 18:51:27 INFO - 2015-12-02 18:51:27,357 DEBUG : BROWSER_OUTPUT: 18:51:30 INFO - 2015-12-02 18:51:30,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-dft) 18:51:30 INFO - 2015-12-02 18:51:30,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 143187968 18:51:30 INFO - 2015-12-02 18:51:30,688 DEBUG : BROWSER_OUTPUT: 18:51:33 INFO - 2015-12-02 18:51:33,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-fft) 18:51:34 INFO - 2015-12-02 18:51:34,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 18:51:34 INFO - 2015-12-02 18:51:34,207 DEBUG : BROWSER_OUTPUT: 18:51:36 INFO - 2015-12-02 18:51:36,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-oscillator) 18:51:36 INFO - 2015-12-02 18:51:36,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 138915840 18:51:36 INFO - 2015-12-02 18:51:36,874 DEBUG : BROWSER_OUTPUT: 18:51:39 INFO - 2015-12-02 18:51:39,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:39 INFO - 2015-12-02 18:51:39,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 139894784 18:51:39 INFO - 2015-12-02 18:51:39,697 DEBUG : BROWSER_OUTPUT: 18:51:42 INFO - 2015-12-02 18:51:42,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:43 INFO - 2015-12-02 18:51:43,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 140406784 18:51:43 INFO - 2015-12-02 18:51:43,342 DEBUG : BROWSER_OUTPUT: 18:51:46 INFO - 2015-12-02 18:51:46,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:47 INFO - 2015-12-02 18:51:47,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 140374016 18:51:47 INFO - 2015-12-02 18:51:47,377 DEBUG : BROWSER_OUTPUT: 18:51:50 INFO - 2015-12-02 18:51:50,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50252/tests/kraken/driver.html?testName=json-parse-financial) 18:51:50 INFO - 2015-12-02 18:51:50,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 141074432 18:51:50 INFO - 2015-12-02 18:51:50,856 DEBUG : BROWSER_OUTPUT: 18:51:52 INFO - 2015-12-02 18:51:52,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:53 INFO - 2015-12-02 18:51:53,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 140255232 18:51:53 INFO - 2015-12-02 18:51:53,196 DEBUG : BROWSER_OUTPUT: 18:51:55 INFO - 2015-12-02 18:51:55,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:55 INFO - 2015-12-02 18:51:55,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 18:51:55 INFO - 2015-12-02 18:51:55,717 DEBUG : BROWSER_OUTPUT: 18:51:57 INFO - 2015-12-02 18:51:57,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:58 INFO - 2015-12-02 18:51:58,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 141553664 18:51:58 INFO - 2015-12-02 18:51:58,476 DEBUG : BROWSER_OUTPUT: 18:52:01 INFO - 2015-12-02 18:52:01,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:52:01 INFO - 2015-12-02 18:52:01,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 141639680 18:52:01 INFO - 2015-12-02 18:52:01,625 DEBUG : BROWSER_OUTPUT: 18:52:04 INFO - 2015-12-02 18:52:04,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:52:04 INFO - 2015-12-02 18:52:04,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 18:52:04 INFO - 2015-12-02 18:52:04,835 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50252/tests/kraken/driver.html?testName=ai-astar) 18:52:06 INFO - 2015-12-02 18:52:06,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 18:52:06 INFO - 2015-12-02 18:52:06,835 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,835 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:52:06 INFO - 2015-12-02 18:52:06,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:52:06 INFO - 2015-12-02 18:52:06,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:52:06 INFO - 2015-12-02 18:52:06,836 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:52:06 INFO - 2015-12-02 18:52:06,836 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;115;111;110;123;110;110;111;111 18:52:06 INFO - 2015-12-02 18:52:06,836 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;135;155;164;132;160;151;134;168;140 18:52:06 INFO - 2015-12-02 18:52:06,837 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;166;162;164;161;164;172;165;164;162 18:52:06 INFO - 2015-12-02 18:52:06,837 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;72;72;73;132;71;72;72 18:52:06 INFO - 2015-12-02 18:52:06,837 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;141;94;95;96;136;94;95;134 18:52:06 INFO - 2015-12-02 18:52:06,837 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;111;112;111;111;111;111;110 18:52:06 INFO - 2015-12-02 18:52:06,837 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;148;148;148;149;147;147;147 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;96;96;96;96;96;98;96 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;73;73;74;73;74;73;70 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;70;69;69;69;73;69 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;85;86;84;85;93;85;84 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;127;125;121;132;132;125;124;126 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;137;149;148;145;138;149;144;147;146 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;69;70;71;69;71;67;68;68;69 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:52:06 INFO - 2015-12-02 18:52:06,838 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:52:06 INFO - 2015-12-02 18:52:06,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,775 18:52:06 INFO - 2015-12-02 18:52:06,839 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:52:06 INFO - 2015-12-02 18:52:06,839 DEBUG : BROWSER_OUTPUT: __startTimestamp1449111126834__endTimestamp 18:52:06 INFO - 2015-12-02 18:52:06,839 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,840 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:52:06 INFO - 2015-12-02 18:52:06,840 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:52:06 INFO - 2015-12-02 18:52:06,840 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:111.00 stddev:4.50 (4.1%) stddev-sans-first:4.76 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 115.0 111.0 110.0 123.0 110.0 110.0 111.0 111.0 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.00 stddev:13.08 (8.5%) stddev-sans-first:13.86 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: Values: 150.0 135.0 155.0 164.0 132.0 160.0 151.0 134.0 168.0 140.0 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,841 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 18:52:06 INFO - 2015-12-02 18:52:06,842 DEBUG : BROWSER_OUTPUT: Values: 164.0 166.0 162.0 164.0 161.0 164.0 172.0 165.0 164.0 162.0 18:52:06 INFO - 2015-12-02 18:52:06,842 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,842 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.10 Median:72.00 stddev:18.95 (26.3%) stddev-sans-first:20.01 18:52:06 INFO - 2015-12-02 18:52:06,842 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 72.0 72.0 73.0 132.0 71.0 72.0 72.0 18:52:06 INFO - 2015-12-02 18:52:06,842 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,843 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.50 stddev:20.51 (21.7%) stddev-sans-first:21.25 18:52:06 INFO - 2015-12-02 18:52:06,843 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 141.0 94.0 95.0 96.0 136.0 94.0 95.0 134.0 18:52:06 INFO - 2015-12-02 18:52:06,843 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,843 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 18:52:06 INFO - 2015-12-02 18:52:06,844 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 111.0 112.0 111.0 111.0 111.0 111.0 110.0 18:52:06 INFO - 2015-12-02 18:52:06,844 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,844 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 18:52:06 INFO - 2015-12-02 18:52:06,844 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 148.0 148.0 148.0 149.0 147.0 147.0 147.0 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 18:52:06 INFO - 2015-12-02 18:52:06,845 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 74.0 73.0 74.0 73.0 70.0 18:52:06 INFO - 2015-12-02 18:52:06,846 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,846 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 18:52:06 INFO - 2015-12-02 18:52:06,846 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 70.0 69.0 69.0 69.0 73.0 69.0 18:52:06 INFO - 2015-12-02 18:52:06,846 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,847 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:2.72 (3.2%) stddev-sans-first:2.83 18:52:06 INFO - 2015-12-02 18:52:06,847 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 85.0 86.0 84.0 85.0 93.0 85.0 84.0 18:52:06 INFO - 2015-12-02 18:52:06,847 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,847 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.50 stddev:3.83 (3.1%) stddev-sans-first:4.01 18:52:06 INFO - 2015-12-02 18:52:06,848 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 127.0 125.0 121.0 132.0 132.0 125.0 124.0 126.0 18:52:06 INFO - 2015-12-02 18:52:06,848 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,848 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:146.50 stddev:4.88 (3.3%) stddev-sans-first:4.47 18:52:06 INFO - 2015-12-02 18:52:06,848 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 149.0 148.0 145.0 138.0 149.0 144.0 147.0 146.0 18:52:06 INFO - 2015-12-02 18:52:06,848 DEBUG : BROWSER_OUTPUT: 18:52:06 INFO - 2015-12-02 18:52:06,849 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.36 18:52:06 INFO - 2015-12-02 18:52:06,849 DEBUG : BROWSER_OUTPUT: Values: 72.0 69.0 70.0 71.0 69.0 71.0 67.0 68.0 68.0 69.0 18:52:06 INFO - 2015-12-02 18:52:06,849 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:52:06 INFO - 2015-12-02 18:52:06,849 DEBUG : BROWSER_OUTPUT: 18:52:07 INFO - 2015-12-02 18:52:07,758 INFO : Browser exited with error code: 0 18:52:07 INFO - 2015-12-02 18:52:07,811 INFO : Completed test kraken (00:01:01) 18:52:07 INFO - 2015-12-02 18:52:07,812 INFO : Starting test v8_7 18:52:07 INFO - 2015-12-02 18:52:07,812 DEBUG : operating with platform_type : linux_ 18:52:07 INFO - 2015-12-02 18:52:07,812 INFO : Initialising browser for v8_7 test... 18:52:07 INFO - 2015-12-02 18:52:07,818 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpReutfX/profile http://localhost:50252/getInfo.html 18:52:12 INFO - 2015-12-02 18:52:12,440 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:52:12 INFO - 2015-12-02 18:52:12,440 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:52:12 INFO - 2015-12-02 18:52:12,441 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:52:12 INFO - 2015-12-02 18:52:12,441 DEBUG : BROWSER_OUTPUT: __metrics 18:52:12 INFO - 2015-12-02 18:52:12,557 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:52:13 INFO - 2015-12-02 18:52:13,549 INFO : Browser initialized. 18:52:13 INFO - 2015-12-02 18:52:13,550 INFO : Running cycle 1/1 for v8_7 test... 18:52:13 INFO - 2015-12-02 18:52:13,550 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpReutfX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:52:25 INFO - 2015-12-02 18:52:25,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 18:52:25 INFO - 2015-12-02 18:52:25,576 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50252/tests/v8_7/run.html (next: http://localhost:50252/tests/v8_7/run.html) 18:52:47 INFO - 2015-12-02 18:52:47,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 138534912 18:52:47 INFO - 2015-12-02 18:52:47,285 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,286 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:52:47 INFO - 2015-12-02 18:52:47,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |0;Richards;168.15200941651253 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.85732671446956 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 18:52:47 INFO - 2015-12-02 18:52:47,287 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1079.913606911447 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: |5;Earley;705.7163020465773 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: |8;Splay;608.272506082725 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:52:47 INFO - 2015-12-02 18:52:47,288 DEBUG : BROWSER_OUTPUT: __startTimestamp1449111167286__endTimestamp 18:52:47 INFO - 2015-12-02 18:52:47,289 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: Values: 168.2 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.86 Median:183.86 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: Values: 183.9 18:52:47 INFO - 2015-12-02 18:52:47,290 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: Values: 280.7 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: Values: 5181.3 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: Values: 1079.9 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: Values: 705.7 18:52:47 INFO - 2015-12-02 18:52:47,291 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: Values: 12207.3 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: Values: 25666.7 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,292 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.27 Median:608.27 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: Values: 608.3 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:52:47 INFO - 2015-12-02 18:52:47,293 DEBUG : BROWSER_OUTPUT: 18:52:48 INFO - 2015-12-02 18:52:48,194 INFO : Browser exited with error code: 0 18:52:48 INFO - 2015-12-02 18:52:48,206 INFO : Completed test v8_7 (00:00:40) 18:52:48 INFO - 2015-12-02 18:52:48,340 INFO : Completed test suite (00:20:16) 18:52:48 INFO - 2015-12-02 18:52:48,340 DEBUG : Working with test: dromaeo_css 18:52:48 INFO - 2015-12-02 18:52:48,340 DEBUG : Generating results file: dromaeo_css 18:52:48 INFO - 2015-12-02 18:52:48,341 DEBUG : Working with test: kraken 18:52:48 INFO - 2015-12-02 18:52:48,341 DEBUG : Generating results file: kraken 18:52:48 INFO - 2015-12-02 18:52:48,342 INFO : javascript benchmark 18:52:48 INFO - 2015-12-02 18:52:48,342 DEBUG : Working with test: v8_7 18:52:48 INFO - 2015-12-02 18:52:48,342 DEBUG : Generating results file: v8_7 18:52:48 INFO - 2015-12-02 18:52:48,342 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:52:48 INFO - 2015-12-02 18:52:48,400 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:52:48 INFO - 2015-12-02 18:52:48,401 DEBUG : process_Request line: dromaeo_css 6340.93 graph.html#tests=[[72,132,43]] 18:52:48 INFO - 2015-12-02 18:52:48,401 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:52:48 INFO - 2015-12-02 18:52:48,430 DEBUG : process_Request line: kraken 1532.70 graph.html#tests=[[232,132,43]] 18:52:48 INFO - 2015-12-02 18:52:48,431 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:52:48 INFO - 2015-12-02 18:52:48,468 DEBUG : process_Request line: v8_7 21354.36 graph.html#tests=[[230,132,43]] 18:52:48 INFO - 2015-12-02 18:52:48,470 INFO : javascript benchmark 18:52:48 INFO - 2015-12-02 18:52:48,473 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2647.1264482720703, 2707.28257011892, 2733.0844167203986, 2740.7670348020406, 2752.724727527247, 4595.333676616897, 4726.243800991838, 4761.0715910397485, 4819.662623616348, 4859.854204373874, 4707.552782485667, 4727.8818029549275, 4728.148933192024, 4862.343583616211, 4872.171730805762, 4344.717593356438, 4416.97791511042, 4418.646508279338, 4478.462584489866, 4504.7747612619405, 4227.260229459847, 4449.977750111261, 4491.281394976804, 4496.100779844044, 4506.932396014046, 4255.638270747006, 4332.436783218193, 4343.283358245885, 4345.47854257488, 4372.2130016597, 4339.60943515082, 4345.217860785057, 4361.760103194355, 4398.164348773723, 4405.185040767468, 4185.958140418587, 4290.528041915387, 4297.05464797744, 4330.242207613655, 4450.198964186445, 4508.819647214107, 4544.295634176675, 4547.0, 4596.655250856199, 4601.102784956935, 5022.824201152942, 5023.673461225008, 5026.547610715017, 5071.1632580624155, 5082.593392528589, 4908.190148625508, 5003.799848006075, 5035.1188542005, 5106.744662766847, 5136.280920671109, 4757.762111894461, 4767.046590681808, 4781.569658730731, 4788.904221915577, 4814.927776083362, 5251.711155886386, 5266.0, 5269.525742683177, 5272.420033796279, 5278.261043453919, 4836.516348365135, 4923.212286034289, 4965.3048573199785, 5049.7727602257255, 5053.267276244924, 5110.207917772751, 5112.36095488064, 5124.436312005676, 5133.922991155136, 5156.097682905552, 5049.2426136079885, 5050.267711181858, 5053.393592768891, 5054.595632349403, 5070.062038522811, 4872.4883887192045, 4882.731449770296, 4974.1543937530705, 4981.302617633534, 5006.349174607278, 4183.3515805050265, 4194.580541945781, 4231.069164783743, 4233.5131459881895, 4261.850835220815, 3679.1537946272506, 3683.5763887152784, 3688.6680198782237, 3705.40713485841, 3712.535933008374, 4142.2958097123565, 4298.914021719548, 4354.586314300136, 4413.955860441419, 4420.31485119807, 5089.465606111305, 5091.363579552556, 5093.490650934951, 5106.642535022587, 5175.430702622709, 4384.298512238027, 4413.889652758707, 4414.337849322563, 4428.778561071934, 4445.333200019958, 4334.19817333788, 4370.606645401929, 4421.027373977719, 4444.666650001198, 4477.955220447819, 4877.512248775094, 4883.536064073907, 4885.193942999365, 4909.607231421478, 4929.260610908393, 5033.597312214941, 5148.819791307286, 5152.9742351288005, 5164.741762911764, 5209.453007434165, 4902.044101400335, 4905.6075513958085, 4910.484399138182, 4915.877103072452, 4920.384951881015, 4957.925631115464, 5031.572316353005, 5059.747012649426, 5071.923921141112, 5081.669691470042, 5065.56942659878, 5073.644844860824, 5105.055564720538, 5124.897502050013, 5173.32746742921, 4882.95117048825, 4912.214045752662, 4928.926066109083, 4935.703857768545, 4973.577245934136, 4672.719636821802, 4781.067691800065, 4891.853244402673, 4993.750312484289, 5008.974955125201, 4743.573078422958, 4796.400449943757, 4829.710217386968, 4842.370491836039, 4856.854294371175, 4967.975160124321, 4988.45127036033, 4990.4011518618, 4993.4257560379565, 5029.4216165140015, 4649.628029757544, 4683.9226977794615, 4740.146773580788, 4746.406699162605, 4758.976205118952], "unit": "ms", "name": "dojo.html", "value": 4650.945287105529}, {"lowerIsBetter": false, "replicates": [577.517772659829, 583.6439771739239, 588.8792797476518, 590.7312172961304, 591.9112133180024, 36079.2784144317, 36854.8157259214, 37001.25997480049, 37066.44400333994, 37108.0, 40544.189116217654, 40776.59223407765, 41167.58832411675, 41225.793871030604, 41226.0, 7821.335186509139, 7965.203479652017, 8011.679532818709, 8028.799280018017, 8032.799180020488, 7764.883526747103, 7865.292123708865, 7894.763157105267, 7914.208579142098, 7924.683012679486, 7858.528488290721, 7865.370770338388, 7929.167437419074, 7954.9602251988945, 7962.800929976768, 7886.211378862096, 7911.802204944894, 7977.641006154737, 7984.8403031939615, 8009.038915330139, 7805.882911756328, 7864.0, 7908.169642187545, 7938.24586664266, 7982.600869956537, 37484.81257593722, 37896.431553526716, 38199.427008594896, 38247.80876095629, 38322.61677383218, 2303.4126297793955, 2697.757201851823, 2803.355228297503, 2915.620969274002, 3050.42042012017, 26935.46129077427, 27140.59289110645, 27156.59265111005, 27333.316667083283, 27372.0, 3120.8439578021007, 3187.490001599756, 3189.5056266278766, 3258.5438038674606, 3303.8513266903046, 215405.0, 218464.0, 218612.0, 219167.0, 219176.0, 50297.0, 51047.0, 56257.0, 61447.0, 62593.68703156546, 56811.71594142086, 57280.14079788807, 57428.13857792137, 57542.42457575454, 57600.0, 13633.25017124048, 13770.93114534441, 13824.723505529833, 13851.0, 13935.442582296595, 9710.70867873965, 9769.364991275545, 9836.262280329003, 9859.50702464874, 9944.303898727165, 19090.52273693169, 19148.0, 19319.517012074528, 19403.514912127026, 19443.513912152026, 7510.887336689954, 7802.0, 7925.48484348527, 7978.840423191504, 8026.9598652007535, 849.9702510412106, 900.8603666431713, 902.1970446302796, 927.1377618814568, 1024.9538770755335, 25978.350541236243, 26129.608055879176, 26255.606165907528, 26278.0, 26327.73672263291, 933.272047802715, 962.4610218277647, 990.3909095905966, 1053.710229686827, 1054.8839627640953, 13873.37569809361, 13931.442742290397, 14021.088629239066, 14064.2967851607, 14095.859041409454, 260365.0, 263171.0, 264227.0, 265159.0, 265908.0, 44988.77505612451, 45026.099478010256, 45177.32234016427, 45339.54660453419, 45519.77240113844, 1178.3519064514483, 1194.6774370919802, 1199.9220050696676, 1205.3009254632293, 1221.9389030548436, 25029.624555632043, 25756.356091097125, 25796.35509112287, 25812.741872581035, 25840.0, 40577.1884562313, 40753.0, 40899.0, 40986.0, 41002.1799564013, 240321.0, 241953.0, 242712.0, 242940.0, 243106.0, 29742.851285743433, 41551.0, 42263.7886810564, 42456.0, 42575.787121065434, 38784.6121538781, 38961.6103838958, 39339.80330098331, 40007.1998560033, 40367.79816100901, 33501.66498334985, 33656.83171584224, 34006.48990265099, 34290.256779457086, 36417.63582364142, 33591.83204083964, 33739.0, 34007.659923401436, 34083.65916340805, 34101.147471312426, 33821.66178338185, 34013.82993085019, 34219.82890085533, 34308.31383372368, 34433.655663443045, 30074.24814379658, 30392.289195174784, 30437.239069023453, 30867.382652347278, 31214.687853121177, 24197.0, 24424.0, 24665.876670616533, 24768.876155619106, 25069.87465062663], "unit": "ms", "name": "ext.html", "value": 17031.821806986583}, {"lowerIsBetter": false, "replicates": [331.069694159412, 332.1182261096789, 335.1554083709053, 335.4130272023958, 336.9022983334833, 14913.179775112365, 15237.542873713792, 15776.684466310668, 15807.367705291803, 16440.588985275375, 15401.614959625987, 15578.065316081014, 15695.37218511261, 15746.7954486372, 15906.045637261772, 4340.175366680329, 4361.389405483219, 4394.560543945596, 4423.955760442403, 4434.97782511087, 4547.45430548333, 4569.474510431293, 4573.3368661544055, 4581.129585378784, 4583.587477127058, 4557.293619488984, 4609.838655647053, 4773.379460670108, 4882.633802464829, 4892.486288939664, 4861.854144375674, 4877.634177436688, 4887.755612219393, 4897.6326775491625, 4914.852554423373, 6030.728617212236, 6283.214598175228, 6285.528585356116, 6285.748570057192, 6312.179416675849, 19156.80843191564, 19229.711554326695, 19332.32336868217, 19618.607627847363, 19692.40922772305, 1946.9610607787765, 1988.7116368126685, 2018.2431588154443, 2054.5685406064745, 2064.380685794256, 12494.058935361238, 13163.407646655924, 13420.932895335558, 13641.113327633671, 13835.169889806644, 1827.6436094961489, 1891.328578354678, 1904.6857268550673, 1908.5133291010843, 1908.8568357373113, 60501.0, 62503.93724407899, 62919.37080629181, 63434.0, 64019.6799016002, 15534.300956456986, 15603.375864965501, 15692.450764223197, 15736.842631573538, 15739.449119281, 23082.422939426313, 23351.416214594432, 23513.529729405316, 23569.646455303184, 23625.054997799896, 8590.355723320776, 8635.266002389742, 8664.220220180214, 8667.306615470747, 8762.38663293576, 7230.74692385764, 7297.416206703451, 7383.929330247084, 7451.180370159278, 7471.8505629887095, 7636.961815191, 7707.11368192665, 7772.727954521564, 7825.0, 7946.483478573874, 2974.2267010577407, 3007.578938948549, 3016.7284944355115, 3081.9213275353895, 3089.258577941278, 358.1351037245024, 358.19942428671897, 371.34828376199596, 388.3049341678421, 402.19962275072396, 9388.248940084777, 9453.52732363379, 9517.381370210915, 9872.950635246922, 9960.80078398428, 388.9241597888441, 390.98045097745, 394.0149625935162, 398.12214067980034, 407.97394552699393, 4800.639952003614, 5340.679559226459, 5411.621186516984, 5413.810516631899, 5446.128619420873, 499555.0, 511750.0, 521333.0, 540574.0, 543859.0, 70933.64533177404, 75260.0, 76278.23721762712, 77584.61207693926, 79024.60487697525, 414.5460720511036, 423.40088774384515, 434.3289617540844, 435.7124297963329, 436.91261747650594, 9340.906590934004, 9341.159295663423, 9437.433753974783, 9597.808043839224, 9623.663171788954, 33176.0, 33594.65621375118, 33643.3271334567, 34317.48523772195, 34388.0, 43360.0, 44492.77753611211, 45080.323795143755, 45375.77312113418, 46071.308930366744, 8817.559122043744, 9029.0, 9265.351425400157, 9367.765805854635, 9371.250299976122, 16238.269277882287, 16355.754663679816, 16505.092219928018, 16619.252133654256, 16751.91624041872, 13048.54330098442, 13137.868621313664, 13749.656258593615, 13812.516561920285, 13896.37466313998, 13138.277394743382, 13239.536616218385, 13294.734105318033, 13400.93299533496, 13456.730865382442, 13047.478100876238, 13968.58094257174, 14018.579442616738, 14032.78950815759, 14149.151050936976, 8548.572571371282, 8654.82690346177, 8747.562621869009, 9055.320850936074, 9063.320250981335, 13191.934040329737, 13302.46790128384, 13321.866781332063, 13851.30743462843, 14395.85604143987], "unit": "ms", "name": "jquery.html", "value": 8167.649276668906}, {"lowerIsBetter": false, "replicates": [1449.9927500362496, 1616.7170745119604, 1690.6111594333304, 1715.7169067103928, 1716.9828301716987, 6027.336992930774, 6248.125262463247, 6725.2938441463675, 6932.0, 6991.126109236346, 6790.660466976656, 6966.895496567543, 7058.717651293942, 7076.15086189658, 7085.681144348504, 1997.0913234478278, 2036.1855257896887, 2041.1529215375601, 2044.4377796106041, 2045.2228153301724, 1985.0967809646647, 2006.3278801601407, 2015.8185763281301, 2073.0360382422173, 2078.896055197242, 1998.4504261328107, 2045.826104781088, 2069.7205877206534, 2072.3057775645175, 2077.034179106715, 2023.03905644819, 2048.8873111978837, 2049.2212959075605, 2052.035543294649, 2058.938231853047, 1952.3557226115347, 1990.2735501541977, 2008.106392655269, 2012.0442789674933, 2017.0620661392377, 6957.8956315655305, 7032.648367581652, 7057.0, 7059.611721355323, 7060.117485314336, 3950.644442000234, 4027.3153563894207, 4028.798560072014, 4032.6370626643743, 4035.778032208227, 2386.140989243871, 2451.63225516174, 2689.1125928443566, 2749.1065403743864, 2761.2130542795408, 850.37497439382, 872.4590753732663, 885.4819930340758, 909.8635204719279, 914.40563633638, 8959.910400895973, 9162.26701863856, 9187.943386510504, 9240.075992400773, 9263.953680231556, 3657.7988210648136, 3708.647678470541, 3756.286305601927, 3774.8490060397826, 3783.5459744830796, 7721.884171737428, 7723.922760772432, 7768.184340644264, 7779.8833017504785, 7785.0, 4107.0, 4111.301078816608, 4116.403121547359, 4138.255114079434, 4145.2952997990415, 3789.280036793056, 3790.3556395412847, 3795.2788970095594, 3797.0, 3812.6187381262207, 3040.8327541985404, 3042.5284080967485, 3076.200187951149, 3092.412441636127, 3100.162956001912, 924.5562130177552, 945.9148676619, 952.7475219066953, 960.0351646595127, 963.9036096390305, 1122.2985633978763, 1134.0, 1144.5936692474218, 1187.352892673495, 1198.1433275208267, 6702.162229721285, 6759.763408280785, 6770.5599136056, 6774.220964589037, 6801.0, 398.0, 399.2613664720302, 402.1253773043677, 403.2258064516136, 404.7996241860239, 5188.481151884781, 5230.764615592308, 5296.417394086648, 5315.946840531546, 5322.456487618547, 7536.472446928772, 7637.961810190914, 8152.83694326122, 8186.7953301167945, 8444.0, 8287.046989596152, 8288.875666865002, 8297.087320394752, 8305.95847020761, 8307.875381869277, 6510.381513756186, 6638.070670106189, 6688.398044176048, 6737.124173857465, 6769.1876974763345, 6758.053872457762, 6763.797086087426, 6812.557183783038, 6817.181938167451, 6823.93176068233, 7485.737999170003, 7550.5469671819865, 7657.234276572298, 7664.69341226367, 7704.92295077042, 7757.65090570937, 7776.377889768692, 7908.762737117896, 7959.721409750631, 7961.124276329483, 6032.54755893301, 6117.602355846856, 6135.233095863017, 6172.259328880563, 6178.783742568989, 6882.03651488782, 6960.060391847036, 6987.161540615159, 6998.790036298919, 6999.965000174967, 6468.288488266381, 6511.609303441619, 6621.1392518972225, 6681.532292739462, 6689.130413046468, 6463.418292353711, 6476.870462590816, 6501.512386570931, 6590.308017658077, 6639.302873198245, 6568.408843204134, 6639.70121344531, 6665.133532640726, 6683.064370987969, 6694.799156025327, 5680.460356266148, 5952.642841429528, 6011.308699499614, 6015.248093988252, 6033.095035744674, 5802.216700745515, 5857.47282744555, 5863.501602363676, 5919.792807251725, 5948.078047902582], "unit": "ms", "name": "mootools.html", "value": 3936.0025970731936}, {"lowerIsBetter": false, "replicates": [287.89060157140284, 297.1783019949839, 300.8781443515377, 303.7372672638169, 304.23940149625935, 5459.454054594544, 5515.255440515529, 5515.972420137894, 5523.143912693534, 5668.546516278698, 5507.807226747064, 5527.198556209347, 5549.5837812164045, 5585.609007369486, 5595.244641973342, 4104.507459104897, 4232.682548808836, 4256.446661933945, 4271.359296105578, 4278.507971583261, 4202.2856114460465, 4232.851850185244, 4247.277962746341, 4255.234057869582, 4257.191133684605, 4197.496300443936, 4209.326507758759, 4209.768462734548, 4213.199492096492, 4226.133642603274, 4222.303319952204, 4233.068724880522, 4235.131797981422, 4245.0, 4246.957530424718, 3679.1354031802507, 3681.4845921571, 3681.650243226889, 3683.521142251517, 3688.61269566697, 5179.585633149339, 5224.268602395668, 5344.866378340534, 5346.572274218053, 5351.812686555952, 4843.321934929113, 4853.781579828881, 4857.222844344888, 4860.222364421676, 4865.6107511399005, 5827.125931110325, 5845.5908086433965, 5848.824535263949, 5849.473547380713, 5878.470937615635, 3794.0, 3945.940810887839, 3947.940780888289, 3949.624785645359, 3953.6639385652256, 6089.756409743605, 6131.325554189036, 6152.2002139722, 6153.784617538409, 6158.045502947006, 4051.756894586334, 4059.3707975263883, 4075.673946084306, 4076.6343275002614, 4090.7136500444685, 4143.751374917515, 4148.23257697327, 4148.585141485827, 4149.170165966819, 4149.91700165995, 4708.552687494683, 4798.088363210979, 4798.2802579613335, 4803.639727020487, 4809.759512024385, 5796.1595568642315, 5806.0, 5809.041508151192, 5817.88364232713, 5825.970870145622, 1450.7026059657744, 1471.1246808149135, 1471.9484818031317, 1472.1608683050558, 1479.733647943359, 953.4946478366477, 957.3250858144991, 965.3966271080575, 979.2655508368723, 987.1461186074138, 5092.10888094582, 5094.083065048327, 5102.209157580581, 5110.029094472038, 5110.156824124052, 6052.969735151384, 6064.666443345658, 6070.453659170607, 6072.815800918778, 6076.696165191723, 5083.161278389024, 5096.108181068298, 5103.744812759422, 5104.106781313255, 5109.667871588409, 3172.2862355969723, 3255.3977514159483, 3270.5421241026274, 3283.326917981808, 3290.1116698491273, 5554.50009499147, 5767.711614419346, 5775.16260142277, 5781.161731548902, 5787.5080618147085, 6099.634021958696, 6155.199824022849, 6338.524610654219, 6349.8730025400155, 6355.3009168991375, 5798.217240672455, 5804.622699524517, 5809.3609702932645, 5828.0966450200285, 5852.209951656557, 6131.386861313833, 6141.631502109888, 6142.78500252489, 6148.1699970503405, 6154.815355539341, 5765.365809761007, 5916.526677865846, 5978.491828194478, 5983.880322393441, 5993.760249589967, 5815.156802263733, 5816.1857339973285, 5829.941700583109, 5843.444872737083, 5844.912326315194, 4076.612721791425, 4123.711340206157, 4124.216398884202, 4125.071858831739, 4133.503979522477, 5983.850403739767, 6104.542159337979, 6107.144999700135, 6137.294211165773, 6137.877242455215, 5861.677607731615, 5865.0, 5891.05743081105, 5903.380145084876, 5912.142739302863, 5858.209141765978, 5883.2057672213705, 5884.735186916513, 5886.23478947734, 5895.675737834289, 5607.971960140173, 5747.7413516391025, 5751.252337196138, 5752.769889204553, 5771.220885180447, 5905.675187864536, 5905.734241959036, 5907.143464197581, 5913.46778789911, 5924.022536281465, 5746.16680581305, 5750.367459579526, 5758.856028599319, 5759.251297331488, 5768.451997060272], "unit": "ms", "name": "prototype.html", "value": 4355.176438167562}, {"lowerIsBetter": false, "replicates": [791.0823444804029, 803.3653413803094, 805.7904944714372, 813.5688085314778, 815.6003558256455, 10289.228307876901, 10517.158627309816, 10537.578496860117, 10565.049145576897, 10584.947075264623, 11944.984676302525, 11977.221480603777, 11978.341191234478, 12002.45988930498, 12050.0, 598.8832177725345, 627.1063734178799, 768.6464226455837, 818.1899919080098, 820.327331588098, 802.9879551806728, 806.0045843383417, 814.222417591199, 816.6447595296065, 818.4271010292819, 839.7816567692413, 844.7507985144397, 846.2299307630058, 847.063994286314, 852.688768599463, 834.56185502611, 837.5728378526934, 841.9031811341713, 842.4566154830131, 842.9199226073513, 625.2184769038702, 625.4683519008852, 625.5527297981919, 627.9403456671608, 628.4940622798646, 11835.171537992344, 11904.702382440422, 11945.820812687816, 11949.462274197682, 11956.043516518657, 11012.944935275273, 11151.107911367071, 11155.553777848876, 11427.0, 11508.712282192928, 9651.276154288456, 9750.561224744833, 9939.204863610894, 9959.103680668775, 10064.69805905824, 3284.917877053069, 3306.057773534555, 3321.4353559894635, 3336.5662463879785, 3409.6590340965954, 41890.999999999694, 42373.15253694909, 42390.152196956195, 42545.149097017886, 42620.147597047886, 9404.38871473352, 9495.192908602847, 9517.191038761644, 9541.0, 9692.854607180898, 16226.594335141715, 16272.43046493367, 16290.592735181715, 16297.755533667005, 16351.918240408722, 5984.132300816357, 6112.786052488142, 6152.600080994721, 6184.0, 6273.654948977759, 3569.446735755962, 3644.489771432002, 3693.575238847513, 3720.925581488355, 3737.084414318455, 2850.7576855967477, 2887.20601834493, 2887.8556072196307, 2905.622269105003, 2906.5785461108444, 498.8004798080797, 499.8900241946766, 505.05806670559144, 510.50226029620825, 511.6546331226482, 569.2457493820704, 576.1473019930443, 583.5710752596838, 608.6104892868568, 624.54720327762, 7602.391808655294, 7852.489588176751, 7891.171427000082, 8011.198880112059, 8032.357411407073, 485.7595490232287, 486.6252985201375, 585.3853453873415, 591.7573794744134, 620.7951376045894, 3717.9070523237137, 3901.2782635212575, 3949.150932549516, 4006.899827504336, 4070.531888832822, 54501.72749136229, 54561.45438545564, 54697.812087516846, 54755.0, 54851.451485485435, 48457.757711211925, 49121.0, 49266.0, 49446.752766236656, 49484.257736133986, 42488.3626745599, 42972.78513607412, 43031.13937721228, 43464.78267608705, 43924.56075439269, 8021.558814265038, 8032.3975701823765, 8147.75556733299, 8216.0, 8386.622601982803, 31154.22114447157, 31663.52504712477, 31923.68076319207, 32477.675223247465, 32677.509837351983, 39710.80144599374, 42413.36379954365, 42456.1508769829, 42534.57465425306, 42614.36078458888, 9988.05113514215, 10045.899541004497, 10096.899031009596, 10246.692599222035, 10320.587176513156, 11356.54573817038, 11479.885201148216, 11617.244879082833, 12300.077494187793, 12310.446029928853, 10654.62708805188, 10944.945275273572, 10995.065419439117, 11084.722881928017, 11302.265352752045, 10126.392416455037, 10497.47512624381, 10633.415162166155, 11164.274322169033, 11173.776524469302, 10766.515506802056, 10862.891371086187, 10907.345559266469, 11097.278676885977, 11549.249298795552, 9333.85999210026, 9399.295052870926, 9428.245740340893, 9570.377925434825, 9738.707838764849, 8883.600237989434, 8888.511131887808, 8901.109889011048, 9144.26845852317, 9184.816303674022], "unit": "ms", "name": "yui.html", "value": 5860.19422301893}], "name": "dromaeo_css", "value": 6340.9301512509455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 115.0, 111.0, 110.0, 123.0, 110.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 155.0, 164.0, 132.0, 160.0, 151.0, 134.0, 168.0, 140.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [164.0, 166.0, 162.0, 164.0, 161.0, 164.0, 172.0, 165.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 72.0, 72.0, 73.0, 132.0, 71.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 141.0, 94.0, 95.0, 96.0, 136.0, 94.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 73.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 73.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 86.0, 84.0, 85.0, 93.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 127.0, 125.0, 121.0, 132.0, 132.0, 125.0, 124.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [137.0, 137.0, 149.0, 148.0, 145.0, 138.0, 149.0, 144.0, 147.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 70.0, 71.0, 69.0, 71.0, 67.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1532.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [183.85732671446956], "unit": "score", "name": "DeltaBlue", "value": 359.615802}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Earley", "value": 944.3780709999997}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [608.272506082725], "unit": "score", "name": "Splay", "value": 133.97120400000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21354.360476525624}]} 18:52:48 INFO - RETURN: dromaeo_css: 6340.93 18:52:48 INFO - RETURN: kraken: 1532.70 18:52:48 INFO - RETURN: v8_7: 21354.36 18:52:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21354.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1532.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6340.93"}}} 18:52:48 INFO - Return code: 0 18:52:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:52:48 INFO - # TBPL SUCCESS # 18:52:48 INFO - Running post-action listener: _resource_record_post_action 18:52:48 INFO - Running post-run listener: _resource_record_post_run 18:52:49 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 147456; Write bytes: 516280320; Read time: 40; Write time: 716012 18:52:49 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 239697920; Read time: 0; Write time: 501924 18:52:49 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 147456; Write bytes: 276287488; Read time: 40; Write time: 214060 18:52:49 INFO - Running post-run listener: _upload_blobber_files 18:52:49 INFO - Blob upload gear active. 18:52:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:52:49 INFO - Copying logs to upload dir... 18:52:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.308371 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 18:52:49.626513) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 18:52:49.630511) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010022 build_url: 'https://queue.taskcluster.net/v1/task/huCfBHN4TeyFLG5HtrhfRQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 18:52:49.682746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:52:49.683128) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449108083.597081-194238147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 18:52:49.733354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 18:52:49.733701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 18:52:49.734053) ========= ========= Total master_lag: 0.61 =========