builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1449100510.94 results: success (0) buildid: 20151202150712 builduid: 467d06be68b84c64af6a239b30e30a7a revision: 661a531f5deec68b079489e3557fbb5bf57dc24b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.940051) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.940519) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.940806) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004358 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.960063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.960394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.974332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:10.974737) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.024320) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.024658) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.025011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.025281) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 15:55:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-12-02 15:55:11 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.217759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.218066) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:11.267212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 15:55:11.267566) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 661a531f5deec68b079489e3557fbb5bf57dc24b --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 661a531f5deec68b079489e3557fbb5bf57dc24b --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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 15:55:11,470 truncating revision to first 12 chars 2015-12-02 15:55:11,471 Setting DEBUG logging. 2015-12-02 15:55:11,471 attempt 1/10 2015-12-02 15:55:11,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/661a531f5dee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 15:55:12,620 unpacking tar archive at: fx-team-661a531f5dee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 15:55:12.740075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:12.740548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:12.748728) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:12.749074) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 15:55:12.749536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 15:55:12.749821) ========= /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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:55:13 INFO - MultiFileLogger online at 20151202 15:55:13 in /builds/slave/test 15:55:13 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 15:55:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:13 INFO - {'append_to_log': False, 15:55:13 INFO - 'base_work_dir': '/builds/slave/test', 15:55:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:55:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:13 INFO - 'branch': 'Fx-Team-Non-PGO', 15:55:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:13 INFO - 'config_files': ('talos/linux_config.py',), 15:55:13 INFO - 'default_actions': ('clobber', 15:55:13 INFO - 'read-buildbot-config', 15:55:13 INFO - 'download-and-extract', 15:55:13 INFO - 'populate-webroot', 15:55:13 INFO - 'create-virtualenv', 15:55:13 INFO - 'install', 15:55:13 INFO - 'run-tests'), 15:55:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:13 INFO - 'download_minidump_stackwalk': True, 15:55:13 INFO - 'download_symbols': 'ondemand', 15:55:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:55:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:55:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:55:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:55:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:13 INFO - 'installer_path': 'installer.exe', 15:55:13 INFO - 'log_level': 'info', 15:55:13 INFO - 'log_name': 'talos', 15:55:13 INFO - 'log_to_console': True, 15:55:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:55:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:55:13 INFO - 'opt_config_files': (), 15:55:13 INFO - 'pip_index': False, 15:55:13 INFO - 'sps_profile': False, 15:55:13 INFO - 'sps_profile_interval': 0, 15:55:13 INFO - 'suite': 'dromaeojs-e10s', 15:55:13 INFO - 'system_bits': '64', 15:55:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:13 INFO - 'title': 'talos-linux64-ix-044', 15:55:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:13 INFO - 'use_talos_json': True, 15:55:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:13 INFO - 'work_dir': 'build'} 15:55:13 INFO - ##### 15:55:13 INFO - ##### Running clobber step. 15:55:13 INFO - ##### 15:55:13 INFO - Running pre-action listener: _resource_record_pre_action 15:55:13 INFO - Running main action method: clobber 15:55:13 INFO - rmtree: /builds/slave/test/build 15:55:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:13 INFO - Running post-action listener: _resource_record_post_action 15:55:13 INFO - ##### 15:55:13 INFO - ##### Running read-buildbot-config step. 15:55:13 INFO - ##### 15:55:13 INFO - Running pre-action listener: _resource_record_pre_action 15:55:13 INFO - Running main action method: read_buildbot_config 15:55:13 INFO - Using buildbot properties: 15:55:13 INFO - { 15:55:13 INFO - "properties": { 15:55:13 INFO - "buildnumber": 503, 15:55:13 INFO - "product": "firefox", 15:55:13 INFO - "script_repo_revision": "production", 15:55:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:55:13 INFO - "repository": "", 15:55:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:55:13 INFO - "buildid": "20151202150712", 15:55:13 INFO - "slavename": "talos-linux64-ix-044", 15:55:13 INFO - "pgo_build": "False", 15:55:13 INFO - "basedir": "/builds/slave/test", 15:55:13 INFO - "project": "", 15:55:13 INFO - "platform": "ubuntu64_hw", 15:55:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:55:13 INFO - "slavebuilddir": "test", 15:55:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:55:13 INFO - "branch": "fx-team", 15:55:13 INFO - "repo_path": "integration/fx-team", 15:55:13 INFO - "stage_platform": "linux64", 15:55:13 INFO - "builduid": "467d06be68b84c64af6a239b30e30a7a", 15:55:13 INFO - "revision": "661a531f5deec68b079489e3557fbb5bf57dc24b" 15:55:13 INFO - }, 15:55:13 INFO - "sourcestamp": { 15:55:13 INFO - "repository": "", 15:55:13 INFO - "hasPatch": false, 15:55:13 INFO - "project": "", 15:55:13 INFO - "branch": "fx-team-linux64-talos", 15:55:13 INFO - "changes": [ 15:55:13 INFO - { 15:55:13 INFO - "category": null, 15:55:13 INFO - "files": [ 15:55:13 INFO - { 15:55:13 INFO - "url": null, 15:55:13 INFO - "name": "https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:55:13 INFO - } 15:55:13 INFO - ], 15:55:13 INFO - "repository": "", 15:55:13 INFO - "rev": "661a531f5deec68b079489e3557fbb5bf57dc24b", 15:55:13 INFO - "who": "mhammond@skippinet.com.au", 15:55:13 INFO - "when": 1449100468, 15:55:13 INFO - "number": 6735994, 15:55:13 INFO - "comments": "Bug 1201331 (part 5) - Use a new non-animated icon for the sync button. r=Gijs", 15:55:13 INFO - "project": "", 15:55:13 INFO - "at": "Wed 02 Dec 2015 15:54:28", 15:55:13 INFO - "branch": "fx-team-linux64-talos", 15:55:13 INFO - "revlink": "", 15:55:13 INFO - "properties": [ 15:55:13 INFO - [ 15:55:13 INFO - "buildid", 15:55:13 INFO - "20151202150712", 15:55:13 INFO - "Change" 15:55:13 INFO - ], 15:55:13 INFO - [ 15:55:13 INFO - "builduid", 15:55:13 INFO - "467d06be68b84c64af6a239b30e30a7a", 15:55:13 INFO - "Change" 15:55:13 INFO - ], 15:55:13 INFO - [ 15:55:13 INFO - "pgo_build", 15:55:13 INFO - "False", 15:55:13 INFO - "Change" 15:55:13 INFO - ] 15:55:13 INFO - ], 15:55:13 INFO - "revision": "661a531f5deec68b079489e3557fbb5bf57dc24b" 15:55:13 INFO - } 15:55:13 INFO - ], 15:55:13 INFO - "revision": "661a531f5deec68b079489e3557fbb5bf57dc24b" 15:55:13 INFO - } 15:55:13 INFO - } 15:55:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:55:13 INFO - Running post-action listener: _resource_record_post_action 15:55:13 INFO - ##### 15:55:13 INFO - ##### Running download-and-extract step. 15:55:13 INFO - ##### 15:55:13 INFO - Running pre-action listener: _resource_record_pre_action 15:55:13 INFO - Running main action method: download_and_extract 15:55:13 INFO - mkdir: /builds/slave/test/build/tests 15:55: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')]} 15:55:13 INFO - https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/test_packages.json 15:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/test_packages.json 15:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:55:15 INFO - Downloaded 1302 bytes. 15:55:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:55:15 INFO - Using the following test package requirements: 15:55:15 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:55:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:55:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'jsshell-linux-x86_64.zip'], 15:55:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:55:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:55:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:55:15 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:55:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:55:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:55:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:55:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:55:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:15 INFO - https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:55:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:16 INFO - Downloaded 21774978 bytes. 15:55:16 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 15:55:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:16 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 15:55:17 INFO - Return code: 0 15:55:17 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 15:55:17 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')]} 15:55:17 INFO - https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:18 INFO - Downloaded 21774978 bytes. 15:55:18 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 15:55:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:55:18 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 15:55:20 INFO - Return code: 0 15:55:20 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')]} 15:55:20 INFO - https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:55:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:55:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:55:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:21 INFO - Downloaded 11132001 bytes. 15:55:21 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 15:55:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:55:21 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 15:55:21 INFO - Return code: 0 15:55:21 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')]} 15:55:21 INFO - https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 15:55:24 INFO - Downloaded 57681368 bytes. 15:55:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:55:24 INFO - mkdir: /builds/slave/test/properties 15:55:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:55:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:55:24 INFO - Contents: 15:55:24 INFO - build_url:https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:55:24 INFO - Running post-action listener: _resource_record_post_action 15:55:24 INFO - Running post-action listener: set_extra_try_arguments 15:55:24 INFO - ##### 15:55:24 INFO - ##### Running populate-webroot step. 15:55:24 INFO - ##### 15:55:24 INFO - Running pre-action listener: _resource_record_pre_action 15:55:24 INFO - Running main action method: populate_webroot 15:55:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:55:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:55:24 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:55:24 INFO - '../fennec_ids.txt'], 15:55:24 INFO - 'tests': ['tcheck2']}, 15:55:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:55:24 INFO - '--tppagecycles', 15:55:24 INFO - '7'], 15:55:24 INFO - 'tests': ['tsvgm']}}, 15:55:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:55:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:55:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:55:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:55:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'tests': ['damp', 'tps']}, 15:55:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['damp', 'tps']}, 15:55:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:55:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:55:24 INFO - 'other': {'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'other_l64': {'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'other_nol64': {'tests': ['a11yr', 15:55:24 INFO - 'ts_paint', 15:55:24 INFO - 'tpaint', 15:55:24 INFO - 'sessionrestore', 15:55:24 INFO - 'sessionrestore_no_auto_restore']}, 15:55:24 INFO - 'svgr': {'tests': ['tsvgx', 15:55:24 INFO - 'tsvgr_opacity', 15:55:24 INFO - 'tart', 15:55:24 INFO - 'tscrollx', 15:55:24 INFO - 'cart']}, 15:55:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['tsvgx', 15:55:24 INFO - 'tsvgr_opacity', 15:55:24 INFO - 'tart', 15:55:24 INFO - 'tscrollx', 15:55:24 INFO - 'cart']}, 15:55:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'tests': ['tp5o']}, 15:55:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'talos_options': ['--e10s'], 15:55:24 INFO - 'tests': ['tp5o']}, 15:55:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'talos_options': ['--xperf_path', 15:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:24 INFO - 'tests': ['tp5n']}, 15:55:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:24 INFO - 'talos_options': ['--e10s', 15:55:24 INFO - '--xperf_path', 15:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:24 INFO - 'tests': ['tp5n']}}, 15:55:24 INFO - 'talos.zip': {'path': '', 15:55:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:55:24 INFO - Running post-action listener: _resource_record_post_action 15:55:24 INFO - ##### 15:55:24 INFO - ##### Running create-virtualenv step. 15:55:24 INFO - ##### 15:55:24 INFO - Running pre-action listener: _resource_record_pre_action 15:55:24 INFO - Running main action method: create_virtualenv 15:55:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:55:24 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 15:55:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:55:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:55:24 INFO - Using real prefix '/usr' 15:55:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:55:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:55:27 INFO - Installing pip.................done. 15:55:27 INFO - Return code: 0 15:55:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:27 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:27 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 15:55:27 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 15:55:27 INFO - Using env: {'DISPLAY': ':0', 15:55:27 INFO - 'HOME': '/home/cltbld', 15:55:27 INFO - 'LANG': 'en_US.UTF-8', 15:55:27 INFO - 'LANGUAGE': 'en_US:en', 15:55:27 INFO - 'LOGNAME': 'cltbld', 15:55:27 INFO - 'MAIL': '/var/mail/cltbld', 15:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:27 INFO - 'MOZ_NO_REMOTE': '1', 15:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:27 INFO - 'NO_EM_RESTART': '1', 15:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:27 INFO - 'PWD': '/builds/slave/test', 15:55:27 INFO - 'SHELL': '/bin/bash', 15:55:27 INFO - 'SHLVL': '1', 15:55:27 INFO - 'TERM': 'linux', 15:55:27 INFO - 'TMOUT': '86400', 15:55:27 INFO - 'USER': 'cltbld', 15:55:27 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:27 INFO - '_': '/tools/buildbot/bin/python'} 15:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:27 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 15:55:27 INFO - Cleaning up... 15:55:27 INFO - Return code: 0 15:55:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:27 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:27 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 15:55:27 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 15:55:27 INFO - Using env: {'DISPLAY': ':0', 15:55:27 INFO - 'HOME': '/home/cltbld', 15:55:27 INFO - 'LANG': 'en_US.UTF-8', 15:55:27 INFO - 'LANGUAGE': 'en_US:en', 15:55:27 INFO - 'LOGNAME': 'cltbld', 15:55:27 INFO - 'MAIL': '/var/mail/cltbld', 15:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:27 INFO - 'MOZ_NO_REMOTE': '1', 15:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:27 INFO - 'NO_EM_RESTART': '1', 15:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:27 INFO - 'PWD': '/builds/slave/test', 15:55:27 INFO - 'SHELL': '/bin/bash', 15:55:27 INFO - 'SHLVL': '1', 15:55:27 INFO - 'TERM': 'linux', 15:55:27 INFO - 'TMOUT': '86400', 15:55:27 INFO - 'USER': 'cltbld', 15:55:27 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:27 INFO - '_': '/tools/buildbot/bin/python'} 15:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:28 INFO - Downloading/unpacking psutil>=0.7.1 15:55:28 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 15:55:28 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 15:55:28 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 15:55:28 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 15:55:28 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 15:55:28 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 15:55:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:55:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:55:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:29 INFO - Installing collected packages: psutil 15:55:29 INFO - Running setup.py install for psutil 15:55:29 INFO - building 'psutil._psutil_linux' extension 15:55:29 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 15:55:30 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 15:55:30 INFO - building 'psutil._psutil_posix' extension 15:55:30 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 15:55:30 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 15:55:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:30 INFO - Successfully installed psutil 15:55:30 INFO - Cleaning up... 15:55:30 INFO - Return code: 0 15:55:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:30 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:30 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 15:55:30 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 15:55:30 INFO - Using env: {'DISPLAY': ':0', 15:55:30 INFO - 'HOME': '/home/cltbld', 15:55:30 INFO - 'LANG': 'en_US.UTF-8', 15:55:30 INFO - 'LANGUAGE': 'en_US:en', 15:55:30 INFO - 'LOGNAME': 'cltbld', 15:55:30 INFO - 'MAIL': '/var/mail/cltbld', 15:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:30 INFO - 'MOZ_NO_REMOTE': '1', 15:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:30 INFO - 'NO_EM_RESTART': '1', 15:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:30 INFO - 'PWD': '/builds/slave/test', 15:55:30 INFO - 'SHELL': '/bin/bash', 15:55:30 INFO - 'SHLVL': '1', 15:55:30 INFO - 'TERM': 'linux', 15:55:30 INFO - 'TMOUT': '86400', 15:55:30 INFO - 'USER': 'cltbld', 15:55:30 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:30 INFO - '_': '/tools/buildbot/bin/python'} 15:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:55:30 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 15:55:30 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 15:55:30 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 15:55:30 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 15:55:30 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 15:55:30 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 15:55:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:55:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:55:32 INFO - Installing collected packages: mozsystemmonitor 15:55:32 INFO - Running setup.py install for mozsystemmonitor 15:55:32 INFO - Successfully installed mozsystemmonitor 15:55:32 INFO - Cleaning up... 15:55:32 INFO - Return code: 0 15:55:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:55:32 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')]} 15:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:32 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')]} 15:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:32 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:32 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 15:55:32 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 15:55:32 INFO - Using env: {'DISPLAY': ':0', 15:55:32 INFO - 'HOME': '/home/cltbld', 15:55:32 INFO - 'LANG': 'en_US.UTF-8', 15:55:32 INFO - 'LANGUAGE': 'en_US:en', 15:55:32 INFO - 'LOGNAME': 'cltbld', 15:55:32 INFO - 'MAIL': '/var/mail/cltbld', 15:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:32 INFO - 'MOZ_NO_REMOTE': '1', 15:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:32 INFO - 'NO_EM_RESTART': '1', 15:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:32 INFO - 'PWD': '/builds/slave/test', 15:55:32 INFO - 'SHELL': '/bin/bash', 15:55:32 INFO - 'SHLVL': '1', 15:55:32 INFO - 'TERM': 'linux', 15:55:32 INFO - 'TMOUT': '86400', 15:55:32 INFO - 'USER': 'cltbld', 15:55:32 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:32 INFO - '_': '/tools/buildbot/bin/python'} 15:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:55:32 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 15:55:32 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 15:55:32 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 15:55:32 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 15:55:32 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 15:55:32 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 15:55:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:55:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:55:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:55:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:34 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 15:55:35 INFO - Downloading docopt-0.6.1.tar.gz 15:55:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:55:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:55:35 INFO - Running setup.py install for blobuploader 15:55:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:55:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:55:35 INFO - Running setup.py install for requests 15:55:35 INFO - Running setup.py install for docopt 15:55:35 INFO - Successfully installed blobuploader requests docopt 15:55:35 INFO - Cleaning up... 15:55:35 INFO - Return code: 0 15:55:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:35 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:35 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 15:55:35 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 15:55:35 INFO - Using env: {'DISPLAY': ':0', 15:55:35 INFO - 'HOME': '/home/cltbld', 15:55:35 INFO - 'LANG': 'en_US.UTF-8', 15:55:35 INFO - 'LANGUAGE': 'en_US:en', 15:55:35 INFO - 'LOGNAME': 'cltbld', 15:55:35 INFO - 'MAIL': '/var/mail/cltbld', 15:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:35 INFO - 'MOZ_NO_REMOTE': '1', 15:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:35 INFO - 'NO_EM_RESTART': '1', 15:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:35 INFO - 'PWD': '/builds/slave/test', 15:55:35 INFO - 'SHELL': '/bin/bash', 15:55:35 INFO - 'SHLVL': '1', 15:55:35 INFO - 'TERM': 'linux', 15:55:35 INFO - 'TMOUT': '86400', 15:55:35 INFO - 'USER': 'cltbld', 15:55:35 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:35 INFO - '_': '/tools/buildbot/bin/python'} 15:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:35 INFO - Running setup.py (path:/tmp/pip-urQfv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:35 INFO - Running setup.py (path:/tmp/pip-vCepO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:36 INFO - Running setup.py (path:/tmp/pip-x5aBfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:36 INFO - Running setup.py (path:/tmp/pip-xXcB4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:36 INFO - Running setup.py (path:/tmp/pip-V7Ukh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:36 INFO - Running setup.py (path:/tmp/pip-dNBcYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:36 INFO - Running setup.py (path:/tmp/pip-7cUDUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:36 INFO - Running setup.py (path:/tmp/pip-VuW9gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:36 INFO - Running setup.py (path:/tmp/pip-b3TOKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:36 INFO - Running setup.py (path:/tmp/pip-lbeZrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:36 INFO - Running setup.py (path:/tmp/pip-hZzIV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:36 INFO - Running setup.py (path:/tmp/pip-gBAQUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:36 INFO - Running setup.py (path:/tmp/pip-B8hyen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:36 INFO - Running setup.py (path:/tmp/pip-LmCvEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:36 INFO - Running setup.py (path:/tmp/pip-6w7zOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:36 INFO - Running setup.py (path:/tmp/pip-9ED_me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:37 INFO - Running setup.py (path:/tmp/pip-QpPGTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:55:37 INFO - Running setup.py install for manifestparser 15:55:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Running setup.py install for mozcrash 15:55:37 INFO - Running setup.py install for mozdebug 15:55:37 INFO - Running setup.py install for mozdevice 15:55:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Running setup.py install for mozfile 15:55:37 INFO - Running setup.py install for mozhttpd 15:55:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Running setup.py install for mozinfo 15:55:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Running setup.py install for mozInstall 15:55:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:55:37 INFO - Running setup.py install for mozleak 15:55:38 INFO - Running setup.py install for mozlog 15:55:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Running setup.py install for moznetwork 15:55:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Running setup.py install for mozprocess 15:55:38 INFO - Running setup.py install for mozprofile 15:55:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Running setup.py install for mozrunner 15:55:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Running setup.py install for mozscreenshot 15:55:38 INFO - Running setup.py install for moztest 15:55:38 INFO - Running setup.py install for mozversion 15:55:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:55:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:55:38 INFO - Cleaning up... 15:55:38 INFO - Return code: 0 15:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:38 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')]} 15:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:38 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')]} 15:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:38 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:38 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 15:55:38 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 15:55:38 INFO - Using env: {'DISPLAY': ':0', 15:55:38 INFO - 'HOME': '/home/cltbld', 15:55:38 INFO - 'LANG': 'en_US.UTF-8', 15:55:38 INFO - 'LANGUAGE': 'en_US:en', 15:55:38 INFO - 'LOGNAME': 'cltbld', 15:55:38 INFO - 'MAIL': '/var/mail/cltbld', 15:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:38 INFO - 'MOZ_NO_REMOTE': '1', 15:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:38 INFO - 'NO_EM_RESTART': '1', 15:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:38 INFO - 'PWD': '/builds/slave/test', 15:55:38 INFO - 'SHELL': '/bin/bash', 15:55:38 INFO - 'SHLVL': '1', 15:55:38 INFO - 'TERM': 'linux', 15:55:38 INFO - 'TMOUT': '86400', 15:55:38 INFO - 'USER': 'cltbld', 15:55:38 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:38 INFO - '_': '/tools/buildbot/bin/python'} 15:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:39 INFO - Running setup.py (path:/tmp/pip-9Idfy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:39 INFO - Running setup.py (path:/tmp/pip-4fi8bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:39 INFO - Running setup.py (path:/tmp/pip-qDpDsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:39 INFO - Running setup.py (path:/tmp/pip-nnDR2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:39 INFO - Running setup.py (path:/tmp/pip-9CWADR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:39 INFO - Running setup.py (path:/tmp/pip-FmtfS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:39 INFO - Running setup.py (path:/tmp/pip-a5ecwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:39 INFO - Running setup.py (path:/tmp/pip-AYEgk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:39 INFO - Running setup.py (path:/tmp/pip-eA3Rj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:39 INFO - Running setup.py (path:/tmp/pip-AEeqTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:39 INFO - Running setup.py (path:/tmp/pip-fzt7cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:39 INFO - Running setup.py (path:/tmp/pip-dRn6ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:39 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)) 15:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:39 INFO - Running setup.py (path:/tmp/pip-rWXMgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:40 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)) 15:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:40 INFO - Running setup.py (path:/tmp/pip-GK0ohA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:40 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)) 15:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:40 INFO - Running setup.py (path:/tmp/pip-x0Xh8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:40 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)) 15:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:40 INFO - Running setup.py (path:/tmp/pip-7T2bce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:40 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)) 15:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:40 INFO - Running setup.py (path:/tmp/pip-HeMmQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:40 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)) 15:55:40 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)) 15:55:40 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)) 15:55:40 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)) 15:55:40 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)) 15:55:40 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)) 15:55:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:42 INFO - Downloading blessings-1.5.1.tar.gz 15:55:42 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 15:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:55:42 INFO - Installing collected packages: blessings 15:55:42 INFO - Running setup.py install for blessings 15:55:42 INFO - Successfully installed blessings 15:55:42 INFO - Cleaning up... 15:55:42 INFO - Return code: 0 15:55:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:55:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:42 INFO - Reading from file tmpfile_stdout 15:55:42 INFO - Current package versions: 15:55:42 INFO - argparse == 1.2.1 15:55:42 INFO - blessings == 1.5.1 15:55:42 INFO - blobuploader == 1.2.4 15:55:42 INFO - docopt == 0.6.1 15:55:42 INFO - manifestparser == 1.1 15:55:42 INFO - mozInstall == 1.12 15:55:42 INFO - mozcrash == 0.16 15:55:42 INFO - mozdebug == 0.1 15:55:42 INFO - mozdevice == 0.47 15:55:42 INFO - mozfile == 1.2 15:55:42 INFO - mozhttpd == 0.7 15:55:42 INFO - mozinfo == 0.9 15:55:42 INFO - mozleak == 0.1 15:55:42 INFO - mozlog == 3.1 15:55:42 INFO - moznetwork == 0.27 15:55:42 INFO - mozprocess == 0.22 15:55:42 INFO - mozprofile == 0.27 15:55:42 INFO - mozrunner == 6.11 15:55:42 INFO - mozscreenshot == 0.1 15:55:42 INFO - mozsystemmonitor == 0.0 15:55:42 INFO - moztest == 0.7 15:55:42 INFO - mozversion == 1.4 15:55:42 INFO - psutil == 3.1.1 15:55:42 INFO - requests == 1.2.3 15:55:42 INFO - wsgiref == 0.1.2 15:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:42 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 15:55:42 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 15:55:42 INFO - Using env: {'DISPLAY': ':0', 15:55:42 INFO - 'HOME': '/home/cltbld', 15:55:42 INFO - 'LANG': 'en_US.UTF-8', 15:55:42 INFO - 'LANGUAGE': 'en_US:en', 15:55:42 INFO - 'LOGNAME': 'cltbld', 15:55:42 INFO - 'MAIL': '/var/mail/cltbld', 15:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:42 INFO - 'MOZ_NO_REMOTE': '1', 15:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:42 INFO - 'NO_EM_RESTART': '1', 15:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:42 INFO - 'PWD': '/builds/slave/test', 15:55:42 INFO - 'SHELL': '/bin/bash', 15:55:42 INFO - 'SHLVL': '1', 15:55:42 INFO - 'TERM': 'linux', 15:55:42 INFO - 'TMOUT': '86400', 15:55:42 INFO - 'USER': 'cltbld', 15:55:42 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:42 INFO - '_': '/tools/buildbot/bin/python'} 15:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 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)) 15:55:42 INFO - Cleaning up... 15:55:42 INFO - Return code: 0 15:55:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:55:42 INFO - Using env: {'DISPLAY': ':0', 15:55:42 INFO - 'HOME': '/home/cltbld', 15:55:42 INFO - 'LANG': 'en_US.UTF-8', 15:55:42 INFO - 'LANGUAGE': 'en_US:en', 15:55:42 INFO - 'LOGNAME': 'cltbld', 15:55:42 INFO - 'MAIL': '/var/mail/cltbld', 15:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:42 INFO - 'MOZ_NO_REMOTE': '1', 15:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:42 INFO - 'NO_EM_RESTART': '1', 15:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:42 INFO - 'PWD': '/builds/slave/test', 15:55:42 INFO - 'SHELL': '/bin/bash', 15:55:42 INFO - 'SHLVL': '1', 15:55:42 INFO - 'TERM': 'linux', 15:55:42 INFO - 'TMOUT': '86400', 15:55:42 INFO - 'USER': 'cltbld', 15:55:42 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:42 INFO - '_': '/tools/buildbot/bin/python'} 15:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:42 INFO - Downloading/unpacking jsonschema 15:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:55:44 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 15:55:44 INFO - Downloading/unpacking functools32 (from jsonschema) 15:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 15:55:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:55:44 INFO - warning: no files found matching '*.txt' 15:55:44 INFO - no previously-included directories found matching 'build' 15:55:44 INFO - no previously-included directories found matching 'dist' 15:55:44 INFO - no previously-included directories found matching '.git*' 15:55:44 INFO - Installing collected packages: jsonschema, functools32 15:55:44 INFO - Running setup.py install for functools32 15:55:44 INFO - warning: no files found matching '*.txt' 15:55:44 INFO - no previously-included directories found matching 'build' 15:55:44 INFO - no previously-included directories found matching 'dist' 15:55:44 INFO - no previously-included directories found matching '.git*' 15:55:44 INFO - Successfully installed jsonschema functools32 15:55:44 INFO - Cleaning up... 15:55:45 INFO - Return code: 0 15:55:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:45 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 0x7fdff8e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, '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': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', '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 15:55:45 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 15:55:45 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 15:55:45 INFO - Using env: {'DISPLAY': ':0', 15:55:45 INFO - 'HOME': '/home/cltbld', 15:55:45 INFO - 'LANG': 'en_US.UTF-8', 15:55:45 INFO - 'LANGUAGE': 'en_US:en', 15:55:45 INFO - 'LOGNAME': 'cltbld', 15:55:45 INFO - 'MAIL': '/var/mail/cltbld', 15:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:45 INFO - 'MOZ_NO_REMOTE': '1', 15:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:45 INFO - 'NO_EM_RESTART': '1', 15:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:45 INFO - 'PWD': '/builds/slave/test', 15:55:45 INFO - 'SHELL': '/bin/bash', 15:55:45 INFO - 'SHLVL': '1', 15:55:45 INFO - 'TERM': 'linux', 15:55:45 INFO - 'TMOUT': '86400', 15:55:45 INFO - 'USER': 'cltbld', 15:55:45 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:45 INFO - '_': '/tools/buildbot/bin/python'} 15:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:45 INFO - Downloading/unpacking flake8 15:55:45 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 15:55:45 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 15:55:45 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 15:55:45 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 15:55:45 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 15:55:45 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 15:55:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:55:46 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 15:55:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:55:47 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 15:55:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:47 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 15:55:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:55:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:47 INFO - no previously-included directories found matching 'docs/_build' 15:55:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:55:47 INFO - Running setup.py install for pep8 15:55:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:47 INFO - no previously-included directories found matching 'docs/_build' 15:55:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:55:47 INFO - Cleaning up... 15:55:47 INFO - Return code: 0 15:55:47 INFO - Running post-action listener: _resource_record_post_action 15:55:47 INFO - Running post-action listener: _start_resource_monitoring 15:55:47 INFO - Starting resource monitoring. 15:55:47 INFO - ##### 15:55:47 INFO - ##### Running install step. 15:55:47 INFO - ##### 15:55:47 INFO - Running pre-action listener: _resource_record_pre_action 15:55:47 INFO - Running main action method: install 15:55:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:48 INFO - Reading from file tmpfile_stdout 15:55:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:55:48 INFO - Reading from file tmpfile_stdout 15:55:48 INFO - Output received: 15:55:48 INFO - Usage: mozinstall [options] installer 15:55:48 INFO - Options: 15:55:48 INFO - -h, --help show this help message and exit 15:55:48 INFO - -d DEST, --destination=DEST 15:55:48 INFO - Directory to install application into. [default: 15:55:48 INFO - "/builds/slave/test"] 15:55:48 INFO - --app=APP Application being installed. [default: firefox] 15:55:48 INFO - mkdir: /builds/slave/test/build/application 15:55:48 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'] 15:55:48 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 15:56:02 INFO - Reading from file tmpfile_stdout 15:56:02 INFO - Output received: 15:56:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:56:02 INFO - Running post-action listener: _resource_record_post_action 15:56:02 INFO - ##### 15:56:02 INFO - ##### Running run-tests step. 15:56:02 INFO - ##### 15:56:02 INFO - Running pre-action listener: _resource_record_pre_action 15:56:02 INFO - Running main action method: run_tests 15:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:02 INFO - Python 2.7.3 15:56:02 INFO - Return code: 0 15:56:02 INFO - grabbing minidump binary from tooltool 15:56:02 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')]} 15:56:02 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 0x282e0b0>, '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 0x282efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:02 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 15:56:02 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 15:56:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:02 INFO - Return code: 0 15:56:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:56:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:56:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:56:03 INFO - Return code: 0 15:56:03 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/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test/build 15:56:03 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/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 15:56:03 INFO - Using env: {'DISPLAY': ':0', 15:56:03 INFO - 'HOME': '/home/cltbld', 15:56:03 INFO - 'LANG': 'en_US.UTF-8', 15:56:03 INFO - 'LANGUAGE': 'en_US:en', 15:56:03 INFO - 'LOGNAME': 'cltbld', 15:56:03 INFO - 'MAIL': '/var/mail/cltbld', 15:56:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:03 INFO - 'MOZ_NO_REMOTE': '1', 15:56:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:03 INFO - 'NO_EM_RESTART': '1', 15:56:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:03 INFO - 'PWD': '/builds/slave/test', 15:56:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:03 INFO - 'SHELL': '/bin/bash', 15:56:03 INFO - 'SHLVL': '1', 15:56:03 INFO - 'TERM': 'linux', 15:56:03 INFO - 'TMOUT': '86400', 15:56:03 INFO - 'USER': 'cltbld', 15:56:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558', 15:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:03 INFO - '_': '/tools/buildbot/bin/python'} 15:56:03 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/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 15:56:03 INFO - mozversion INFO | application_buildid: 20151202150712 15:56:03 INFO - mozversion INFO | application_changeset: 661a531f5deec68b079489e3557fbb5bf57dc24b 15:56:03 INFO - mozversion INFO | application_display_name: Nightly 15:56:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:03 INFO - mozversion INFO | application_name: Firefox 15:56:03 INFO - mozversion INFO | application_remotingname: firefox 15:56:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:56:03 INFO - mozversion INFO | application_vendor: Mozilla 15:56:03 INFO - mozversion INFO | application_version: 45.0a1 15:56:03 INFO - mozversion INFO | platform_buildid: 20151202150712 15:56:03 INFO - mozversion INFO | platform_changeset: 661a531f5deec68b079489e3557fbb5bf57dc24b 15:56:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:56:03 INFO - mozversion INFO | platform_version: 45.0a1 15:56:03 INFO - 2015-12-02 15:56:03,839 DEBUG : using testdate: 1449100563 15:56:03 INFO - 2015-12-02 15:56:03,839 DEBUG : actual date: 1449100563 15:56:03 INFO - 2015-12-02 15:56:03,848 INFO : starting webserver on 'localhost:43296' 15:56:03 INFO - 2015-12-02 15:56:03,849 INFO : Starting test suite talos-linux64-ix-044.e 15:56:03 INFO - 2015-12-02 15:56:03,850 INFO : Starting test dromaeo_css 15:56:03 INFO - 2015-12-02 15:56:03,850 DEBUG : operating with platform_type : linux_ 15:56:03 INFO - 2015-12-02 15:56:03,850 INFO : Initialising browser for dromaeo_css test... 15:56:03 INFO - 2015-12-02 15:56:03,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIJwWK/profile http://localhost:43296/getInfo.html 15:56:08 INFO - 2015-12-02 15:56:08,773 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:56:08 INFO - 2015-12-02 15:56:08,773 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:56:08 INFO - 2015-12-02 15:56:08,773 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:56:08 INFO - 2015-12-02 15:56:08,774 DEBUG : BROWSER_OUTPUT: __metrics 15:56:08 INFO - 2015-12-02 15:56:08,911 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] 15:56:09 INFO - 2015-12-02 15:56:09,893 INFO : Browser initialized. 15:56:09 INFO - 2015-12-02 15:56:09,893 INFO : Running cycle 1/1 for dromaeo_css test... 15:56:09 INFO - 2015-12-02 15:56:09,894 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIJwWK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:56:21 INFO - 2015-12-02 15:56:21,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 142704640 15:56:21 INFO - 2015-12-02 15:56:21,889 DEBUG : BROWSER_OUTPUT: 15:57:11 INFO - 2015-12-02 15:57:11,523 DEBUG : BROWSER_OUTPUT: 1449100631522 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] 15:59:23 INFO - 2015-12-02 15:59:23,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43296/tests/dromaeo/cssquery-ext.html) 15:59:24 INFO - 2015-12-02 15:59:24,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 146022400 15:59:24 INFO - 2015-12-02 15:59:24,408 DEBUG : BROWSER_OUTPUT: 16:02:26 INFO - 2015-12-02 16:02:26,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-ext.html (next: http://localhost:43296/tests/dromaeo/cssquery-jquery.html) 16:02:27 INFO - 2015-12-02 16:02:27,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 144367616 16:02:27 INFO - 2015-12-02 16:02:27,144 DEBUG : BROWSER_OUTPUT: 16:05:28 INFO - 2015-12-02 16:05:28,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43296/tests/dromaeo/cssquery-mootools.html) 16:05:29 INFO - 2015-12-02 16:05:29,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 146612224 16:05:29 INFO - 2015-12-02 16:05:29,565 DEBUG : BROWSER_OUTPUT: 16:08:31 INFO - 2015-12-02 16:08:31,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43296/tests/dromaeo/cssquery-prototype.html) 16:08:32 INFO - 2015-12-02 16:08:32,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 143835136 16:08:32 INFO - 2015-12-02 16:08:32,015 DEBUG : BROWSER_OUTPUT: 16:11:34 INFO - 2015-12-02 16:11:34,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43296/tests/dromaeo/cssquery-yui.html) 16:11:35 INFO - 2015-12-02 16:11:35,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 145195008 16:11:35 INFO - 2015-12-02 16:11:35,215 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/dromaeo/cssquery-yui.html (next: http://localhost:43296/tests/dromaeo/cssquery-dojo.html) 16:14:37 INFO - 2015-12-02 16:14:37,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 148131840 16:14:37 INFO - 2015-12-02 16:14:37,819 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,819 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:14:37 INFO - 2015-12-02 16:14:37,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:14:37 INFO - 2015-12-02 16:14:37,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:14:37 INFO - 2015-12-02 16:14:37,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:14:37 INFO - 2015-12-02 16:14:37,820 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2613.385854324234;2664.2806442260603;2709.2143278449253;2723.741244581764;2723.8093333466654;4470.061287129699;4730.0303437795255;4730.90538189236;4766.8093276268955;4780.426348838144;4631.258998560231;4677.438707355113;4686.320483529886;4758.095961767271;4769.499202583731;4307.741535507872;4372.12557488502;4433.623142032931;4437.778111094449;4475.127350166719;4247.872563823074;4316.6762492813;4410.250257456224;4414.205443020255;4452.532484089173;4159.8960025999595;4257.510386305553;4267.573242675739;4290.356446533029;4292.549282325342;4374.212641724488;4402.955970440286;4412.029353542215;4413.845515406977;4432.29083346663;4379.430674012358;4396.428464299621;4410.7794610269675;4417.271150260203;4441.533638967894;4420.602145806861;4504.166729155117;4559.977200114012;4659.277811939155;4688.367070445481;4997.575206107485;5008.298838162624;5035.395752509686;5045.84862454127;5079.085764562377;5072.971134317507;5086.440491545927;5089.312942752718;5092.3125378073855;5101.336826212606;4508.120916421299;4600.42494688164;4603.332516785047;4613.907721845544;4614.792334344963;5041.344625198774;5127.41034781005;5130.7947682093045;5136.2295655651205;5164.9741751291;4960.355153829979;5011.774470148779;5019.272205530251;5028.446870844205;5070.4929507049;4831.9275210871865;4936.531029552187;4988.5260900214425;5110.386753589519;5112.054269960069;5063.316452278968;5079.3650793650795;5081;5081.28861959326;5095.286659867622;5036.169032109734;5047.4952504749235;5047.949520504748;5049.697018178921;5087.949120508748;4034.3545032794614;4120.072983578671;4124.52567954683;4204.516480604709;4267.701260911706;3656.908577285589;3661.8718344857803;3680.7791532508136;3713.294474049922;3724.515812944354;4380.934285985712;4391.253486907233;4392.604665580113;4401.713888597231;4405.052913623586;4879.658423910292;5013.89972200554;5016.372953380827;5095.821646242363;5127.769250383742;4375.190589740908;4381.233284175257;4387.846425375161;4394.055278115221;4436.800343984464;4302.784860757012;4437.42313499243;4461.5092339842595;4482;4521.027978984468;4683.742394168354;4772.475027746945;4875.609951203966;4881.29221262922;4919.606431485401;5093.363329583802;5127.717975511383;5129.179331306973;5136.794528218829;5179.792808287626;4662.836800711959;4804.927926081042;4874.147024270667;4884.316195732529;4926.113299605962;4966.801327946841;4999.950000499948;5007.774650140679;5015.448300686849;5034.622403319692;5038.546530812245;5091.796328146981;5109.795608175631;5122.923156152586;5123.487651234846;4769.213079841926;4908.190148625436;4911.017796440798;4947.060058588857;4969.925451118163;4828.203346447796;4860.756962151949;4895.804167833389;4944.777485013111;4973.2540118981;4785.95214047869;4826.493218212037;4835.226363781778;4843.975780121077;4909.0672772173175;4708.081924024782;4997.650164488597;4998;5023.471133747984;5045.571126454292;4766.904661906673;4768.213244814706;4822.228443449031;4852.2479015752615;4921.9507804921495 16:14:37 INFO - 2015-12-02 16:14:37,821 DEBUG : BROWSER_OUTPUT: |1;ext.html;527.2565682387834;533.9626226164169;542.0297667175753;545.2693390856252;550.6888607936515;36037.27925441493;36612.99999999996;36733.63266367342;36838;36854.262914741725;39982.20035599286;40565;40583;40642.18715625693;40754.18491630173;7985.720499782523;8164.7550573482895;8173.264406203471;8176.836463270731;8177.264046235838;7821.76534703957;7984.720534781284;7986.560739159344;7995.320397766197;8008.079070906833;8003.839923201533;8059.476134051297;8062.556559389232;8067.112617612058;8084.676612935505;7992.480488768211;8011.118776934532;8071.798205044862;8076.071251806059;8103.95948020262;7893.447458677895;7956.801079972989;8007.519548827089;8054.476459030203;8067.072286687047;36012.819935900414;36111.097222569384;36228.45657315142;36403.81798091019;36427;2833.546632538784;3026.3947210557976;3072.4623190941497;3372.920665387077;3585.820708964541;27316.31709207266;27900.860495697594;28115;28211.435771284458;28212.07526534281;3193.425183466975;3213.550102985584;3240.9351812963846;3282.868685252587;3293.950590741141;205865;205995;206420;207441;207554.47118701696;38081;38927;51680;51830;52193;37014;37059;37139.442908356395;37204.62795372066;37248.44127338092;13059.34703264833;13404.463821447229;13423.3959471824;13461.259630720404;13489.190648560922;10420.583176672848;10432.165426765841;10450.059494645366;10491.580336786596;10516.526756295985;12965.611031669065;13500.122492037986;13504.932475337757;13549.119307245195;13691.863081369258;5478.58910581708;5553.250311207935;5557.694326812064;5653.406392328746;5691.516221121168;821.4619424277108;872.7905302727299;904.1410659873147;987.0376383026635;1001.244060734141;25366.746332536808;25561.488770224492;25782.871085644452;25797;25887.741122588533;979.2753362511833;1005.4419797012728;1069.9090577301017;1085.218642577343;1095.1895597257972;13313.467461301632;13688.384022719001;13719.931400342934;13790.793138102936;15331.770023449657;318452;318860;320762;325026;326082;45564.544354556696;46363.30455043177;46577.76711116423;46590;46617.30074048892;1214.9392530373445;1217.8721234270274;1230.0221324047225;1237.5049980007889;1243.9813402798966;26042.479150417264;26586.335341616614;26972.595411069244;27024.72975270222;27151.86424067867;38436;38977.41533876937;39168;39185.41221881731;39244.60755392409;252694;253291;254323;254404;254874;29398.706012940453;29676.40647187001;42275.3658695126;43183.35224971691;43212.567874320855;38315;38447;38696.226075478895;39104;39264.214715704955;32468.512972305907;32770.83614581912;33309.66690333065;33575.1606209837;33725.662743373236;33783.15542111467;36831.63168368389;38657.42013869851;38816.80591597024;38843.611563884;33148.33703325968;33502.49746253759;33519;37975.2404951905;38215.235695286494;28425.43149137047;29976.70023299739;30279.10183472153;30679.539806902467;30829.075127746204;24177.274681759576;24780.628290576016;25386.365340866625;26066.34834129086;27065.323366915196 16:14:37 INFO - 2015-12-02 16:14:37,823 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.9716974057205;333.90650617827004;335.37452650806256;335.43311803052836;336.6616550366882;14870.182139982297;15311.157886316249;15542.22288885557;15690.84309156908;16371.59071023225;9422.29332800041;9437.622495100188;9625.085616866403;9680.51597420128;9688.224942004623;4504.954950450495;4598.264277715566;4616.6306695464455;4618.145643056028;4620.792064357095;4533.909321813562;4833.1783596788455;4843.273508973647;4876.195427754416;4884.413870335565;3323.4682450807877;3427.1946092668327;4806.495317991613;4814.374131362935;5075.162598171316;5161.303224064741;5169.017886601571;5170.810713535889;5174.818881339153;5220.608454365919;4957.529034741694;4991.700497970097;5013.39839219296;5172.818951336722;5198.506141916512;17731.556711082198;17788;17934;18443.907780461144;18457.2617095316;1802.1079565614973;1852.9258829646799;1912.4931893048354;1975.9407217783346;1980.227711192636;12369.443375048144;12565.93717031418;12637.2417654941;12766.297853618047;12834.486620535168;1733.9653206935916;1745.894126681367;1768.4606195110487;1807.1054827860294;1815.2648177488138;55787;57863.42136578664;58410.415895840924;58514.41485585132;58984.410155898324;9314.115159059878;9538.856917146248;9771.120599145968;9777.804443911224;9801.16690081351;12275.508979640894;12307.938460307641;12314.384280786104;12325.568605098779;12339.444724987397;7117.288271172842;7152.606606636685;7162.570245785269;7189.317014883578;7200.459965502503;7036.964815175994;7065.4700897432895;7073.328033836778;7097.7160913562875;7123.145222573221;4045.8786236412957;4049.817758200888;4068.5931406859077;4100.5899410058755;4118.897027574335;1696.1010664347916;1696.2536483947024;1703.0462940753218;1736.4877361178483;1743.3375317379314;734.2657342657343;876.4697358098259;918.6509126531876;967.0088159636429;1021.6322124035341;14831.629209269639;14905.329260183318;15133;15325.632194824422;15636.140012299205;844.6368061733391;847.9830403391898;864.6022829498501;894.2041582991143;903.6340282185726;8803.735887923373;8871.645134194689;8887.822243555092;8992.730218093468;9133.588988495534;474208;482499;483262;483589;486696;66021.6698916512;68454.65772671104;69080.6545967267;69548.82707037593;69649.3035069653;991.8016396720685;997.1075887081022;998.1066945084254;1007.4207330784828;1017.97455063624;13541.661458463223;14131.304243490436;14240.216788076756;14309.499167529086;14383.065100768417;28111.297217569725;28592;31452.370952581277;31581.21046973752;32621.673783262813;37640.62359376481;38321.61678383181;38447;38883.2223355537;39182;8800.295976322006;8834.602442890215;8943.955280223558;8979.865302020344;9019.77450563715;16296.266668000206;16524.421645242357;16623.50129496117;16733.41433049886;16926.069066200984;11605.767884642091;13558.86441135576;13607.86392136066;13648.454061837812;14141.080829746033;12869.871301286867;12915.806262905877;13069.803952940523;13167.934160329138;13308.467661293827;12707.237565746085;12842.807357889453;12870.67823304425;13528.255945922676;13561.660958476117;8724.607392667218;8893.777655558662;9112.681056163003;9170.816583668156;9237.67668131639;8832.514211718417;8982.685606003759;9014.549272536478;11556.59551915679;14403.567892963229 16:14:37 INFO - 2015-12-02 16:14:37,824 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1380.4961189165945;1413.145047246416;1447;1631.2740830330501;1702.1404190883602;6272.153259309992;6439.549231553793;6857.965710171448;7404.518706284094;7436.256374362568;7052.823679408018;7151.821204469891;7239.058922340088;7243.963780181091;7268.672909719062;2081.3027635742005;2110.082114280285;2113.4610674278038;2114.8413868959815;2118.798714122156;2045.3596771949346;2083.8853863037525;2093.4766308422895;2120.1943261560587;2128.467883029243;2028.4624574487698;2035.185925629745;2058.7838276980924;2059;2063.5357044664906;2065.9070341834654;2070.9689354659617;2072.6062048210865;2086.1759604955955;2086.2906611752;2041.0815133190124;2068.503559145809;2082.135913595856;2083.4062292246635;2092.246791155183;7104.183018952784;7279.6360181990685;7307.561546307238;7321.341079302835;7345.88981165283;3605.56733192016;3671.761335513183;4125.339945608718;4210.978945105255;4211.684123690736;2664.427148163154;2702.50003749307;2712.281245469952;2713.375923537578;2713.579395193748;871.7907702151501;887.7647423432795;906.3836591118037;921.7188757428981;926.7683079230193;9851.852222216672;9864.506774661239;9908.563258327502;9917.553710082992;9983.101520863085;3847.8845634631007;3883.5922228165637;3916.138449541096;3936.547297060875;3938.6258305460933;8591.699290524926;8595.699150529701;8629.52537610425;8636.956815215884;8688.652453901774;4271.380649805823;4272.9359059614135;4304.78476076195;4312.266914624522;4314.741115533078;3871.7483363581277;3877.515310586177;3880.767153970771;3884.8446062157764;3898.142408670088;3304.1904733340007;3318.61835888871;3330.884153808453;3341.8329083546214;3343.5987681478377;1029.8146333659863;1043;1055.5408397347178;1056.8626078609884;1057.4659796802719;951.3911096897991;969.5152423788106;970.8640790289365;1042.1454407386022;1191.3447603817865;6828.0440738296675;6840.555363901331;6878.174619045746;6882.105326307548;6907.516473846883;435.16448419035527;1119.9776004479866;1138.3909608359654;1148.0930065248526;1149.1758485652517;5451.918221226685;5456.727163641802;5462.180672899097;5485.698286594195;5515.751791169407;7671.501352412075;7743.109542402583;8485.448445851123;8634.09342019079;8635.13648635144;7258.237885022102;7292.45306602007;7338.596377199306;7339.266073392725;7383.556986580822;6617.966910165418;6670.833229169212;6735.158105236846;6956.443484521226;7024.578525288499;6825.522213445011;6834.692438840165;6840.179178498413;6899.793006209822;6909.723611055702;7603.619819009138;7734.381249500139;7898.091719452336;7900.091489478554;7912.4856884302335;7916.762497125095;8083.312918402002;8097.178134919596;8144.104148543537;8202.753917382488;6934.682878476296;6958.338957799001;7021.332973367522;7023.824404389727;7100.467464940047;7058.682359293947;7062.3996960258955;7089.929100708927;7124.501284910007;7128.4653650977425;6651.933480665131;6695.531312808057;6714.429273511806;6801.489888258301;6827.93172068273;6645.534812563074;6645.966770166118;6652.800415987528;6713.932860671331;6731.091302674076;6384.042393640805;6409.583377080475;6415.807525774234;6427.614343139427;6464.870702586016;5866.6186697864505;6019.157317975574;6028.186194863637;6033.698315084316;6111.786087486917;6278.560500764903;6330.620162790247;6341.841453963688;6346.619202847844;6368.5860419072615 16:14:37 INFO - 2015-12-02 16:14:37,825 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.688477099046;304.96950304969505;307.8045441144873;308.1141717562009;310.3745951906908;5515.283013208283;5535.114381698929;5602.411746766592;5735.655860648364;5742.109972954194;5525.751341189656;5589.692566908819;5603.187537807015;5606.775728970836;5613.971930140344;4011.759294442328;4119.855805046809;4252.978735106328;4263;4296.355546667994;4197.664186865043;4274.358846173083;4288.120935208275;4301.3547967804925;4308.504521979966;4235.258829704805;4239.682023848224;4242.193983143193;4243.130158317553;4247.25673007224;4221.852235171785;4240.406343111967;4241.151769646068;4250.213710463574;4250.936235956432;3690.0774806298427;3694.261147770457;3695.2424752925585;3702.074481379655;3702.8889133326043;5228.607854410934;5265.684058956436;5290.100682883919;5290.735463226862;5298.046351656739;4848.981713840098;4850.878728031792;4853.830115945925;4854.2718592211095;4868.9269660955115;5785.247917770705;5809;5812.331581868097;5815.854603634901;5831.620944638585;3984.362501999666;3989.6608788253034;3991.501062367204;4006.358982562805;4007.1785284016705;5897.203877476529;6123.8162855114415;6143.569950103494;6150.2927163376335;6155.107509411155;4105.137921036556;4105.712600117963;4111.424400583921;4112.753234805861;4113.773742444135;4136.400221967858;4154.439150714615;4175.373693945932;4178.35235538492;4181.184668989578;4813.663043586986;4817.229243321051;4821.734804585712;4825.710457372569;4827.903441931142;5666.320041594952;5744.827655170351;5753.971230143822;5780.277465316835;5782.2483077199695;1452.201289290907;1461.3058797071305;1468.9779653305209;1478.8225412950515;1479.5857159995219;976.2287792643874;980.0836218136066;981.2003217377815;996.9551370188359;999.3004896572428;5077.619178561623;5081.517255860687;5102.387713474407;5113.590912726973;5125.308083408692;5979.252593425822;6084.452399284086;6115.541334399938;6117.204763380732;6133.6319820810895;5120.820771273062;5128.743562821844;5142.922856157161;5149.9742501287255;5162.767675454614;3268.9182770430452;3305.4215512285255;3308.8841890533718;3327.5341452196712;3332.8333583320737;5702.287214098238;5836.533077353802;5836.708164591753;5839.5036421904615;5842.357340692605;6282.623042617458;6292.842678933063;6325.746970121236;6332.461740751995;6342.587731797418;5776.595638305278;5793.565482588739;5806.564507661942;5808.738606762706;5829.912551311819;5999.3100793407575;6148.262208535004;6150.661713605795;6153.9845925421805;6168.753249869955;5930.318013428511;5942.762289508371;5948.434898684618;5960.850978725566;5971.104334349882;5781.277340332458;5803.419658034163;5816.621919575214;5821.505172060422;5823.79616713413;4231.703780735319;4278.614924656796;4295.24833154203;4297.677674174512;4302.569743025672;5968.850778730392;6071.908921366095;6078;6079.665618391031;6088.786892458743;5812.273465816773;5837.445442682938;5841.386654401226;5849.093390524476;5849.444302791228;5814.244148260699;5849.502792262705;5851.297844258546;5854.414558544111;5856.736446859816;5609.270794796814;5689.857753556194;5694.515966142924;5697.572682048946;5711.171880077449;5874.295084589877;5879.323877754113;5879.353271140257;5886.676232807236;5898.675572843363;5623.69069701154;5670.461306175906;5697.7151142443545;5711.942880571141;5727.083666613488 16:14:37 INFO - 2015-12-02 16:14:37,826 DEBUG : BROWSER_OUTPUT: |5;yui.html;756.6216891554222;761.1741260732106;769.6421164158666;795.339867909635;820.1716266570762;11103.666889993303;11288.774224515504;11358.091352691776;11359.772804543903;11413.429328533572;9276.25789936805;11201.71995700108;11342.60300889469;11419.54321827126;11444.313341199513;787.1184273613546;803.1406395157184;804.2038382001805;808.3775492870486;809.017044291186;793.6309616028545;794.0986979777936;797.4059325802257;799.5962039170211;800.3397197312212;833.9708110216144;838.7316058861167;844.7254642241265;847.8092429203441;848.3382961290204;826.8346330733877;830.5930094253803;833.6540335760652;835.2399316621845;836.5733475927291;618.3692633513836;619.7273199792122;620.199942074723;620.3796203796204;621.8538643418793;10018.148457381132;10046.89953100467;10119.544620492095;10134.797304053951;10154.746131346701;9652.22782177424;9756.853647195298;9916.157126644244;9997.80004399908;10308.226882983807;8678.86981695275;8747.693830715894;8883.958331260512;8987.775305617346;9105.817883642356;3228.322052368982;3234.1591186291735;3253.511973204015;3259.1363288728508;3305.6198537168293;36582.8170859144;37532.62467375346;37534.62465375366;37657.62342376596;38392.80803595992;8912.197902188835;8912.5669690781;9060.320475964329;9077.727668169966;9249.815003699889;15977.201139942956;16034.75947860783;16070.196490175444;16073.517794466185;16103.838961610234;6021.789237376671;6026.578139530278;6027.035674292092;6281.560290779693;6412.23053233615;3644.9635503645154;3645.453182022718;3682.5949145593963;3714.517112775322;3757.530308711411;2840.0343883079854;2900.013995241628;2900.8404537750625;2903.970960290412;2916.7083291670665;494.24380697532115;499.51047972986674;499.92001279795784;501.2631431795255;505.0857947115732;457.76196377883315;552.8617845538615;602.599271484458;605.2157693433415;637.4581605635266;7344.339009489065;7357.705691772377;7634.312911837961;7639.274268944441;7665.501742386727;580.9970950145222;586.718375179916;595.8957182493047;599.3526990849872;604.5043064687003;3571.3035957987945;3679.9080022999638;3770.057485628593;4021.2158629067053;4107.856225032109;50396.748016259684;50415.74792126016;50764.49235507598;50789.746051270246;51193.488065119614;44941.55058449439;45126.774366128615;45659.315110273375;45768.54231457709;46419.30371044437;41542;42863;43826.12347753027;44354.11291774146;44710.77644611756;7719.189485103983;7779.611019449118;8286.502809831429;8298.336133109216;8382;31393;31956.36087278288;31999.200019999687;32067.35865282728;32141.839290803397;36058.819705901304;37337.626623734504;39937.600623993385;39983;40331;9485.573149208165;9525.952370238105;10291.794164116525;10351.223658225512;10722.142228621535;9778.853317200106;9780.11978921872;9886.653967111117;9936.403815771077;10187.592496300065;10652.680419587425;10706.304090234109;10809.67570972872;10864.782704346027;11121.16591255643;9554.757881475642;9572.282078843975;9629.374090684363;9961.103500684972;10171.186305095427;10433.53049112807;10581.576736930745;10627.468626568487;10649.787004259717;10653.680389588324;8621.82756344857;8960.551972401485;9238.214751746176;9278.11857873501;9308.860367094634;8721.476711397336;8898.288136949159;8949.194572488508;9002.50486223264;9032.23226025769 16:14:37 INFO - 2015-12-02 16:14:37,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,330 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1449101677817__endTimestamp 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4663.17 Median:4785.95 stddev:492.82 (10.3%) stddev-sans-first:467.36 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: Values: 2613.4 2664.3 2709.2 2723.7 2723.8 4470.1 4730.0 4730.9 4766.8 4780.4 4631.3 4677.4 4686.3 4758.1 4769.5 4307.7 4372.1 4433.6 4437.8 4475.1 4247.9 4316.7 4410.3 4414.2 4452.5 4159.9 4257.5 4267.6 4290.4 4292.5 4374.2 4403.0 4412.0 4413.8 4432.3 4379.4 4396.4 4410.8 4417.3 4441.5 4420.6 4504.2 4560.0 4659.3 4688.4 4997.6 5008.3 5035.4 5045.8 5079.1 5073.0 5086.4 5089.3 5092.3 5101.3 4508.1 4600.4 4603.3 4613.9 4614.8 5041.3 5127.4 5130.8 5136.2 5165.0 4960.4 5011.8 5019.3 5028.4 5070.5 4831.9 4936.5 4988.5 5110.4 5112.1 5063.3 5079.4 5081.0 5081.3 5095.3 5036.2 5047.5 5047.9 5049.7 5087.9 4034.4 4120.1 4124.5 4204.5 4267.7 3656.9 3661.9 3680.8 3713.3 3724.5 4380.9 4391.3 4392.6 4401.7 4405.1 4879.7 5013.9 5016.4 5095.8 5127.8 4375.2 4381.2 4387.8 4394.1 4436.8 4302.8 4437.4 4461.5 4482.0 4521.0 4683.7 4772.5 4875.6 4881.3 4919.6 5093.4 5127.7 5129.2 5136.8 5179.8 4662.8 4804.9 4874.1 4884.3 4926.1 4966.8 5000.0 5007.8 5015.4 5034.6 5038.5 5091.8 5109.8 5122.9 5123.5 4769.2 4908.2 4911.0 4947.1 4969.9 4828.2 4860.8 4895.8 4944.8 4973.3 4786.0 4826.5 4835.2 4844.0 4909.1 4708.1 4997.7 4998.0 5023.5 5045.6 4766.9 4768.2 4822.2 4852.2 4922.0 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41389.71 Median:19799.32 stddev:69336.76 (350.2%) stddev-sans-first:69463.39 16:14:37 INFO - 2015-12-02 16:14:37,827 DEBUG : BROWSER_OUTPUT: Values: 527.3 534.0 542.0 545.3 550.7 36037.3 36613.0 36733.6 36838.0 36854.3 39982.2 40565.0 40583.0 40642.2 40754.2 7985.7 8164.8 8173.3 8176.8 8177.3 7821.8 7984.7 7986.6 7995.3 8008.1 8003.8 8059.5 8062.6 8067.1 8084.7 7992.5 8011.1 8071.8 8076.1 8104.0 7893.4 7956.8 8007.5 8054.5 8067.1 36012.8 36111.1 36228.5 36403.8 36427.0 2833.5 3026.4 3072.5 3372.9 3585.8 27316.3 27900.9 28115.0 28211.4 28212.1 3193.4 3213.6 3240.9 3282.9 3294.0 205865.0 205995.0 206420.0 207441.0 207554.5 38081.0 38927.0 51680.0 51830.0 52193.0 37014.0 37059.0 37139.4 37204.6 37248.4 13059.3 13404.5 13423.4 13461.3 13489.2 10420.6 10432.2 10450.1 10491.6 10516.5 12965.6 13500.1 13504.9 13549.1 13691.9 5478.6 5553.3 5557.7 5653.4 5691.5 821.5 872.8 904.1 987.0 1001.2 25366.7 25561.5 25782.9 25797.0 25887.7 979.3 1005.4 1069.9 1085.2 1095.2 13313.5 13688.4 13719.9 13790.8 15331.8 318452.0 318860.0 320762.0 325026.0 326082.0 45564.5 46363.3 46577.8 46590.0 46617.3 1214.9 1217.9 1230.0 1237.5 1244.0 26042.5 26586.3 26972.6 27024.7 27151.9 38436.0 38977.4 39168.0 39185.4 39244.6 252694.0 253291.0 254323.0 254404.0 254874.0 29398.7 29676.4 42275.4 43183.4 43212.6 38315.0 38447.0 38696.2 39104.0 39264.2 32468.5 32770.8 33309.7 33575.2 33725.7 33783.2 36831.6 38657.4 38816.8 38843.6 33148.3 33502.5 33519.0 37975.2 38215.2 28425.4 29976.7 30279.1 30679.5 30829.1 24177.3 24780.6 25386.4 26066.3 27065.3 16:14:37 INFO - 2015-12-02 16:14:37,828 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,829 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25801.21 Median:4109.74 stddev:78709.82 (1915.2%) stddev-sans-first:78907.39 16:14:37 INFO - 2015-12-02 16:14:37,830 DEBUG : BROWSER_OUTPUT: Values: 333.0 333.9 335.4 335.4 336.7 14870.2 15311.2 15542.2 15690.8 16371.6 9422.3 9437.6 9625.1 9680.5 9688.2 4505.0 4598.3 4616.6 4618.1 4620.8 4533.9 4833.2 4843.3 4876.2 4884.4 3323.5 3427.2 4806.5 4814.4 5075.2 5161.3 5169.0 5170.8 5174.8 5220.6 4957.5 4991.7 5013.4 5172.8 5198.5 17731.6 17788.0 17934.0 18443.9 18457.3 1802.1 1852.9 1912.5 1975.9 1980.2 12369.4 12565.9 12637.2 12766.3 12834.5 1734.0 1745.9 1768.5 1807.1 1815.3 55787.0 57863.4 58410.4 58514.4 58984.4 9314.1 9538.9 9771.1 9777.8 9801.2 12275.5 12307.9 12314.4 12325.6 12339.4 7117.3 7152.6 7162.6 7189.3 7200.5 7037.0 7065.5 7073.3 7097.7 7123.1 4045.9 4049.8 4068.6 4100.6 4118.9 1696.1 1696.3 1703.0 1736.5 1743.3 734.3 876.5 918.7 967.0 1021.6 14831.6 14905.3 15133.0 15325.6 15636.1 844.6 848.0 864.6 894.2 903.6 8803.7 8871.6 8887.8 8992.7 9133.6 474208.0 482499.0 483262.0 483589.0 486696.0 66021.7 68454.7 69080.7 69548.8 69649.3 991.8 997.1 998.1 1007.4 1018.0 13541.7 14131.3 14240.2 14309.5 14383.1 28111.3 28592.0 31452.4 31581.2 32621.7 37640.6 38321.6 38447.0 38883.2 39182.0 8800.3 8834.6 8944.0 8979.9 9019.8 16296.3 16524.4 16623.5 16733.4 16926.1 11605.8 13558.9 13607.9 13648.5 14141.1 12869.9 12915.8 13069.8 13167.9 13308.5 12707.2 12842.8 12870.7 13528.3 13561.7 8724.6 8893.8 9112.7 9170.8 9237.7 8832.5 8982.7 9014.5 11556.6 14403.6 16:14:37 INFO - 2015-12-02 16:14:37,830 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5044.09 Median:6421.71 stddev:2617.16 (40.8%) stddev-sans-first:2610.01 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: Values: 1380.5 1413.1 1447.0 1631.3 1702.1 6272.2 6439.5 6858.0 7404.5 7436.3 7052.8 7151.8 7239.1 7244.0 7268.7 2081.3 2110.1 2113.5 2114.8 2118.8 2045.4 2083.9 2093.5 2120.2 2128.5 2028.5 2035.2 2058.8 2059.0 2063.5 2065.9 2071.0 2072.6 2086.2 2086.3 2041.1 2068.5 2082.1 2083.4 2092.2 7104.2 7279.6 7307.6 7321.3 7345.9 3605.6 3671.8 4125.3 4211.0 4211.7 2664.4 2702.5 2712.3 2713.4 2713.6 871.8 887.8 906.4 921.7 926.8 9851.9 9864.5 9908.6 9917.6 9983.1 3847.9 3883.6 3916.1 3936.5 3938.6 8591.7 8595.7 8629.5 8637.0 8688.7 4271.4 4272.9 4304.8 4312.3 4314.7 3871.7 3877.5 3880.8 3884.8 3898.1 3304.2 3318.6 3330.9 3341.8 3343.6 1029.8 1043.0 1055.5 1056.9 1057.5 951.4 969.5 970.9 1042.1 1191.3 6828.0 6840.6 6878.2 6882.1 6907.5 435.2 1120.0 1138.4 1148.1 1149.2 5451.9 5456.7 5462.2 5485.7 5515.8 7671.5 7743.1 8485.4 8634.1 8635.1 7258.2 7292.5 7338.6 7339.3 7383.6 6618.0 6670.8 6735.2 6956.4 7024.6 6825.5 6834.7 6840.2 6899.8 6909.7 7603.6 7734.4 7898.1 7900.1 7912.5 7916.8 8083.3 8097.2 8144.1 8202.8 6934.7 6958.3 7021.3 7023.8 7100.5 7058.7 7062.4 7089.9 7124.5 7128.5 6651.9 6695.5 6714.4 6801.5 6827.9 6645.5 6646.0 6652.8 6713.9 6731.1 6384.0 6409.6 6415.8 6427.6 6464.9 5866.6 6019.2 6028.2 6033.7 6111.8 6278.6 6330.6 6341.8 6346.6 6368.6 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4839.19 Median:5604.98 stddev:1440.07 (25.7%) stddev-sans-first:1403.17 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: Values: 296.7 305.0 307.8 308.1 310.4 5515.3 5535.1 5602.4 5735.7 5742.1 5525.8 5589.7 5603.2 5606.8 5614.0 4011.8 4119.9 4253.0 4263.0 4296.4 4197.7 4274.4 4288.1 4301.4 4308.5 4235.3 4239.7 4242.2 4243.1 4247.3 4221.9 4240.4 4241.2 4250.2 4250.9 3690.1 3694.3 3695.2 3702.1 3702.9 5228.6 5265.7 5290.1 5290.7 5298.0 4849.0 4850.9 4853.8 4854.3 4868.9 5785.2 5809.0 5812.3 5815.9 5831.6 3984.4 3989.7 3991.5 4006.4 4007.2 5897.2 6123.8 6143.6 6150.3 6155.1 4105.1 4105.7 4111.4 4112.8 4113.8 4136.4 4154.4 4175.4 4178.4 4181.2 4813.7 4817.2 4821.7 4825.7 4827.9 5666.3 5744.8 5754.0 5780.3 5782.2 1452.2 1461.3 1469.0 1478.8 1479.6 976.2 980.1 981.2 997.0 999.3 5077.6 5081.5 5102.4 5113.6 5125.3 5979.3 6084.5 6115.5 6117.2 6133.6 5120.8 5128.7 5142.9 5150.0 5162.8 3268.9 3305.4 3308.9 3327.5 3332.8 5702.3 5836.5 5836.7 5839.5 5842.4 6282.6 6292.8 6325.7 6332.5 6342.6 5776.6 5793.6 5806.6 5808.7 5829.9 5999.3 6148.3 6150.7 6154.0 6168.8 5930.3 5942.8 5948.4 5960.9 5971.1 5781.3 5803.4 5816.6 5821.5 5823.8 4231.7 4278.6 4295.2 4297.7 4302.6 5968.9 6071.9 6078.0 6079.7 6088.8 5812.3 5837.4 5841.4 5849.1 5849.4 5814.2 5849.5 5851.3 5854.4 5856.7 5609.3 5689.9 5694.5 5697.6 5711.2 5874.3 5879.3 5879.4 5886.7 5898.7 5623.7 5670.5 5697.7 5711.9 5727.1 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: 16:14:37 INFO - 2015-12-02 16:14:37,831 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12087.38 Median:25873.17 stddev:13960.64 (54.0%) stddev-sans-first:13973.87 16:14:37 INFO - 2015-12-02 16:14:37,832 DEBUG : BROWSER_OUTPUT: Values: 756.6 761.2 769.6 795.3 820.2 11103.7 11288.8 11358.1 11359.8 11413.4 9276.3 11201.7 11342.6 11419.5 11444.3 787.1 803.1 804.2 808.4 809.0 793.6 794.1 797.4 799.6 800.3 834.0 838.7 844.7 847.8 848.3 826.8 830.6 833.7 835.2 836.6 618.4 619.7 620.2 620.4 621.9 10018.1 10046.9 10119.5 10134.8 10154.7 9652.2 9756.9 9916.2 9997.8 10308.2 8678.9 8747.7 8884.0 8987.8 9105.8 3228.3 3234.2 3253.5 3259.1 3305.6 36582.8 37532.6 37534.6 37657.6 38392.8 8912.2 8912.6 9060.3 9077.7 9249.8 15977.2 16034.8 16070.2 16073.5 16103.8 6021.8 6026.6 6027.0 6281.6 6412.2 3645.0 3645.5 3682.6 3714.5 3757.5 2840.0 2900.0 2900.8 2904.0 2916.7 494.2 499.5 499.9 501.3 505.1 457.8 552.9 602.6 605.2 637.5 7344.3 7357.7 7634.3 7639.3 7665.5 581.0 586.7 595.9 599.4 604.5 3571.3 3679.9 3770.1 4021.2 4107.9 50396.7 50415.7 50764.5 50789.7 51193.5 44941.6 45126.8 45659.3 45768.5 46419.3 41542.0 42863.0 43826.1 44354.1 44710.8 7719.2 7779.6 8286.5 8298.3 8382.0 31393.0 31956.4 31999.2 32067.4 32141.8 36058.8 37337.6 39937.6 39983.0 40331.0 9485.6 9526.0 10291.8 10351.2 10722.1 9778.9 9780.1 9886.7 9936.4 10187.6 10652.7 10706.3 10809.7 10864.8 11121.2 9554.8 9572.3 9629.4 9961.1 10171.2 10433.5 10581.6 10627.5 10649.8 10653.7 8621.8 8960.6 9238.2 9278.1 9308.9 8721.5 8898.3 8949.2 9002.5 9032.2 16:14:37 INFO - 2015-12-02 16:14:37,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:14:37 INFO - 2015-12-02 16:14:37,833 DEBUG : BROWSER_OUTPUT: 16:14:38 INFO - 2015-12-02 16:14:38,573 INFO : Browser exited with error code: 0 16:14:38 INFO - 2015-12-02 16:14:38,597 INFO : Completed test dromaeo_css (00:18:34) 16:14:38 INFO - 2015-12-02 16:14:38,597 INFO : Starting test kraken 16:14:38 INFO - 2015-12-02 16:14:38,597 DEBUG : operating with platform_type : linux_ 16:14:38 INFO - 2015-12-02 16:14:38,597 INFO : Initialising browser for kraken test... 16:14:38 INFO - 2015-12-02 16:14:38,603 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphle_f3/profile http://localhost:43296/getInfo.html 16:14:43 INFO - 2015-12-02 16:14:43,560 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:14:43 INFO - 2015-12-02 16:14:43,560 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:14:43 INFO - 2015-12-02 16:14:43,560 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:14:43 INFO - 2015-12-02 16:14:43,560 DEBUG : BROWSER_OUTPUT: __metrics 16:14:43 INFO - 2015-12-02 16:14:43,702 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:14:44 INFO - 2015-12-02 16:14:44,621 INFO : Browser initialized. 16:14:44 INFO - 2015-12-02 16:14:44,621 INFO : Running cycle 1/1 for kraken test... 16:14:44 INFO - 2015-12-02 16:14:44,622 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphle_f3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:14:56 INFO - 2015-12-02 16:14:56,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 143470592 16:14:56 INFO - 2015-12-02 16:14:56,636 DEBUG : BROWSER_OUTPUT: 16:14:59 INFO - 2015-12-02 16:14:59,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43296/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:59 INFO - 2015-12-02 16:14:59,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 145526784 16:14:59 INFO - 2015-12-02 16:14:59,834 DEBUG : BROWSER_OUTPUT: 16:15:02 INFO - 2015-12-02 16:15:02,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43296/tests/kraken/driver.html?testName=audio-dft) 16:15:03 INFO - 2015-12-02 16:15:03,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 145125376 16:15:03 INFO - 2015-12-02 16:15:03,145 DEBUG : BROWSER_OUTPUT: 16:15:06 INFO - 2015-12-02 16:15:06,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43296/tests/kraken/driver.html?testName=audio-fft) 16:15:06 INFO - 2015-12-02 16:15:06,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 138379264 16:15:06 INFO - 2015-12-02 16:15:06,638 DEBUG : BROWSER_OUTPUT: 16:15:08 INFO - 2015-12-02 16:15:08,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43296/tests/kraken/driver.html?testName=audio-oscillator) 16:15:09 INFO - 2015-12-02 16:15:09,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 16:15:09 INFO - 2015-12-02 16:15:09,310 DEBUG : BROWSER_OUTPUT: 16:15:11 INFO - 2015-12-02 16:15:11,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:12 INFO - 2015-12-02 16:15:12,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 140517376 16:15:12 INFO - 2015-12-02 16:15:12,159 DEBUG : BROWSER_OUTPUT: 16:15:15 INFO - 2015-12-02 16:15:15,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43296/tests/kraken/driver.html?testName=imaging-darkroom) 16:15:15 INFO - 2015-12-02 16:15:15,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 16:15:15 INFO - 2015-12-02 16:15:15,788 DEBUG : BROWSER_OUTPUT: 16:15:19 INFO - 2015-12-02 16:15:19,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43296/tests/kraken/driver.html?testName=imaging-desaturate) 16:15:19 INFO - 2015-12-02 16:15:19,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 16:15:19 INFO - 2015-12-02 16:15:19,877 DEBUG : BROWSER_OUTPUT: 16:15:22 INFO - 2015-12-02 16:15:22,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43296/tests/kraken/driver.html?testName=json-parse-financial) 16:15:23 INFO - 2015-12-02 16:15:23,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 16:15:23 INFO - 2015-12-02 16:15:23,409 DEBUG : BROWSER_OUTPUT: 16:15:25 INFO - 2015-12-02 16:15:25,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:15:25 INFO - 2015-12-02 16:15:25,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 140374016 16:15:25 INFO - 2015-12-02 16:15:25,765 DEBUG : BROWSER_OUTPUT: 16:15:27 INFO - 2015-12-02 16:15:27,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:15:28 INFO - 2015-12-02 16:15:28,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 140984320 16:15:28 INFO - 2015-12-02 16:15:28,279 DEBUG : BROWSER_OUTPUT: 16:15:30 INFO - 2015-12-02 16:15:30,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:15:31 INFO - 2015-12-02 16:15:31,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 141533184 16:15:31 INFO - 2015-12-02 16:15:31,045 DEBUG : BROWSER_OUTPUT: 16:15:33 INFO - 2015-12-02 16:15:33,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:15:34 INFO - 2015-12-02 16:15:34,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 16:15:34 INFO - 2015-12-02 16:15:34,259 DEBUG : BROWSER_OUTPUT: 16:15:36 INFO - 2015-12-02 16:15:36,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:15:37 INFO - 2015-12-02 16:15:37,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 16:15:37 INFO - 2015-12-02 16:15:37,506 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43296/tests/kraken/driver.html?testName=ai-astar) 16:15:39 INFO - 2015-12-02 16:15:39,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 16:15:39 INFO - 2015-12-02 16:15:39,521 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,521 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:15:39 INFO - 2015-12-02 16:15:39,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:15:39 INFO - 2015-12-02 16:15:39,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;105;113;111;114;123;113;114;112;110 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;133;162;160;131;154;153;136;169;132 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;163;164;165;173;162;165;162 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;73;73;73;136;73;79;73;73 16:15:39 INFO - 2015-12-02 16:15:39,522 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;138;95;95;94;136;94;96;131 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;150;149;148;149;147;148;147;149 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;98;96;96;96;96;97;95;96 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;73;72;73;73;72;72;72;72 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;70;69;70;69 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;83;86;86;85;84;85;83;96 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;125;136;130;125;133;135;130;130;138 16:15:39 INFO - 2015-12-02 16:15:39,523 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;149;157;159;151;153;149;147;148;159 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;71;69;71;68;69;69;72;70 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,799 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: __startTimestamp1449101739516__endTimestamp 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:15:39 INFO - 2015-12-02 16:15:39,525 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:15:39 INFO - 2015-12-02 16:15:39,525 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,525 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:4.58 (4.0%) stddev-sans-first:4.74 16:15:39 INFO - 2015-12-02 16:15:39,525 DEBUG : BROWSER_OUTPUT: Values: 116.0 105.0 113.0 111.0 114.0 123.0 113.0 114.0 112.0 110.0 16:15:39 INFO - 2015-12-02 16:15:39,526 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,526 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:157.00 stddev:15.36 (9.8%) stddev-sans-first:14.81 16:15:39 INFO - 2015-12-02 16:15:39,526 DEBUG : BROWSER_OUTPUT: Values: 168.0 133.0 162.0 160.0 131.0 154.0 153.0 136.0 169.0 132.0 16:15:39 INFO - 2015-12-02 16:15:39,526 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,527 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.43 (2.1%) stddev-sans-first:3.56 16:15:39 INFO - 2015-12-02 16:15:39,527 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 163.0 164.0 165.0 173.0 162.0 165.0 162.0 16:15:39 INFO - 2015-12-02 16:15:39,527 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,527 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:19.73 (27.0%) stddev-sans-first:20.76 16:15:39 INFO - 2015-12-02 16:15:39,528 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 73.0 73.0 73.0 136.0 73.0 79.0 73.0 73.0 16:15:39 INFO - 2015-12-02 16:15:39,528 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,528 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.50 stddev:19.54 (20.7%) stddev-sans-first:20.17 16:15:39 INFO - 2015-12-02 16:15:39,528 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 138.0 95.0 95.0 94.0 136.0 94.0 96.0 131.0 16:15:39 INFO - 2015-12-02 16:15:39,528 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,529 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:15:39 INFO - 2015-12-02 16:15:39,529 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 16:15:39 INFO - 2015-12-02 16:15:39,529 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,529 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.00 16:15:39 INFO - 2015-12-02 16:15:39,530 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 150.0 149.0 148.0 149.0 147.0 148.0 147.0 149.0 16:15:39 INFO - 2015-12-02 16:15:39,530 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,530 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 98.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:73.00 stddev:0.95 (1.3%) stddev-sans-first:0.53 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 73.0 72.0 73.0 73.0 72.0 72.0 72.0 72.0 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 70.0 69.0 16:15:39 INFO - 2015-12-02 16:15:39,531 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.95 (4.6%) stddev-sans-first:4.16 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 83.0 86.0 86.0 85.0 84.0 85.0 83.0 96.0 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:131.50 stddev:4.64 (3.5%) stddev-sans-first:4.58 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: Values: 126.0 125.0 136.0 130.0 125.0 133.0 135.0 130.0 130.0 138.0 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,532 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.00 stddev:4.71 (3.1%) stddev-sans-first:4.77 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 157.0 159.0 151.0 153.0 149.0 147.0 148.0 159.0 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 69.0 71.0 68.0 69.0 69.0 72.0 70.0 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:15:39 INFO - 2015-12-02 16:15:39,533 DEBUG : BROWSER_OUTPUT: 16:15:40 INFO - 2015-12-02 16:15:40,445 INFO : Browser exited with error code: 0 16:15:40 INFO - 2015-12-02 16:15:40,503 INFO : Completed test kraken (00:01:01) 16:15:40 INFO - 2015-12-02 16:15:40,503 INFO : Starting test v8_7 16:15:40 INFO - 2015-12-02 16:15:40,503 DEBUG : operating with platform_type : linux_ 16:15:40 INFO - 2015-12-02 16:15:40,503 INFO : Initialising browser for v8_7 test... 16:15:40 INFO - 2015-12-02 16:15:40,509 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXPi2P/profile http://localhost:43296/getInfo.html 16:15:45 INFO - 2015-12-02 16:15:45,395 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:15:45 INFO - 2015-12-02 16:15:45,395 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:15:45 INFO - 2015-12-02 16:15:45,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:15:45 INFO - 2015-12-02 16:15:45,396 DEBUG : BROWSER_OUTPUT: __metrics 16:15:45 INFO - 2015-12-02 16:15:45,533 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] 16:15:46 INFO - 2015-12-02 16:15:46,497 INFO : Browser initialized. 16:15:46 INFO - 2015-12-02 16:15:46,497 INFO : Running cycle 1/1 for v8_7 test... 16:15:46 INFO - 2015-12-02 16:15:46,498 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXPi2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:15:58 INFO - 2015-12-02 16:15:58,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 143466496 16:15:58 INFO - 2015-12-02 16:15:58,472 DEBUG : BROWSER_OUTPUT: 16:16:19 INFO - 2015-12-02 16:16:19,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43296/tests/v8_7/run.html (next: http://localhost:43296/tests/v8_7/run.html) 16:16:20 INFO - 2015-12-02 16:16:20,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 137916416 16:16:20 INFO - 2015-12-02 16:16:20,177 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,178 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:16:20 INFO - 2015-12-02 16:16:20,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:16:20 INFO - 2015-12-02 16:16:20,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:16:20 INFO - 2015-12-02 16:16:20,179 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:16:20 INFO - 2015-12-02 16:16:20,179 DEBUG : BROWSER_OUTPUT: |0;Richards;167.11229946524065 16:16:20 INFO - 2015-12-02 16:16:20,179 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.945441094877 16:16:20 INFO - 2015-12-02 16:16:20,179 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 16:16:20 INFO - 2015-12-02 16:16:20,179 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5268.421052631579 16:16:20 INFO - 2015-12-02 16:16:20,180 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1094.0919037199126 16:16:20 INFO - 2015-12-02 16:16:20,180 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 16:16:20 INFO - 2015-12-02 16:16:20,180 DEBUG : BROWSER_OUTPUT: |6;Boyer;12650 16:16:20 INFO - 2015-12-02 16:16:20,180 DEBUG : BROWSER_OUTPUT: |7;RegExp;25600 16:16:20 INFO - 2015-12-02 16:16:20,181 DEBUG : BROWSER_OUTPUT: |8;Splay;1285.3470437017995 16:16:20 INFO - 2015-12-02 16:16:20,181 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 16:16:20 INFO - 2015-12-02 16:16:20,181 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:16:20 INFO - 2015-12-02 16:16:20,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1449101780177__endTimestamp 16:16:20 INFO - 2015-12-02 16:16:20,182 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,182 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:16:20 INFO - 2015-12-02 16:16:20,182 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:16:20 INFO - 2015-12-02 16:16:20,183 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,183 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.11 Median:167.11 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,183 DEBUG : BROWSER_OUTPUT: Values: 167.1 16:16:20 INFO - 2015-12-02 16:16:20,183 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,184 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.95 Median:184.95 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,184 DEBUG : BROWSER_OUTPUT: Values: 184.9 16:16:20 INFO - 2015-12-02 16:16:20,184 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,185 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: Values: 279.2 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: Values: 5268.4 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,186 DEBUG : BROWSER_OUTPUT: Values: 1094.1 16:16:20 INFO - 2015-12-02 16:16:20,187 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,187 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,187 DEBUG : BROWSER_OUTPUT: Values: 721.0 16:16:20 INFO - 2015-12-02 16:16:20,187 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,187 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12650.00 Median:12650.00 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: Values: 12650.0 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25600.00 Median:25600.00 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: Values: 25600.0 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1285.35 Median:1285.35 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: Values: 1285.3 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: 16:16:20 INFO - 2015-12-02 16:16:20,188 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:16:20 INFO - 2015-12-02 16:16:20,189 DEBUG : BROWSER_OUTPUT: Values: 4845.4 16:16:20 INFO - 2015-12-02 16:16:20,189 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:16:20 INFO - 2015-12-02 16:16:20,189 DEBUG : BROWSER_OUTPUT: 16:16:21 INFO - 2015-12-02 16:16:21,121 INFO : Browser exited with error code: 0 16:16:21 INFO - 2015-12-02 16:16:21,135 INFO : Completed test v8_7 (00:00:40) 16:16:21 INFO - 2015-12-02 16:16:21,176 INFO : Completed test suite (00:20:17) 16:16:21 INFO - 2015-12-02 16:16:21,177 DEBUG : Working with test: dromaeo_css 16:16:21 INFO - 2015-12-02 16:16:21,177 DEBUG : Generating results file: dromaeo_css 16:16:21 INFO - 2015-12-02 16:16:21,178 DEBUG : Working with test: kraken 16:16:21 INFO - 2015-12-02 16:16:21,178 DEBUG : Generating results file: kraken 16:16:21 INFO - 2015-12-02 16:16:21,178 INFO : javascript benchmark 16:16:21 INFO - 2015-12-02 16:16:21,178 DEBUG : Working with test: v8_7 16:16:21 INFO - 2015-12-02 16:16:21,178 DEBUG : Generating results file: v8_7 16:16:21 INFO - 2015-12-02 16:16:21,179 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:16:21 INFO - 2015-12-02 16:16:21,233 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:16:21 INFO - 2015-12-02 16:16:21,234 DEBUG : process_Request line: dromaeo_css 6315.02 graph.html#tests=[[72,132,43]] 16:16:21 INFO - 2015-12-02 16:16:21,234 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:16:21 INFO - 2015-12-02 16:16:21,265 DEBUG : process_Request line: kraken 1548.60 graph.html#tests=[[232,132,43]] 16:16:21 INFO - 2015-12-02 16:16:21,265 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:16:21 INFO - 2015-12-02 16:16:21,296 DEBUG : process_Request line: v8_7 19668.77 graph.html#tests=[[230,132,43]] 16:16:21 INFO - 2015-12-02 16:16:21,297 INFO : javascript benchmark 16:16:21 INFO - 2015-12-02 16:16:21,301 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.385854324234, 2664.2806442260603, 2709.2143278449253, 2723.741244581764, 2723.8093333466654, 4470.061287129699, 4730.0303437795255, 4730.90538189236, 4766.8093276268955, 4780.426348838144, 4631.258998560231, 4677.438707355113, 4686.320483529886, 4758.095961767271, 4769.499202583731, 4307.741535507872, 4372.12557488502, 4433.623142032931, 4437.778111094449, 4475.127350166719, 4247.872563823074, 4316.6762492813, 4410.250257456224, 4414.205443020255, 4452.532484089173, 4159.8960025999595, 4257.510386305553, 4267.573242675739, 4290.356446533029, 4292.549282325342, 4374.212641724488, 4402.955970440286, 4412.029353542215, 4413.845515406977, 4432.29083346663, 4379.430674012358, 4396.428464299621, 4410.7794610269675, 4417.271150260203, 4441.533638967894, 4420.602145806861, 4504.166729155117, 4559.977200114012, 4659.277811939155, 4688.367070445481, 4997.575206107485, 5008.298838162624, 5035.395752509686, 5045.84862454127, 5079.085764562377, 5072.971134317507, 5086.440491545927, 5089.312942752718, 5092.3125378073855, 5101.336826212606, 4508.120916421299, 4600.42494688164, 4603.332516785047, 4613.907721845544, 4614.792334344963, 5041.344625198774, 5127.41034781005, 5130.7947682093045, 5136.2295655651205, 5164.9741751291, 4960.355153829979, 5011.774470148779, 5019.272205530251, 5028.446870844205, 5070.4929507049, 4831.9275210871865, 4936.531029552187, 4988.5260900214425, 5110.386753589519, 5112.054269960069, 5063.316452278968, 5079.3650793650795, 5081.0, 5081.28861959326, 5095.286659867622, 5036.169032109734, 5047.4952504749235, 5047.949520504748, 5049.697018178921, 5087.949120508748, 4034.3545032794614, 4120.072983578671, 4124.52567954683, 4204.516480604709, 4267.701260911706, 3656.908577285589, 3661.8718344857803, 3680.7791532508136, 3713.294474049922, 3724.515812944354, 4380.934285985712, 4391.253486907233, 4392.604665580113, 4401.713888597231, 4405.052913623586, 4879.658423910292, 5013.89972200554, 5016.372953380827, 5095.821646242363, 5127.769250383742, 4375.190589740908, 4381.233284175257, 4387.846425375161, 4394.055278115221, 4436.800343984464, 4302.784860757012, 4437.42313499243, 4461.5092339842595, 4482.0, 4521.027978984468, 4683.742394168354, 4772.475027746945, 4875.609951203966, 4881.29221262922, 4919.606431485401, 5093.363329583802, 5127.717975511383, 5129.179331306973, 5136.794528218829, 5179.792808287626, 4662.836800711959, 4804.927926081042, 4874.147024270667, 4884.316195732529, 4926.113299605962, 4966.801327946841, 4999.950000499948, 5007.774650140679, 5015.448300686849, 5034.622403319692, 5038.546530812245, 5091.796328146981, 5109.795608175631, 5122.923156152586, 5123.487651234846, 4769.213079841926, 4908.190148625436, 4911.017796440798, 4947.060058588857, 4969.925451118163, 4828.203346447796, 4860.756962151949, 4895.804167833389, 4944.777485013111, 4973.2540118981, 4785.95214047869, 4826.493218212037, 4835.226363781778, 4843.975780121077, 4909.0672772173175, 4708.081924024782, 4997.650164488597, 4998.0, 5023.471133747984, 5045.571126454292, 4766.904661906673, 4768.213244814706, 4822.228443449031, 4852.2479015752615, 4921.9507804921495], "unit": "ms", "name": "dojo.html", "value": 4632.139525222575}, {"lowerIsBetter": false, "replicates": [527.2565682387834, 533.9626226164169, 542.0297667175753, 545.2693390856252, 550.6888607936515, 36037.27925441493, 36612.99999999996, 36733.63266367342, 36838.0, 36854.262914741725, 39982.20035599286, 40565.0, 40583.0, 40642.18715625693, 40754.18491630173, 7985.720499782523, 8164.7550573482895, 8173.264406203471, 8176.836463270731, 8177.264046235838, 7821.76534703957, 7984.720534781284, 7986.560739159344, 7995.320397766197, 8008.079070906833, 8003.839923201533, 8059.476134051297, 8062.556559389232, 8067.112617612058, 8084.676612935505, 7992.480488768211, 8011.118776934532, 8071.798205044862, 8076.071251806059, 8103.95948020262, 7893.447458677895, 7956.801079972989, 8007.519548827089, 8054.476459030203, 8067.072286687047, 36012.819935900414, 36111.097222569384, 36228.45657315142, 36403.81798091019, 36427.0, 2833.546632538784, 3026.3947210557976, 3072.4623190941497, 3372.920665387077, 3585.820708964541, 27316.31709207266, 27900.860495697594, 28115.0, 28211.435771284458, 28212.07526534281, 3193.425183466975, 3213.550102985584, 3240.9351812963846, 3282.868685252587, 3293.950590741141, 205865.0, 205995.0, 206420.0, 207441.0, 207554.47118701696, 38081.0, 38927.0, 51680.0, 51830.0, 52193.0, 37014.0, 37059.0, 37139.442908356395, 37204.62795372066, 37248.44127338092, 13059.34703264833, 13404.463821447229, 13423.3959471824, 13461.259630720404, 13489.190648560922, 10420.583176672848, 10432.165426765841, 10450.059494645366, 10491.580336786596, 10516.526756295985, 12965.611031669065, 13500.122492037986, 13504.932475337757, 13549.119307245195, 13691.863081369258, 5478.58910581708, 5553.250311207935, 5557.694326812064, 5653.406392328746, 5691.516221121168, 821.4619424277108, 872.7905302727299, 904.1410659873147, 987.0376383026635, 1001.244060734141, 25366.746332536808, 25561.488770224492, 25782.871085644452, 25797.0, 25887.741122588533, 979.2753362511833, 1005.4419797012728, 1069.9090577301017, 1085.218642577343, 1095.1895597257972, 13313.467461301632, 13688.384022719001, 13719.931400342934, 13790.793138102936, 15331.770023449657, 318452.0, 318860.0, 320762.0, 325026.0, 326082.0, 45564.544354556696, 46363.30455043177, 46577.76711116423, 46590.0, 46617.30074048892, 1214.9392530373445, 1217.8721234270274, 1230.0221324047225, 1237.5049980007889, 1243.9813402798966, 26042.479150417264, 26586.335341616614, 26972.595411069244, 27024.72975270222, 27151.86424067867, 38436.0, 38977.41533876937, 39168.0, 39185.41221881731, 39244.60755392409, 252694.0, 253291.0, 254323.0, 254404.0, 254874.0, 29398.706012940453, 29676.40647187001, 42275.3658695126, 43183.35224971691, 43212.567874320855, 38315.0, 38447.0, 38696.226075478895, 39104.0, 39264.214715704955, 32468.512972305907, 32770.83614581912, 33309.66690333065, 33575.1606209837, 33725.662743373236, 33783.15542111467, 36831.63168368389, 38657.42013869851, 38816.80591597024, 38843.611563884, 33148.33703325968, 33502.49746253759, 33519.0, 37975.2404951905, 38215.235695286494, 28425.43149137047, 29976.70023299739, 30279.10183472153, 30679.539806902467, 30829.075127746204, 24177.274681759576, 24780.628290576016, 25386.365340866625, 26066.34834129086, 27065.323366915196], "unit": "ms", "name": "ext.html", "value": 16613.190651043784}, {"lowerIsBetter": false, "replicates": [332.9716974057205, 333.90650617827004, 335.37452650806256, 335.43311803052836, 336.6616550366882, 14870.182139982297, 15311.157886316249, 15542.22288885557, 15690.84309156908, 16371.59071023225, 9422.29332800041, 9437.622495100188, 9625.085616866403, 9680.51597420128, 9688.224942004623, 4504.954950450495, 4598.264277715566, 4616.6306695464455, 4618.145643056028, 4620.792064357095, 4533.909321813562, 4833.1783596788455, 4843.273508973647, 4876.195427754416, 4884.413870335565, 3323.4682450807877, 3427.1946092668327, 4806.495317991613, 4814.374131362935, 5075.162598171316, 5161.303224064741, 5169.017886601571, 5170.810713535889, 5174.818881339153, 5220.608454365919, 4957.529034741694, 4991.700497970097, 5013.39839219296, 5172.818951336722, 5198.506141916512, 17731.556711082198, 17788.0, 17934.0, 18443.907780461144, 18457.2617095316, 1802.1079565614973, 1852.9258829646799, 1912.4931893048354, 1975.9407217783346, 1980.227711192636, 12369.443375048144, 12565.93717031418, 12637.2417654941, 12766.297853618047, 12834.486620535168, 1733.9653206935916, 1745.894126681367, 1768.4606195110487, 1807.1054827860294, 1815.2648177488138, 55787.0, 57863.42136578664, 58410.415895840924, 58514.41485585132, 58984.410155898324, 9314.115159059878, 9538.856917146248, 9771.120599145968, 9777.804443911224, 9801.16690081351, 12275.508979640894, 12307.938460307641, 12314.384280786104, 12325.568605098779, 12339.444724987397, 7117.288271172842, 7152.606606636685, 7162.570245785269, 7189.317014883578, 7200.459965502503, 7036.964815175994, 7065.4700897432895, 7073.328033836778, 7097.7160913562875, 7123.145222573221, 4045.8786236412957, 4049.817758200888, 4068.5931406859077, 4100.5899410058755, 4118.897027574335, 1696.1010664347916, 1696.2536483947024, 1703.0462940753218, 1736.4877361178483, 1743.3375317379314, 734.2657342657343, 876.4697358098259, 918.6509126531876, 967.0088159636429, 1021.6322124035341, 14831.629209269639, 14905.329260183318, 15133.0, 15325.632194824422, 15636.140012299205, 844.6368061733391, 847.9830403391898, 864.6022829498501, 894.2041582991143, 903.6340282185726, 8803.735887923373, 8871.645134194689, 8887.822243555092, 8992.730218093468, 9133.588988495534, 474208.0, 482499.0, 483262.0, 483589.0, 486696.0, 66021.6698916512, 68454.65772671104, 69080.6545967267, 69548.82707037593, 69649.3035069653, 991.8016396720685, 997.1075887081022, 998.1066945084254, 1007.4207330784828, 1017.97455063624, 13541.661458463223, 14131.304243490436, 14240.216788076756, 14309.499167529086, 14383.065100768417, 28111.297217569725, 28592.0, 31452.370952581277, 31581.21046973752, 32621.673783262813, 37640.62359376481, 38321.61678383181, 38447.0, 38883.2223355537, 39182.0, 8800.295976322006, 8834.602442890215, 8943.955280223558, 8979.865302020344, 9019.77450563715, 16296.266668000206, 16524.421645242357, 16623.50129496117, 16733.41433049886, 16926.069066200984, 11605.767884642091, 13558.86441135576, 13607.86392136066, 13648.454061837812, 14141.080829746033, 12869.871301286867, 12915.806262905877, 13069.803952940523, 13167.934160329138, 13308.467661293827, 12707.237565746085, 12842.807357889453, 12870.67823304425, 13528.255945922676, 13561.660958476117, 8724.607392667218, 8893.777655558662, 9112.681056163003, 9170.816583668156, 9237.67668131639, 8832.514211718417, 8982.685606003759, 9014.549272536478, 11556.59551915679, 14403.567892963229], "unit": "ms", "name": "jquery.html", "value": 8068.32419406169}, {"lowerIsBetter": false, "replicates": [1380.4961189165945, 1413.145047246416, 1447.0, 1631.2740830330501, 1702.1404190883602, 6272.153259309992, 6439.549231553793, 6857.965710171448, 7404.518706284094, 7436.256374362568, 7052.823679408018, 7151.821204469891, 7239.058922340088, 7243.963780181091, 7268.672909719062, 2081.3027635742005, 2110.082114280285, 2113.4610674278038, 2114.8413868959815, 2118.798714122156, 2045.3596771949346, 2083.8853863037525, 2093.4766308422895, 2120.1943261560587, 2128.467883029243, 2028.4624574487698, 2035.185925629745, 2058.7838276980924, 2059.0, 2063.5357044664906, 2065.9070341834654, 2070.9689354659617, 2072.6062048210865, 2086.1759604955955, 2086.2906611752, 2041.0815133190124, 2068.503559145809, 2082.135913595856, 2083.4062292246635, 2092.246791155183, 7104.183018952784, 7279.6360181990685, 7307.561546307238, 7321.341079302835, 7345.88981165283, 3605.56733192016, 3671.761335513183, 4125.339945608718, 4210.978945105255, 4211.684123690736, 2664.427148163154, 2702.50003749307, 2712.281245469952, 2713.375923537578, 2713.579395193748, 871.7907702151501, 887.7647423432795, 906.3836591118037, 921.7188757428981, 926.7683079230193, 9851.852222216672, 9864.506774661239, 9908.563258327502, 9917.553710082992, 9983.101520863085, 3847.8845634631007, 3883.5922228165637, 3916.138449541096, 3936.547297060875, 3938.6258305460933, 8591.699290524926, 8595.699150529701, 8629.52537610425, 8636.956815215884, 8688.652453901774, 4271.380649805823, 4272.9359059614135, 4304.78476076195, 4312.266914624522, 4314.741115533078, 3871.7483363581277, 3877.515310586177, 3880.767153970771, 3884.8446062157764, 3898.142408670088, 3304.1904733340007, 3318.61835888871, 3330.884153808453, 3341.8329083546214, 3343.5987681478377, 1029.8146333659863, 1043.0, 1055.5408397347178, 1056.8626078609884, 1057.4659796802719, 951.3911096897991, 969.5152423788106, 970.8640790289365, 1042.1454407386022, 1191.3447603817865, 6828.0440738296675, 6840.555363901331, 6878.174619045746, 6882.105326307548, 6907.516473846883, 435.16448419035527, 1119.9776004479866, 1138.3909608359654, 1148.0930065248526, 1149.1758485652517, 5451.918221226685, 5456.727163641802, 5462.180672899097, 5485.698286594195, 5515.751791169407, 7671.501352412075, 7743.109542402583, 8485.448445851123, 8634.09342019079, 8635.13648635144, 7258.237885022102, 7292.45306602007, 7338.596377199306, 7339.266073392725, 7383.556986580822, 6617.966910165418, 6670.833229169212, 6735.158105236846, 6956.443484521226, 7024.578525288499, 6825.522213445011, 6834.692438840165, 6840.179178498413, 6899.793006209822, 6909.723611055702, 7603.619819009138, 7734.381249500139, 7898.091719452336, 7900.091489478554, 7912.4856884302335, 7916.762497125095, 8083.312918402002, 8097.178134919596, 8144.104148543537, 8202.753917382488, 6934.682878476296, 6958.338957799001, 7021.332973367522, 7023.824404389727, 7100.467464940047, 7058.682359293947, 7062.3996960258955, 7089.929100708927, 7124.501284910007, 7128.4653650977425, 6651.933480665131, 6695.531312808057, 6714.429273511806, 6801.489888258301, 6827.93172068273, 6645.534812563074, 6645.966770166118, 6652.800415987528, 6713.932860671331, 6731.091302674076, 6384.042393640805, 6409.583377080475, 6415.807525774234, 6427.614343139427, 6464.870702586016, 5866.6186697864505, 6019.157317975574, 6028.186194863637, 6033.698315084316, 6111.786087486917, 6278.560500764903, 6330.620162790247, 6341.841453963688, 6346.619202847844, 6368.5860419072615], "unit": "ms", "name": "mootools.html", "value": 4130.074000538347}, {"lowerIsBetter": false, "replicates": [296.688477099046, 304.96950304969505, 307.8045441144873, 308.1141717562009, 310.3745951906908, 5515.283013208283, 5535.114381698929, 5602.411746766592, 5735.655860648364, 5742.109972954194, 5525.751341189656, 5589.692566908819, 5603.187537807015, 5606.775728970836, 5613.971930140344, 4011.759294442328, 4119.855805046809, 4252.978735106328, 4263.0, 4296.355546667994, 4197.664186865043, 4274.358846173083, 4288.120935208275, 4301.3547967804925, 4308.504521979966, 4235.258829704805, 4239.682023848224, 4242.193983143193, 4243.130158317553, 4247.25673007224, 4221.852235171785, 4240.406343111967, 4241.151769646068, 4250.213710463574, 4250.936235956432, 3690.0774806298427, 3694.261147770457, 3695.2424752925585, 3702.074481379655, 3702.8889133326043, 5228.607854410934, 5265.684058956436, 5290.100682883919, 5290.735463226862, 5298.046351656739, 4848.981713840098, 4850.878728031792, 4853.830115945925, 4854.2718592211095, 4868.9269660955115, 5785.247917770705, 5809.0, 5812.331581868097, 5815.854603634901, 5831.620944638585, 3984.362501999666, 3989.6608788253034, 3991.501062367204, 4006.358982562805, 4007.1785284016705, 5897.203877476529, 6123.8162855114415, 6143.569950103494, 6150.2927163376335, 6155.107509411155, 4105.137921036556, 4105.712600117963, 4111.424400583921, 4112.753234805861, 4113.773742444135, 4136.400221967858, 4154.439150714615, 4175.373693945932, 4178.35235538492, 4181.184668989578, 4813.663043586986, 4817.229243321051, 4821.734804585712, 4825.710457372569, 4827.903441931142, 5666.320041594952, 5744.827655170351, 5753.971230143822, 5780.277465316835, 5782.2483077199695, 1452.201289290907, 1461.3058797071305, 1468.9779653305209, 1478.8225412950515, 1479.5857159995219, 976.2287792643874, 980.0836218136066, 981.2003217377815, 996.9551370188359, 999.3004896572428, 5077.619178561623, 5081.517255860687, 5102.387713474407, 5113.590912726973, 5125.308083408692, 5979.252593425822, 6084.452399284086, 6115.541334399938, 6117.204763380732, 6133.6319820810895, 5120.820771273062, 5128.743562821844, 5142.922856157161, 5149.9742501287255, 5162.767675454614, 3268.9182770430452, 3305.4215512285255, 3308.8841890533718, 3327.5341452196712, 3332.8333583320737, 5702.287214098238, 5836.533077353802, 5836.708164591753, 5839.5036421904615, 5842.357340692605, 6282.623042617458, 6292.842678933063, 6325.746970121236, 6332.461740751995, 6342.587731797418, 5776.595638305278, 5793.565482588739, 5806.564507661942, 5808.738606762706, 5829.912551311819, 5999.3100793407575, 6148.262208535004, 6150.661713605795, 6153.9845925421805, 6168.753249869955, 5930.318013428511, 5942.762289508371, 5948.434898684618, 5960.850978725566, 5971.104334349882, 5781.277340332458, 5803.419658034163, 5816.621919575214, 5821.505172060422, 5823.79616713413, 4231.703780735319, 4278.614924656796, 4295.24833154203, 4297.677674174512, 4302.569743025672, 5968.850778730392, 6071.908921366095, 6078.0, 6079.665618391031, 6088.786892458743, 5812.273465816773, 5837.445442682938, 5841.386654401226, 5849.093390524476, 5849.444302791228, 5814.244148260699, 5849.502792262705, 5851.297844258546, 5854.414558544111, 5856.736446859816, 5609.270794796814, 5689.857753556194, 5694.515966142924, 5697.572682048946, 5711.171880077449, 5874.295084589877, 5879.323877754113, 5879.353271140257, 5886.676232807236, 5898.675572843363, 5623.69069701154, 5670.461306175906, 5697.7151142443545, 5711.942880571141, 5727.083666613488], "unit": "ms", "name": "prototype.html", "value": 4370.271800276482}, {"lowerIsBetter": false, "replicates": [756.6216891554222, 761.1741260732106, 769.6421164158666, 795.339867909635, 820.1716266570762, 11103.666889993303, 11288.774224515504, 11358.091352691776, 11359.772804543903, 11413.429328533572, 9276.25789936805, 11201.71995700108, 11342.60300889469, 11419.54321827126, 11444.313341199513, 787.1184273613546, 803.1406395157184, 804.2038382001805, 808.3775492870486, 809.017044291186, 793.6309616028545, 794.0986979777936, 797.4059325802257, 799.5962039170211, 800.3397197312212, 833.9708110216144, 838.7316058861167, 844.7254642241265, 847.8092429203441, 848.3382961290204, 826.8346330733877, 830.5930094253803, 833.6540335760652, 835.2399316621845, 836.5733475927291, 618.3692633513836, 619.7273199792122, 620.199942074723, 620.3796203796204, 621.8538643418793, 10018.148457381132, 10046.89953100467, 10119.544620492095, 10134.797304053951, 10154.746131346701, 9652.22782177424, 9756.853647195298, 9916.157126644244, 9997.80004399908, 10308.226882983807, 8678.86981695275, 8747.693830715894, 8883.958331260512, 8987.775305617346, 9105.817883642356, 3228.322052368982, 3234.1591186291735, 3253.511973204015, 3259.1363288728508, 3305.6198537168293, 36582.8170859144, 37532.62467375346, 37534.62465375366, 37657.62342376596, 38392.80803595992, 8912.197902188835, 8912.5669690781, 9060.320475964329, 9077.727668169966, 9249.815003699889, 15977.201139942956, 16034.75947860783, 16070.196490175444, 16073.517794466185, 16103.838961610234, 6021.789237376671, 6026.578139530278, 6027.035674292092, 6281.560290779693, 6412.23053233615, 3644.9635503645154, 3645.453182022718, 3682.5949145593963, 3714.517112775322, 3757.530308711411, 2840.0343883079854, 2900.013995241628, 2900.8404537750625, 2903.970960290412, 2916.7083291670665, 494.24380697532115, 499.51047972986674, 499.92001279795784, 501.2631431795255, 505.0857947115732, 457.76196377883315, 552.8617845538615, 602.599271484458, 605.2157693433415, 637.4581605635266, 7344.339009489065, 7357.705691772377, 7634.312911837961, 7639.274268944441, 7665.501742386727, 580.9970950145222, 586.718375179916, 595.8957182493047, 599.3526990849872, 604.5043064687003, 3571.3035957987945, 3679.9080022999638, 3770.057485628593, 4021.2158629067053, 4107.856225032109, 50396.748016259684, 50415.74792126016, 50764.49235507598, 50789.746051270246, 51193.488065119614, 44941.55058449439, 45126.774366128615, 45659.315110273375, 45768.54231457709, 46419.30371044437, 41542.0, 42863.0, 43826.12347753027, 44354.11291774146, 44710.77644611756, 7719.189485103983, 7779.611019449118, 8286.502809831429, 8298.336133109216, 8382.0, 31393.0, 31956.36087278288, 31999.200019999687, 32067.35865282728, 32141.839290803397, 36058.819705901304, 37337.626623734504, 39937.600623993385, 39983.0, 40331.0, 9485.573149208165, 9525.952370238105, 10291.794164116525, 10351.223658225512, 10722.142228621535, 9778.853317200106, 9780.11978921872, 9886.653967111117, 9936.403815771077, 10187.592496300065, 10652.680419587425, 10706.304090234109, 10809.67570972872, 10864.782704346027, 11121.16591255643, 9554.757881475642, 9572.282078843975, 9629.374090684363, 9961.103500684972, 10171.186305095427, 10433.53049112807, 10581.576736930745, 10627.468626568487, 10649.787004259717, 10653.680389588324, 8621.82756344857, 8960.551972401485, 9238.214751746176, 9278.11857873501, 9308.860367094634, 8721.476711397336, 8898.288136949159, 8949.194572488508, 9002.50486223264, 9032.23226025769], "unit": "ms", "name": "yui.html", "value": 5658.763796862427}], "name": "dromaeo_css", "value": 6315.019627259865}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 105.0, 113.0, 111.0, 114.0, 123.0, 113.0, 114.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [168.0, 133.0, 162.0, 160.0, 131.0, 154.0, 153.0, 136.0, 169.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 163.0, 164.0, 165.0, 173.0, 162.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 73.0, 73.0, 136.0, 73.0, 79.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 95.0, 95.0, 94.0, 136.0, 94.0, 96.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 150.0, 149.0, 148.0, 149.0, 147.0, 148.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 72.0, 73.0, 73.0, 72.0, 72.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 86.0, 86.0, 85.0, 84.0, 85.0, 83.0, 96.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 136.0, 130.0, 125.0, 133.0, 135.0, 130.0, 130.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.8}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 157.0, 159.0, 151.0, 153.0, 149.0, 147.0, 148.0, 159.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 69.0, 71.0, 68.0, 69.0, 69.0, 72.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1548.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.11229946524065], "unit": "score", "name": "Richards", "value": 211.24716800000004}, {"lowerIsBetter": false, "replicates": [184.945441094877], "unit": "score", "name": "DeltaBlue", "value": 357.50002600000005}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [720.9805335255949], "unit": "score", "name": "Earley", "value": 924.3841810000001}, {"lowerIsBetter": false, "replicates": [12650.0], "unit": "score", "name": "Boyer", "value": 52.684822134387325}, {"lowerIsBetter": false, "replicates": [25600.0], "unit": "score", "name": "RegExp", "value": 35.58535156250002}, {"lowerIsBetter": false, "replicates": [1285.3470437017995], "unit": "score", "name": "Splay", "value": 63.399998}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19668.768800336366}]} 16:16:21 INFO - RETURN: dromaeo_css: 6315.02 16:16:21 INFO - RETURN: kraken: 1548.60 16:16:21 INFO - RETURN: v8_7: 19668.77 16:16:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "19668.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6315.02"}}} 16:16:21 INFO - Return code: 0 16:16:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:16:21 INFO - # TBPL SUCCESS # 16:16:21 INFO - Running post-action listener: _resource_record_post_action 16:16:21 INFO - Running post-run listener: _resource_record_post_run 16:16:22 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505602048; Read time: 36; Write time: 494872 16:16:22 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237731840; Read time: 0; Write time: 284764 16:16:22 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 267870208; Read time: 36; Write time: 210108 16:16:22 INFO - Running post-run listener: _upload_blobber_files 16:16:22 INFO - Blob upload gear active. 16:16:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:16:22 INFO - Copying logs to upload dir... 16:16:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.652252 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 16:16:22.408976) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 16:16:22.412885) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009896 build_url: 'https://queue.taskcluster.net/v1/task/qsUtBXsKS1eyf6esFCRPOQ/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 16:16:22.464878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:16:22.465211) ========= 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=0cff312cb257a7829adc5a5d000001df-1449100510.436268-1130787558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:16:22.516426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 16:16:22.517097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 16:16:22.517731) ========= ========= Total master_lag: 0.21 =========