builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1449855792.28 results: success (0) buildid: 20151211083202 builduid: e69bdc5b86cb46699cff39c07c3c6e2b revision: c56806034eda39d8275a071152eb2704411906a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.278220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.278691) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.279010) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006306 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.305083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.305354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.322026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.322290) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.371967) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.372232) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.372579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.372852) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 09:43:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-11 09:43:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.579367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.579683) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:12.629242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 09:43:12.629592) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c56806034eda39d8275a071152eb2704411906a9 --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 c56806034eda39d8275a071152eb2704411906a9 --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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 09:43:13,836 truncating revision to first 12 chars 2015-12-11 09:43:13,836 Setting DEBUG logging. 2015-12-11 09:43:13,837 attempt 1/10 2015-12-11 09:43:13,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c56806034eda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 09:43:15,037 unpacking tar archive at: fx-team-c56806034eda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.518083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 09:43:14.160277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:14.160608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:14.169338) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:14.169632) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:43:14.170058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-11 09:43:14.170346) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:15 INFO - MultiFileLogger online at 20151211 09:43:15 in /builds/slave/test 09:43:15 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 09:43:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:15 INFO - {'append_to_log': False, 09:43:15 INFO - 'base_work_dir': '/builds/slave/test', 09:43:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:43:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:15 INFO - 'branch': 'Fx-Team-Non-PGO', 09:43:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:15 INFO - 'config_files': ('talos/linux_config.py',), 09:43:15 INFO - 'default_actions': ('clobber', 09:43:15 INFO - 'read-buildbot-config', 09:43:15 INFO - 'download-and-extract', 09:43:15 INFO - 'populate-webroot', 09:43:15 INFO - 'create-virtualenv', 09:43:15 INFO - 'install', 09:43:15 INFO - 'run-tests'), 09:43:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:15 INFO - 'download_minidump_stackwalk': True, 09:43:15 INFO - 'download_symbols': 'ondemand', 09:43:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:15 INFO - 'installer_path': 'installer.exe', 09:43:15 INFO - 'log_level': 'info', 09:43:15 INFO - 'log_name': 'talos', 09:43:15 INFO - 'log_to_console': True, 09:43:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:15 INFO - 'opt_config_files': (), 09:43:15 INFO - 'pip_index': False, 09:43:15 INFO - 'sps_profile': False, 09:43:15 INFO - 'sps_profile_interval': 0, 09:43:15 INFO - 'suite': 'dromaeojs-e10s', 09:43:15 INFO - 'system_bits': '64', 09:43:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:15 INFO - 'title': 'talos-linux64-ix-010', 09:43:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:15 INFO - 'use_talos_json': True, 09:43:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:15 INFO - 'work_dir': 'build'} 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running clobber step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: clobber 09:43:15 INFO - rmtree: /builds/slave/test/build 09:43:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:15 INFO - Running post-action listener: _resource_record_post_action 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running read-buildbot-config step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: read_buildbot_config 09:43:15 INFO - Using buildbot properties: 09:43:15 INFO - { 09:43:15 INFO - "properties": { 09:43:15 INFO - "buildnumber": 567, 09:43:15 INFO - "product": "firefox", 09:43:15 INFO - "script_repo_revision": "production", 09:43:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:43:15 INFO - "repository": "", 09:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:43:15 INFO - "buildid": "20151211083202", 09:43:15 INFO - "slavename": "talos-linux64-ix-010", 09:43:15 INFO - "pgo_build": "False", 09:43:15 INFO - "basedir": "/builds/slave/test", 09:43:15 INFO - "project": "", 09:43:15 INFO - "platform": "ubuntu64_hw", 09:43:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:43:15 INFO - "slavebuilddir": "test", 09:43:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:43:15 INFO - "branch": "fx-team", 09:43:15 INFO - "repo_path": "integration/fx-team", 09:43:15 INFO - "stage_platform": "linux64", 09:43:15 INFO - "builduid": "e69bdc5b86cb46699cff39c07c3c6e2b", 09:43:15 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:43:15 INFO - }, 09:43:15 INFO - "sourcestamp": { 09:43:15 INFO - "repository": "", 09:43:15 INFO - "hasPatch": false, 09:43:15 INFO - "project": "", 09:43:15 INFO - "branch": "fx-team-linux64-talos", 09:43:15 INFO - "changes": [ 09:43:15 INFO - { 09:43:15 INFO - "category": null, 09:43:15 INFO - "files": [ 09:43:15 INFO - { 09:43:15 INFO - "url": null, 09:43:15 INFO - "name": "https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:43:15 INFO - } 09:43:15 INFO - ], 09:43:15 INFO - "repository": "", 09:43:15 INFO - "rev": "c56806034eda39d8275a071152eb2704411906a9", 09:43:15 INFO - "who": "maglione.k@gmail.com", 09:43:15 INFO - "when": 1449855743, 09:43:15 INFO - "number": 7350103, 09:43:15 INFO - "comments": "Bug 1231827: Fix ESLint regressions in toolkit/components/extensions. r=trivial", 09:43:15 INFO - "project": "", 09:43:15 INFO - "at": "Fri 11 Dec 2015 09:42:23", 09:43:15 INFO - "branch": "fx-team-linux64-talos", 09:43:15 INFO - "revlink": "", 09:43:15 INFO - "properties": [ 09:43:15 INFO - [ 09:43:15 INFO - "buildid", 09:43:15 INFO - "20151211083202", 09:43:15 INFO - "Change" 09:43:15 INFO - ], 09:43:15 INFO - [ 09:43:15 INFO - "builduid", 09:43:15 INFO - "e69bdc5b86cb46699cff39c07c3c6e2b", 09:43:15 INFO - "Change" 09:43:15 INFO - ], 09:43:15 INFO - [ 09:43:15 INFO - "pgo_build", 09:43:15 INFO - "False", 09:43:15 INFO - "Change" 09:43:15 INFO - ] 09:43:15 INFO - ], 09:43:15 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:43:15 INFO - } 09:43:15 INFO - ], 09:43:15 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:43:15 INFO - } 09:43:15 INFO - } 09:43:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:43:15 INFO - Running post-action listener: _resource_record_post_action 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running download-and-extract step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: download_and_extract 09:43:15 INFO - mkdir: /builds/slave/test/build/tests 09:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:15 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json 09:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json 09:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:43:16 INFO - Downloaded 1302 bytes. 09:43:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:43:16 INFO - Using the following test package requirements: 09:43:16 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:16 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:16 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'jsshell-linux-x86_64.zip'], 09:43:16 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:16 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:16 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:43:16 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:43:16 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:16 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:16 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:16 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:16 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:17 INFO - Downloaded 21874385 bytes. 09:43:17 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 09:43:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:17 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 09:43:19 INFO - Return code: 0 09:43:19 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 09:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:19 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:21 INFO - Downloaded 21874385 bytes. 09:43:21 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 09:43:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:21 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 09:43:22 INFO - Return code: 0 09:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:22 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:23 INFO - Downloaded 11132038 bytes. 09:43:23 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 09:43:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:23 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 09:43:24 INFO - Return code: 0 09:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:24 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:25 INFO - Downloaded 57727543 bytes. 09:43:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:25 INFO - mkdir: /builds/slave/test/properties 09:43:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:25 INFO - Contents: 09:43:25 INFO - build_url:https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:25 INFO - Running post-action listener: _resource_record_post_action 09:43:25 INFO - Running post-action listener: set_extra_try_arguments 09:43:25 INFO - ##### 09:43:25 INFO - ##### Running populate-webroot step. 09:43:25 INFO - ##### 09:43:25 INFO - Running pre-action listener: _resource_record_pre_action 09:43:25 INFO - Running main action method: populate_webroot 09:43:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:25 INFO - '--tppagecycles', 09:43:25 INFO - '7'], 09:43:25 INFO - 'tests': ['tsvgm']}}, 09:43:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:43:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'tests': ['damp', 'tps']}, 09:43:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['damp', 'tps']}, 09:43:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:43:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:25 INFO - 'other': {'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'other_l64': {'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'other_nol64': {'tests': ['a11yr', 09:43:25 INFO - 'ts_paint', 09:43:25 INFO - 'tpaint', 09:43:25 INFO - 'sessionrestore', 09:43:25 INFO - 'sessionrestore_no_auto_restore']}, 09:43:25 INFO - 'svgr': {'tests': ['tsvgx', 09:43:25 INFO - 'tsvgr_opacity', 09:43:25 INFO - 'tart', 09:43:25 INFO - 'tscrollx', 09:43:25 INFO - 'cart']}, 09:43:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['tsvgx', 09:43:25 INFO - 'tsvgr_opacity', 09:43:25 INFO - 'tart', 09:43:25 INFO - 'tscrollx', 09:43:25 INFO - 'cart']}, 09:43:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'tests': ['tp5o']}, 09:43:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'talos_options': ['--e10s'], 09:43:25 INFO - 'tests': ['tp5o']}, 09:43:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'talos_options': ['--xperf_path', 09:43:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:25 INFO - 'tests': ['tp5n']}, 09:43:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:25 INFO - 'talos_options': ['--e10s', 09:43:25 INFO - '--xperf_path', 09:43:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:25 INFO - 'tests': ['tp5n']}}, 09:43:25 INFO - 'talos.zip': {'path': '', 09:43:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:25 INFO - Running post-action listener: _resource_record_post_action 09:43:25 INFO - ##### 09:43:25 INFO - ##### Running create-virtualenv step. 09:43:25 INFO - ##### 09:43:25 INFO - Running pre-action listener: _resource_record_pre_action 09:43:25 INFO - Running main action method: create_virtualenv 09:43:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:43:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:25 INFO - Using real prefix '/usr' 09:43:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:27 INFO - Installing pip.................done. 09:43:27 INFO - Return code: 0 09:43:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:27 INFO - Using env: {'DISPLAY': ':0', 09:43:27 INFO - 'HOME': '/home/cltbld', 09:43:27 INFO - 'LANG': 'en_US.UTF-8', 09:43:27 INFO - 'LANGUAGE': 'en_US:en', 09:43:27 INFO - 'LOGNAME': 'cltbld', 09:43:27 INFO - 'MAIL': '/var/mail/cltbld', 09:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:27 INFO - 'MOZ_NO_REMOTE': '1', 09:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:27 INFO - 'NO_EM_RESTART': '1', 09:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:27 INFO - 'PWD': '/builds/slave/test', 09:43:27 INFO - 'SHELL': '/bin/bash', 09:43:27 INFO - 'SHLVL': '1', 09:43:27 INFO - 'TERM': 'linux', 09:43:27 INFO - 'TMOUT': '86400', 09:43:27 INFO - 'USER': 'cltbld', 09:43:27 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:27 INFO - '_': '/tools/buildbot/bin/python'} 09:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:43:28 INFO - Cleaning up... 09:43:28 INFO - Return code: 0 09:43:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:28 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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:43:28 INFO - Using env: {'DISPLAY': ':0', 09:43:28 INFO - 'HOME': '/home/cltbld', 09:43:28 INFO - 'LANG': 'en_US.UTF-8', 09:43:28 INFO - 'LANGUAGE': 'en_US:en', 09:43:28 INFO - 'LOGNAME': 'cltbld', 09:43:28 INFO - 'MAIL': '/var/mail/cltbld', 09:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:28 INFO - 'MOZ_NO_REMOTE': '1', 09:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:28 INFO - 'NO_EM_RESTART': '1', 09:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:28 INFO - 'PWD': '/builds/slave/test', 09:43:28 INFO - 'SHELL': '/bin/bash', 09:43:28 INFO - 'SHLVL': '1', 09:43:28 INFO - 'TERM': 'linux', 09:43:28 INFO - 'TMOUT': '86400', 09:43:28 INFO - 'USER': 'cltbld', 09:43:28 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:28 INFO - '_': '/tools/buildbot/bin/python'} 09:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:28 INFO - Downloading/unpacking psutil>=0.7.1 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:43:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:30 INFO - Installing collected packages: psutil 09:43:30 INFO - Running setup.py install for psutil 09:43:30 INFO - building 'psutil._psutil_linux' extension 09:43:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:43: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 09:43:30 INFO - building 'psutil._psutil_posix' extension 09:43: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 09:43: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 09:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:30 INFO - Successfully installed psutil 09:43:30 INFO - Cleaning up... 09:43:30 INFO - Return code: 0 09:43:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:30 INFO - Using env: {'DISPLAY': ':0', 09:43:30 INFO - 'HOME': '/home/cltbld', 09:43:30 INFO - 'LANG': 'en_US.UTF-8', 09:43:30 INFO - 'LANGUAGE': 'en_US:en', 09:43:30 INFO - 'LOGNAME': 'cltbld', 09:43:30 INFO - 'MAIL': '/var/mail/cltbld', 09:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:30 INFO - 'MOZ_NO_REMOTE': '1', 09:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:30 INFO - 'NO_EM_RESTART': '1', 09:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:30 INFO - 'PWD': '/builds/slave/test', 09:43:30 INFO - 'SHELL': '/bin/bash', 09:43:30 INFO - 'SHLVL': '1', 09:43:30 INFO - 'TERM': 'linux', 09:43:30 INFO - 'TMOUT': '86400', 09:43:30 INFO - 'USER': 'cltbld', 09:43:30 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:30 INFO - '_': '/tools/buildbot/bin/python'} 09:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43: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) 09:43:32 INFO - Installing collected packages: mozsystemmonitor 09:43:32 INFO - Running setup.py install for mozsystemmonitor 09:43:32 INFO - Successfully installed mozsystemmonitor 09:43:32 INFO - Cleaning up... 09:43:32 INFO - Return code: 0 09:43:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:32 INFO - Using env: {'DISPLAY': ':0', 09:43:32 INFO - 'HOME': '/home/cltbld', 09:43:32 INFO - 'LANG': 'en_US.UTF-8', 09:43:32 INFO - 'LANGUAGE': 'en_US:en', 09:43:32 INFO - 'LOGNAME': 'cltbld', 09:43:32 INFO - 'MAIL': '/var/mail/cltbld', 09:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:32 INFO - 'MOZ_NO_REMOTE': '1', 09:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:32 INFO - 'NO_EM_RESTART': '1', 09:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:32 INFO - 'PWD': '/builds/slave/test', 09:43:32 INFO - 'SHELL': '/bin/bash', 09:43:32 INFO - 'SHLVL': '1', 09:43:32 INFO - 'TERM': 'linux', 09:43:32 INFO - 'TMOUT': '86400', 09:43:32 INFO - 'USER': 'cltbld', 09:43:32 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:32 INFO - '_': '/tools/buildbot/bin/python'} 09:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:43:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:35 INFO - Downloading docopt-0.6.1.tar.gz 09:43:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:35 INFO - Running setup.py install for blobuploader 09:43:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:43:35 INFO - Running setup.py install for requests 09:43:35 INFO - Running setup.py install for docopt 09:43:35 INFO - Successfully installed blobuploader requests docopt 09:43:35 INFO - Cleaning up... 09:43:35 INFO - Return code: 0 09:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:35 INFO - Using env: {'DISPLAY': ':0', 09:43:35 INFO - 'HOME': '/home/cltbld', 09:43:35 INFO - 'LANG': 'en_US.UTF-8', 09:43:35 INFO - 'LANGUAGE': 'en_US:en', 09:43:35 INFO - 'LOGNAME': 'cltbld', 09:43:35 INFO - 'MAIL': '/var/mail/cltbld', 09:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:35 INFO - 'MOZ_NO_REMOTE': '1', 09:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:35 INFO - 'NO_EM_RESTART': '1', 09:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:35 INFO - 'PWD': '/builds/slave/test', 09:43:35 INFO - 'SHELL': '/bin/bash', 09:43:35 INFO - 'SHLVL': '1', 09:43:35 INFO - 'TERM': 'linux', 09:43:35 INFO - 'TMOUT': '86400', 09:43:35 INFO - 'USER': 'cltbld', 09:43:35 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:35 INFO - '_': '/tools/buildbot/bin/python'} 09:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:36 INFO - Running setup.py (path:/tmp/pip-0oCGxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:36 INFO - Running setup.py (path:/tmp/pip-EMtrQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:36 INFO - Running setup.py (path:/tmp/pip-Hu5fer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:36 INFO - Running setup.py (path:/tmp/pip-R7xCuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:36 INFO - Running setup.py (path:/tmp/pip-rhAVVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:36 INFO - Running setup.py (path:/tmp/pip-xNG7dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:36 INFO - Running setup.py (path:/tmp/pip-AM_STQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:36 INFO - Running setup.py (path:/tmp/pip-rhPPnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:36 INFO - Running setup.py (path:/tmp/pip-SdgMnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:36 INFO - Running setup.py (path:/tmp/pip-Au30QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:36 INFO - Running setup.py (path:/tmp/pip-kyaCQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:36 INFO - Running setup.py (path:/tmp/pip-IEQIDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:37 INFO - Running setup.py (path:/tmp/pip-_Wjtbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:37 INFO - Running setup.py (path:/tmp/pip-FzVnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:37 INFO - Running setup.py (path:/tmp/pip-dF7SEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:37 INFO - Running setup.py (path:/tmp/pip-v7AjeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:37 INFO - Running setup.py (path:/tmp/pip-fFNLlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:37 INFO - Running setup.py install for manifestparser 09:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:43:37 INFO - Running setup.py install for mozcrash 09:43:37 INFO - Running setup.py install for mozdebug 09:43:37 INFO - Running setup.py install for mozdevice 09:43:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:43:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:43:37 INFO - Running setup.py install for mozfile 09:43:37 INFO - Running setup.py install for mozhttpd 09:43:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozinfo 09:43:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozInstall 09:43:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozleak 09:43:38 INFO - Running setup.py install for mozlog 09:43:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for moznetwork 09:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozprocess 09:43:38 INFO - Running setup.py install for mozprofile 09:43:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozrunner 09:43:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozscreenshot 09:43:38 INFO - Running setup.py install for moztest 09:43:39 INFO - Running setup.py install for mozversion 09:43:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:39 INFO - Cleaning up... 09:43:39 INFO - Return code: 0 09:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:39 INFO - Using env: {'DISPLAY': ':0', 09:43:39 INFO - 'HOME': '/home/cltbld', 09:43:39 INFO - 'LANG': 'en_US.UTF-8', 09:43:39 INFO - 'LANGUAGE': 'en_US:en', 09:43:39 INFO - 'LOGNAME': 'cltbld', 09:43:39 INFO - 'MAIL': '/var/mail/cltbld', 09:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:39 INFO - 'MOZ_NO_REMOTE': '1', 09:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:39 INFO - 'NO_EM_RESTART': '1', 09:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:39 INFO - 'PWD': '/builds/slave/test', 09:43:39 INFO - 'SHELL': '/bin/bash', 09:43:39 INFO - 'SHLVL': '1', 09:43:39 INFO - 'TERM': 'linux', 09:43:39 INFO - 'TMOUT': '86400', 09:43:39 INFO - 'USER': 'cltbld', 09:43:39 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:39 INFO - '_': '/tools/buildbot/bin/python'} 09:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:39 INFO - Running setup.py (path:/tmp/pip-usN8mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:39 INFO - Running setup.py (path:/tmp/pip-28IqI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:39 INFO - Running setup.py (path:/tmp/pip-_P7KSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:39 INFO - Running setup.py (path:/tmp/pip-0wmWGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:39 INFO - Running setup.py (path:/tmp/pip-1yuraq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:39 INFO - Running setup.py (path:/tmp/pip-fULg2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:39 INFO - Running setup.py (path:/tmp/pip-9FXncP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43: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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:39 INFO - Running setup.py (path:/tmp/pip-LHxKlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:40 INFO - Running setup.py (path:/tmp/pip-jDtVxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:40 INFO - Running setup.py (path:/tmp/pip-zRAYJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:40 INFO - Running setup.py (path:/tmp/pip-c0X76T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:40 INFO - Running setup.py (path:/tmp/pip-OvKSrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:40 INFO - Running setup.py (path:/tmp/pip-bwJFk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43: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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:40 INFO - Running setup.py (path:/tmp/pip-qnQLQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43: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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:40 INFO - Running setup.py (path:/tmp/pip-tS5MfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43: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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:40 INFO - Running setup.py (path:/tmp/pip-fTf3io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43: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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:40 INFO - Running setup.py (path:/tmp/pip-mgL3uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43: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)) 09:43: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)) 09:43: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)) 09:43: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)) 09:43: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)) 09:43: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)) 09:43:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:42 INFO - Downloading blessings-1.5.1.tar.gz 09:43: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 09:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:42 INFO - Installing collected packages: blessings 09:43:42 INFO - Running setup.py install for blessings 09:43:42 INFO - Successfully installed blessings 09:43:42 INFO - Cleaning up... 09:43:42 INFO - Return code: 0 09:43:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:42 INFO - Reading from file tmpfile_stdout 09:43:42 INFO - Current package versions: 09:43:42 INFO - argparse == 1.2.1 09:43:42 INFO - blessings == 1.5.1 09:43:42 INFO - blobuploader == 1.2.4 09:43:42 INFO - docopt == 0.6.1 09:43:42 INFO - manifestparser == 1.1 09:43:42 INFO - mozInstall == 1.12 09:43:42 INFO - mozcrash == 0.16 09:43:42 INFO - mozdebug == 0.1 09:43:42 INFO - mozdevice == 0.47 09:43:42 INFO - mozfile == 1.2 09:43:42 INFO - mozhttpd == 0.7 09:43:42 INFO - mozinfo == 0.9 09:43:42 INFO - mozleak == 0.1 09:43:42 INFO - mozlog == 3.1 09:43:42 INFO - moznetwork == 0.27 09:43:42 INFO - mozprocess == 0.22 09:43:42 INFO - mozprofile == 0.27 09:43:42 INFO - mozrunner == 6.11 09:43:42 INFO - mozscreenshot == 0.1 09:43:42 INFO - mozsystemmonitor == 0.0 09:43:42 INFO - moztest == 0.7 09:43:42 INFO - mozversion == 1.4 09:43:42 INFO - psutil == 3.1.1 09:43:42 INFO - requests == 1.2.3 09:43:42 INFO - wsgiref == 0.1.2 09:43:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:42 INFO - Using env: {'DISPLAY': ':0', 09:43:42 INFO - 'HOME': '/home/cltbld', 09:43:42 INFO - 'LANG': 'en_US.UTF-8', 09:43:42 INFO - 'LANGUAGE': 'en_US:en', 09:43:42 INFO - 'LOGNAME': 'cltbld', 09:43:42 INFO - 'MAIL': '/var/mail/cltbld', 09:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:42 INFO - 'MOZ_NO_REMOTE': '1', 09:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:42 INFO - 'NO_EM_RESTART': '1', 09:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:42 INFO - 'PWD': '/builds/slave/test', 09:43:42 INFO - 'SHELL': '/bin/bash', 09:43:42 INFO - 'SHLVL': '1', 09:43:42 INFO - 'TERM': 'linux', 09:43:42 INFO - 'TMOUT': '86400', 09:43:42 INFO - 'USER': 'cltbld', 09:43:42 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:42 INFO - '_': '/tools/buildbot/bin/python'} 09:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:43:43 INFO - Cleaning up... 09:43:43 INFO - Return code: 0 09:43:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:43:43 INFO - Using env: {'DISPLAY': ':0', 09:43:43 INFO - 'HOME': '/home/cltbld', 09:43:43 INFO - 'LANG': 'en_US.UTF-8', 09:43:43 INFO - 'LANGUAGE': 'en_US:en', 09:43:43 INFO - 'LOGNAME': 'cltbld', 09:43:43 INFO - 'MAIL': '/var/mail/cltbld', 09:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:43 INFO - 'MOZ_NO_REMOTE': '1', 09:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:43 INFO - 'NO_EM_RESTART': '1', 09:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:43 INFO - 'PWD': '/builds/slave/test', 09:43:43 INFO - 'SHELL': '/bin/bash', 09:43:43 INFO - 'SHLVL': '1', 09:43:43 INFO - 'TERM': 'linux', 09:43:43 INFO - 'TMOUT': '86400', 09:43:43 INFO - 'USER': 'cltbld', 09:43:43 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:43 INFO - '_': '/tools/buildbot/bin/python'} 09:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:43 INFO - Downloading/unpacking jsonschema 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:43: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 09:43:44 INFO - Downloading/unpacking functools32 (from jsonschema) 09:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:43:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:43:45 INFO - warning: no files found matching '*.txt' 09:43:45 INFO - no previously-included directories found matching 'build' 09:43:45 INFO - no previously-included directories found matching 'dist' 09:43:45 INFO - no previously-included directories found matching '.git*' 09:43:45 INFO - Installing collected packages: jsonschema, functools32 09:43:45 INFO - Running setup.py install for functools32 09:43:45 INFO - warning: no files found matching '*.txt' 09:43:45 INFO - no previously-included directories found matching 'build' 09:43:45 INFO - no previously-included directories found matching 'dist' 09:43:45 INFO - no previously-included directories found matching '.git*' 09:43:45 INFO - Successfully installed jsonschema functools32 09:43:45 INFO - Cleaning up... 09:43:45 INFO - Return code: 0 09:43:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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 0x7f4bac58cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43: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 09:43: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 09:43:45 INFO - Using env: {'DISPLAY': ':0', 09:43:45 INFO - 'HOME': '/home/cltbld', 09:43:45 INFO - 'LANG': 'en_US.UTF-8', 09:43:45 INFO - 'LANGUAGE': 'en_US:en', 09:43:45 INFO - 'LOGNAME': 'cltbld', 09:43:45 INFO - 'MAIL': '/var/mail/cltbld', 09:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:45 INFO - 'MOZ_NO_REMOTE': '1', 09:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:45 INFO - 'NO_EM_RESTART': '1', 09:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:45 INFO - 'PWD': '/builds/slave/test', 09:43:45 INFO - 'SHELL': '/bin/bash', 09:43:45 INFO - 'SHLVL': '1', 09:43:45 INFO - 'TERM': 'linux', 09:43:45 INFO - 'TMOUT': '86400', 09:43:45 INFO - 'USER': 'cltbld', 09:43:45 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:45 INFO - '_': '/tools/buildbot/bin/python'} 09:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:45 INFO - Downloading/unpacking flake8 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:43:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:43:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:43: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 09:43:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:43:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:47 INFO - no previously-included directories found matching 'docs/_build' 09:43:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:43:48 INFO - Running setup.py install for pep8 09:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:48 INFO - no previously-included directories found matching 'docs/_build' 09:43:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:43:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:43:48 INFO - Cleaning up... 09:43:48 INFO - Return code: 0 09:43:48 INFO - Running post-action listener: _resource_record_post_action 09:43:48 INFO - Running post-action listener: _start_resource_monitoring 09:43:48 INFO - Starting resource monitoring. 09:43:48 INFO - ##### 09:43:48 INFO - ##### Running install step. 09:43:48 INFO - ##### 09:43:48 INFO - Running pre-action listener: _resource_record_pre_action 09:43:48 INFO - Running main action method: install 09:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:48 INFO - Reading from file tmpfile_stdout 09:43:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:48 INFO - Reading from file tmpfile_stdout 09:43:48 INFO - Output received: 09:43:48 INFO - Usage: mozinstall [options] installer 09:43:48 INFO - Options: 09:43:48 INFO - -h, --help show this help message and exit 09:43:48 INFO - -d DEST, --destination=DEST 09:43:48 INFO - Directory to install application into. [default: 09:43:48 INFO - "/builds/slave/test"] 09:43:48 INFO - --app=APP Application being installed. [default: firefox] 09:43:48 INFO - mkdir: /builds/slave/test/build/application 09:43: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'] 09:43: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 09:44:03 INFO - Reading from file tmpfile_stdout 09:44:03 INFO - Output received: 09:44:03 INFO - /builds/slave/test/build/application/firefox/firefox 09:44:03 INFO - Running post-action listener: _resource_record_post_action 09:44:03 INFO - ##### 09:44:03 INFO - ##### Running run-tests step. 09:44:03 INFO - ##### 09:44:03 INFO - Running pre-action listener: _resource_record_pre_action 09:44:03 INFO - Running main action method: run_tests 09:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:03 INFO - Python 2.7.3 09:44:03 INFO - Return code: 0 09:44:03 INFO - grabbing minidump binary from tooltool 09:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:03 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 0xffc0b0>, '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 0xffcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:44:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:44:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:03 INFO - Return code: 0 09:44:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:44:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:44:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:44:04 INFO - Return code: 0 09:44:04 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/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test/build 09:44:04 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/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 09:44:04 INFO - Using env: {'DISPLAY': ':0', 09:44:04 INFO - 'HOME': '/home/cltbld', 09:44:04 INFO - 'LANG': 'en_US.UTF-8', 09:44:04 INFO - 'LANGUAGE': 'en_US:en', 09:44:04 INFO - 'LOGNAME': 'cltbld', 09:44:04 INFO - 'MAIL': '/var/mail/cltbld', 09:44:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:04 INFO - 'MOZ_NO_REMOTE': '1', 09:44:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:04 INFO - 'NO_EM_RESTART': '1', 09:44:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:04 INFO - 'PWD': '/builds/slave/test', 09:44:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:04 INFO - 'SHELL': '/bin/bash', 09:44:04 INFO - 'SHLVL': '1', 09:44:04 INFO - 'TERM': 'linux', 09:44:04 INFO - 'TMOUT': '86400', 09:44:04 INFO - 'USER': 'cltbld', 09:44:04 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538', 09:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:04 INFO - '_': '/tools/buildbot/bin/python'} 09:44:04 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/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 09:44:04 INFO - mozversion INFO | application_buildid: 20151211083202 09:44:04 INFO - mozversion INFO | application_changeset: c56806034eda39d8275a071152eb2704411906a9 09:44:04 INFO - mozversion INFO | application_display_name: Nightly 09:44:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:04 INFO - mozversion INFO | application_name: Firefox 09:44:04 INFO - mozversion INFO | application_remotingname: firefox 09:44:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:44:04 INFO - mozversion INFO | application_vendor: Mozilla 09:44:04 INFO - mozversion INFO | application_version: 45.0a1 09:44:04 INFO - mozversion INFO | platform_buildid: 20151211083202 09:44:04 INFO - mozversion INFO | platform_changeset: c56806034eda39d8275a071152eb2704411906a9 09:44:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:44:04 INFO - mozversion INFO | platform_version: 45.0a1 09:44:04 INFO - 2015-12-11 09:44:04,397 DEBUG : using testdate: 1449855844 09:44:04 INFO - 2015-12-11 09:44:04,397 DEBUG : actual date: 1449855844 09:44:04 INFO - 2015-12-11 09:44:04,406 INFO : starting webserver on 'localhost:45339' 09:44:04 INFO - 2015-12-11 09:44:04,407 INFO : Starting test suite talos-linux64-ix-010.e 09:44:04 INFO - 2015-12-11 09:44:04,407 INFO : Starting test dromaeo_css 09:44:04 INFO - 2015-12-11 09:44:04,407 DEBUG : operating with platform_type : linux_ 09:44:04 INFO - 2015-12-11 09:44:04,408 INFO : Initialising browser for dromaeo_css test... 09:44:04 INFO - 2015-12-11 09:44:04,421 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprTH4cW/profile http://localhost:45339/getInfo.html 09:44:09 INFO - 2015-12-11 09:44:09,406 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:09 INFO - 2015-12-11 09:44:09,406 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:09 INFO - 2015-12-11 09:44:09,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:44:09 INFO - 2015-12-11 09:44:09,407 DEBUG : BROWSER_OUTPUT: __metrics 09:44:09 INFO - 2015-12-11 09:44:09,535 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:44:10 INFO - 2015-12-11 09:44:10,484 INFO : Browser initialized. 09:44:10 INFO - 2015-12-11 09:44:10,484 INFO : Running cycle 1/1 for dromaeo_css test... 09:44:10 INFO - 2015-12-11 09:44:10,484 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprTH4cW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:22 INFO - 2015-12-11 09:44:22,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 143106048 09:44:22 INFO - 2015-12-11 09:44:22,567 DEBUG : BROWSER_OUTPUT: 09:45:12 INFO - 2015-12-11 09:45:12,219 DEBUG : BROWSER_OUTPUT: 1449855912213 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:47:23 INFO - 2015-12-11 09:47:23,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45339/tests/dromaeo/cssquery-ext.html) 09:47:24 INFO - 2015-12-11 09:47:24,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 145862656 09:47:24 INFO - 2015-12-11 09:47:24,866 DEBUG : BROWSER_OUTPUT: 09:50:26 INFO - 2015-12-11 09:50:26,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-ext.html (next: http://localhost:45339/tests/dromaeo/cssquery-jquery.html) 09:50:27 INFO - 2015-12-11 09:50:27,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 143691776 09:50:27 INFO - 2015-12-11 09:50:27,528 DEBUG : BROWSER_OUTPUT: 09:53:29 INFO - 2015-12-11 09:53:29,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45339/tests/dromaeo/cssquery-mootools.html) 09:53:29 INFO - 2015-12-11 09:53:29,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 144228352 09:53:29 INFO - 2015-12-11 09:53:29,910 DEBUG : BROWSER_OUTPUT: 09:56:31 INFO - 2015-12-11 09:56:31,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45339/tests/dromaeo/cssquery-prototype.html) 09:56:32 INFO - 2015-12-11 09:56:32,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 143675392 09:56:32 INFO - 2015-12-11 09:56:32,288 DEBUG : BROWSER_OUTPUT: 09:59:34 INFO - 2015-12-11 09:59:34,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45339/tests/dromaeo/cssquery-yui.html) 09:59:35 INFO - 2015-12-11 09:59:35,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 144392192 09:59:35 INFO - 2015-12-11 09:59:35,580 DEBUG : BROWSER_OUTPUT: 10:02:37 INFO - 2015-12-11 10:02:37,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/dromaeo/cssquery-yui.html (next: http://localhost:45339/tests/dromaeo/cssquery-dojo.html) 10:02:38 INFO - 2015-12-11 10:02:38,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 147357696 10:02:38 INFO - 2015-12-11 10:02:38,214 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,216 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:02:38 INFO - 2015-12-11 10:02:38,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:02:38 INFO - 2015-12-11 10:02:38,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:02:38 INFO - 2015-12-11 10:02:38,216 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:02:38 INFO - 2015-12-11 10:02:38,217 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2669.6395986541816;2726.0867609350867;2748.6701595808495;2767.1560174146884;2783.638127043484;4450.221211288028;4765.261384485406;4799.640026997976;4807;4827.710337379751;4641.187792136371;4643.489216186217;4666.696664716791;4747.359106520618;4845.757712114398;4330.761808100553;4446.55534446556;4449.866504004877;4474.306482495218;4514.345419914111;4224.134052519242;4366.541513141106;4384.758838263894;4384.934225986613;4413.073254616518;4328.761918094519;4388.363687265361;4416.53626369233;4424.491183513905;4459.799309031069;4465;4471.597556219924;4478.865634030984;4487.349334346502;4517.616002639779;4172.332426811696;4276.935845962313;4278.935815962763;4440.178566965122;4485.9551404485865;4591.6097131743845;4671.836485723017;4686.95313046872;4690.695104818176;4694.037722266927;5166.328377310963;5179.352580927384;5199.350081239845;5204.791808327663;5209.1404918188455;4871.610271178297;5011.123053465629;5136.537711605936;5186.351706036746;5206.869828254286;4717.8348757794;4745.525447455296;4758.762061896891;4793.832215872428;4810.230363141881;5232.084385232569;5249.133892907627;5254.474552544715;5257.737113144404;5268.894622107537;4818.68678535894;4931.753412329369;4955.083309587738;5062.848114556569;5102.489751024942;5166.250893620404;5181.222816577468;5206.635535512478;5225.085610018307;5229;5164.535191832753;5164.7934082636275;5165.793368265227;5167.974160129175;5195.532402083831;4797.520247975174;4915.606751459946;4945.134601444733;5034.521720436553;5077.771500282496;4281.507626622916;4312.633426158749;4335.631471324909;4338.869833904988;4360.345948107746;3644.6355364463343;3779.565349984732;3798.0504873781556;3800.7529510581726;3844.4233364995475;4315.568443155722;4326.394304797331;4384.495782984997;4403.8458653946955;4438.578335058164;5102.5662818660085;5151.098557752378;5151.484851514819;5158.716270605153;5191.065608190486;4195.643370313557;4278.4010238566625;4421.712588681789;4423.867283981485;4450.866474005785;4530.592246697813;4569.428821397325;4603.217453032992;4621.191291524037;4644.419447569054;4875.731834749123;4877.12211801879;4878.804847806048;4887.218045112765;4894.094592500328;4872.878178045436;5006.07387633289;5017.0216807722145;5169.405518365436;5188.662736922088;4887.48224387561;4912.557869791593;4918.1393256180745;4918.532739389752;4923.876903077452;5153.871153221199;5155.200943853709;5170.991656626921;5173.249878767633;5202.193659982709;4848.0546293472435;4953.554180123806;4963.478834722302;4970.353853998957;5237.319148510822;4914.70511769295;4925.605951523798;4945.258211268195;5026;5061.038402703474;5046.29351890743;5059.139946209227;5063.772130254074;5064.518870707277;5114.923276150935;4696.553827386393;4924.657500285016;4953.356063711694;4963.429205641253;4970.975145124251;4914.140025495595;4951.678140920829;4951.777170027285;4990.750462476789;5022.347094877789;4927.310176575354;4955.2567114933045;4964.751762411793;4969.105560998911;5027.12025395547 10:02:38 INFO - 2015-12-11 10:02:38,221 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.2422267827094;566.1931747260153;567.0615131956611;574.1473911241802;615.8799034188335;34655;35140.82429587852;35195;35225.64774352256;35283.4707479388;36518.45222321667;37124.07189820256;37141;37227;37380;7660.387169026479;7831.686732530692;7838.098618658842;7841.764747057598;7863.921360786405;7681.155072941972;7819.882701759479;7846.372290216769;7847.450678452511;7867.567283799389;7867.370610351159;7962.044554653421;8003.1996800320085;8009.239122283374;8018.959905200466;7850.882236766453;7923.405744569181;7924.722634707815;7925.484843485184;7951.324137448353;7710.498817576896;7759.030121234846;7804.414668899798;7816.960915195387;7827.452078354518;33143.33713325744;33433.6656633433;33453.6654633453;33609.49585756216;33703.83148084244;2935.838528880911;2942.970570294291;3052.801567898102;3166.5566820645126;3400.778949368283;27634.585481217797;27692.584611230846;28039.719602804118;28185.154445366672;28715.712842871722;3439.3809114359406;3500.474928760681;3553.982230088859;3591.317649646559;3597.5503062117236;215748;217503;217766;218648.9067554668;218746;50665;51764.48235517597;56697;56995.15541179046;63339.36660633427;55576.72211638916;55682.44317556854;55960.72019639957;56065.7196714022;56119.43880561224;12472.43874025671;12540.372981350896;12630.368481575884;12637.747245055047;12656.683582910317;9766.169875560516;9769.706908792748;9785.510724463747;9794.510274486389;9800.215982721365;19371.903140484206;19827.900860495603;19832.305869294505;19875.105620247123;19911;7691.269329413697;7885.44801863864;7898.9210107899335;7971.960140199262;8087.919120808834;809.3323008517996;823.4359463767339;908.504864848659;950.021477877787;978.848278516831;26071.348216294366;26263.343416414362;26397;29605.555916661266;30835.229119272197;929.2473096791485;935.1571223480543;975.5073687787764;1045.5399624165343;1067.0449947297125;13569.52506662262;13682.179069255877;13979.930100349433;13989.86010139906;14000.159990400609;309211;312286;315126;315264;318148;45793;46298.5370146301;46461.76769116133;46526.76736616363;46638;1166.5567084507832;1238.8451443569554;1250.7060840702427;1252.4364036183572;1254.5358217459598;25973.870130649982;26199.738002620492;26283.211503654922;26430.339241518348;26450.867745661148;39360;39737.80131099326;39769;39813.20373592454;39872.80063599663;243778;245580;247064;247161;247445;23895.163669272188;24574.877125614257;28210.15369538917;29096;29905.850470747508;36103.638963611076;36150.63849361473;36203.63796362003;36450.635493644724;36869.078273043386;31186.22034449157;31419;31727.524087139172;32071.198220044687;32111.839440802647;31593.5260971081;31661.8416907914;31665.683343166274;31685.841570792;31907.36185276328;31653.8417307912;31834.840825795724;31848.5222721664;38162;38615;28628.85685571559;29671;29878.25304367408;34092.488612671325;35159;23337.18319858797;23801;23841.284761457184;23927.81263278954;24225 10:02:38 INFO - 2015-12-11 10:02:38,222 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.52775378347206;338.6494977698082;340.181862620398;340.50456585667854;340.9795412275262;13007.479700811957;14943.850561494382;15018;15722.764158537602;16469.588260293498;10092.949535252314;10277.588896444153;14364.856351436509;16395.508134755975;16499.927504712185;4588.54114588541;4694.272387779883;6141.477974372184;6344.873102537947;6355.3009168991375;6222.439980401763;6291.842703932392;6332.936670633304;6645.235797883257;6647.867042659144;6195.65923874189;6400.135981642466;6410.519211059189;6605.339466053404;6614.50391220658;6351.364863513635;6373.968130159343;6391.424771770539;6752.966235168842;6763.628000459973;6440.1305823713665;6470;6484.286728459866;6484.675766211718;6489.4483968862705;18868;19452.319168829166;19792;19811.80188198114;19821.125936739238;1958.7649482062243;1971.4972681966008;1984.99007504963;2042.428120126367;2048.7541495020546;13713.862861371359;13919.164850109026;14103.294835258299;14148.858511414857;14179.78730319046;1857.3313607101434;1869.3831035758167;1927.11352777721;1929.9903500482408;1979.1786408640396;50422.7478862607;50472.24291635665;51658.48341516612;60754.69622651902;65364.673176634285;14821.555353339418;15855.286512106983;16056.357745690042;16057.759133613004;16072.678546429006;23442.64836027461;23519;23648;23786.405339866295;23841.165559205343;8226.794330141794;8349.123342049119;8380.413371064089;8398.076211616717;8411.53736544496;6948.062011628466;6979.616121113388;6990.161180658353;7019.824504387329;7021.684024218923;7777.1833957433655;7844.843103137905;7894.171112033268;7900.209979002054;7927.128015918244;1751.570865138024;1811.8369346758855;3160.383725173615;3164.525321201792;3215.993046501482;819.3117781063935;823.300194834398;854.3891117850642;924.6024209589806;954.3367359684952;13365;15810.17396388795;15921;15950.76073858893;16000.919995399949;778.8831675248645;792.7502836606451;843.0894633795486;862.5169904853302;902.4991129922824;9006.954965225263;9293.349465537347;9339.252859771203;9422;9457.10157535033;468967;473081;479130;483233;486896;69221;69841.65079174572;71137.28862711307;72705;74269.6286518564;1014.5130337437923;1023.9948800255951;1055.5619417941468;1068.7435015596202;1070.2454769387718;14360.497382591559;14432;14557.854421456073;14631;14674.63313417173;29484.852575736983;30090.69909300879;30483;30676.233094172825;31110.53334200034;34643.82678086594;36022.27955440929;36232;36486.817565912;37035.25929481449;8422.24199822019;8749.868751968854;9199;9202.631894724136;9210.95394523023;10283.794324113625;10372.896271037494;15215.239238038275;15445.768313475082;16702.49892503227;12839.358032098171;13060.281684507443;13166.605001849959;13249.801252981406;13598.660033499242;12457.813132802834;12970.156939798882;12974.221546707227;13112.344382780631;13421.798673020108;13086.803697944348;13148.671283217996;13207.66980825487;13282.136661116996;13422.731545368842;8659.696910608098;8889.19997200255;8902.287816974496;8947;9064.50145242018;8979.191872731486;11561.42192890369;14152.646183845074;14393.85606143967;14402.639934001734 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1427.55032164868;1641.1302009934734;1698.8216237295085;1716.733906244531;1730.9394171204005;6663.466922646189;6857.931420685792;7077.256888026747;7102.751403700865;7105.467089968253;7057.89413158803;7089.5037347385705;7193.4245260379175;7226;7241.927580724191;2090.1221486975505;2121.63932131538;2122.299641118435;2126.4258650164447;2133.9146434142617;2099.4121645939085;2101.3695891232646;2108.4412630652814;2109.04038662409;2125.670521069229;1999.4201681512343;2025.4227545149636;2053.496893261153;2056.670932650776;2060.0626714844784;2079.116375540397;2107.230860735836;2120.8303335733103;2121.2787652198326;2122.3420739570706;2058.5882823435372;2077.241806740544;2097.769245383007;2100.7689154193026;2106.3470324199548;7196.1724401693955;7223.349898509159;7224.349808517259;7239.638018099126;7269.709211631528;4154.252234597771;4223.324268117117;4248.426462427564;4248.745075295492;4266.765327906964;2739.4384151248946;2768.349437882096;2800.0339882740627;2830.448062627788;2831.7876159288135;860.1871231686059;872.7250915961451;886.6453418632534;894.7494701483595;904.2946501728662;9291.070892910722;9344.205742511827;9470.289728270338;9506.90493095074;9512.429254244767;3616.4936908832783;3681.9447708284397;3703.851845926187;3902.453656488094;3927.7446965947124;7556.773296801105;7563.73526926566;7581.166071732105;7595.962020189863;7604.8479030419085;4208.242516347087;4233.153369326147;4243.724157929724;4247.426597409372;4268.91462170761;3874.6125387461593;3881.825317860703;3881.922361552753;3892.6885849132;3925.842966281317;2962.7333539981505;2986.5669477926012;3029.606151200374;3040.452718510645;3041.2092855857636;887.4808237181193;892.794657228828;899.8290324838259;903.9864402033975;904.624580798961;749.4192001199006;750.0699133074947;804.5454318310136;831.7878940870161;943.3160958305311;6519.413252807175;6600.306967768412;6617.04052912325;6618.205815302194;6658.067870498134;571.0691572736413;574.2964868036622;581.4911952041963;589.8761260135334;736.054170391045;5004;5032.899342013213;5042.193249080129;5048.495150484996;5076.593872490266;7981.880271795928;8454.154584541497;8482.10937851529;8501.914980850112;8518.23335899772;8300.294474969694;8317.251447369767;8321.791955201048;8325.66697332112;8400.495970241805;6527.902081468782;6529.510286728514;6573.5398522103;6577.210734711865;6618.867622647616;6345.365463453618;6366.9681651591445;6390.041493775785;6395.488360931021;6404.807855764335;7368.336849683555;7499.437542184249;7512.737054203077;7523.887141692989;7679.462437629536;7570.848583028419;7679.193684663253;7726.961365193138;7780.299773020455;7898.723544675909;5839.824805255849;5897.262842144732;5906.143609176559;5910.734016969161;5912.349641539513;6170.691465426621;6297.338779428277;6303.716332764945;6330.082138090043;6331.05034244867;6020.608660437058;6127.142200091902;6130.049842274455;6207.193064901534;6257.217847769029;5713.857153571194;6131.141640170469;6216.316205217513;6255.374462553708;6326.367363263636;6404.231492220963;6423.903641445476;6459.192600924885;6463.7737679181;6472.417482426604;5619.971900140473;5651.067573850269;5691.430856914276;5691.800786972436;5750.13747937796;5934.643921364732;5953.226080609493;5954.166416701752;5955.642661440327;5977.22296101504 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.3032963524622;304.38362316309485;310.3018209029683;311.02338656618224;312.61236067276576;5495.945040549594;5555.749991250394;5587.469190426913;5606.187102870082;5655.066913959197;5544.889102217953;5620.747066382012;5624.465675760806;5633.746481408336;5645.717714114298;4165.958340416602;4286.39990401344;4330.047389574296;4332.2851729464755;4338.609525142752;4285.035866929947;4295.742255464666;4296.5273819879785;4307.655387569002;4313.396124542551;4244.27847265964;4252.681048921328;4254.808533615995;4260.552641972595;4261.829526818923;4246.723962942429;4247.044415006645;4250.3836943643155;4254.553271906436;4280.229558679436;3626.528551288342;3709.5733990591157;3709.647583479565;3710.888673339777;3718.219173973469;5242.737863106868;5356.919646205271;5408.13469844823;5414.91877621836;5426.62013659044;4950.801967921278;4955.603551715854;4960.33035540201;4961.776720047606;4969.726665033421;5976.790812321591;5983.1025346197985;5991.910121348184;5993.460588547008;5993.460588547052;3910.511186101737;4050.0887300357185;4056.1887622475624;4057.087155390014;4066.2680717470844;6178.938210617881;6248.437640612321;6254.937450625481;6260.342664020258;6264;4176.352665336878;4189.622933935961;4200.6219440249915;4204.495460544693;4218.704690671623;4257.978710106491;4281.422008028876;4282.250606143974;4282.89292767677;4284.935725964113;4747.548982846624;4891.559759621651;4932.827351042696;4940.258961155783;4951.653384263139;5961.5230781537375;5964.8807023860145;5970.731317090741;5976.6115202512565;5980.611260268069;1481.052126638952;1487.6504021554927;1493.0742939377656;1495.6111411032991;1506.344740038087;982.3074732313702;983.5646349499937;1000.6947880896397;1015.3501758874327;1019.9847002294972;5128.25640282157;5129.435762066169;5136.640435169502;5141.28022076902;5145.382554093533;6170.167027451236;6176.135341052256;6179.0422484514975;6179.104029915727;6183.783567575203;5108.923366149511;5119.334486516729;5120.871978200575;5121.667091639106;5126.512981266774;3180.920476988094;3285.852136653856;3297.884574039897;3299.670032996681;3329.716974057232;5633.802816901389;5749;5792.9710351447975;5802.071668533014;5812.6221795584;6374.171357723466;6388.552801303864;6404.647744374104;6417.679116044179;6431.903521447182;5736.741846616912;5774.0761478163295;5774.335951365562;5776.277965254427;5781.075027995501;5925.644461332334;6136.5090792737365;6166.321704612579;6188.9690551546955;6191.907121393093;5967.582269241111;6068.696565171812;6070.423309785563;6073.817785466266;6083.422074902877;5734.992752536746;5735.598508104393;5764.827055188351;5789.33422656383;5794.420557944172;4180.83276668942;4218.894527636711;4228.365745138254;4232.534421213725;4235.661147108285;6021.698915054142;6155;6181.103739957771;6182.381761823782;6201.193844800147;5922.437368449991;5927.2590926134235;5941.58408911372;5943.108533719977;5953.583249172516;5930.555208359477;5941.792037278675;5946.791862284799;5955.5235581154275;5960.433758792908;5706.372299047184;5719.256496655575;5812.7674893003805;5814.331351894586;5816.01127808282;5894.528437724886;5945.762169513344;5973.641581505123;5979.431953964367;6005.729742161526;5764.971175144097;5797.391273916178;5803.593748437569;5805.680687562224;5808.73860676279 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.110409842614;661.9238787539434;702.7926761605324;751.6880494594743;765.5865832450477;11251.381174035425;11455.198136130473;11461;11472.426378681064;11515.942420287907;13067.215967041984;13253.403596838141;13255.46978120874;13264.801027984588;13279.070465067449;797.7566842113167;810.0360570920585;813.1746277528314;832.4256263178418;838.9580520973957;811.3995643224031;813.9633716482742;817.0971076959963;818.7830224990382;822.5558198572763;860.3418384935499;861.2937391339104;862.7886167888876;866.1338661338661;868.6308318964415;856.7729551668813;860.3117505995178;862.2843040276556;863.4991704811226;865.0484467086218;629.3989240275572;630.3318482408615;633.4172561243666;633.771842136835;639.9552031357761;11394.715132121763;11495.482703278372;11526.077913766878;11594.826077608843;11606.071514278838;11371.886281137165;11397.202195846294;11803.11476639247;12061.939690301493;12378;8629.568521573896;8899.33255005877;8990.730278091667;9284.72145835626;9478.336516443851;3143.858526366319;3192.74458043356;3272.803631782077;3312.867485300585;3319.3859136059664;40456.59543404587;40643;40826.38760418596;41045;41112.38331425031;9454.196393306645;9532.18976387001;9603.855942160873;9736;9741.756456088513;17207.655846882994;17479;17491.650166996587;17496.125193740263;17517.47447576549;6302.212223472066;6310.5898116622275;6370.649614271259;6373.52198585108;6442.355764423613;3473.149078475739;3493.2314890724;3524.6827785499427;3639.872604458831;3649.4525821127045;2546.414324705328;2577.87110644467;2578.3940773918116;2582;2584.6123081537544;470.5388719055345;477.48193210366446;479.0538686095004;482.1658530741766;482.38014151814747;499.338376650939;516.7158063065299;523.8480840556196;546.3171036204744;561.166667498764;7279.944408060802;7307.525010874276;7406.07424071991;7582.938388625596;7626.351760100342;481.78078974066716;510.6655140882728;536.1555550008752;545.0162456765577;580.851882769891;3379.831008449568;3599.6220396858475;3606.4229723244157;3647.8723244686307;3749.981250093732;48793.51206487961;48983.510164897896;49518.50481495211;49525.75237123863;49793.75103124461;44467.55532444699;46498.30252546147;47172;47623.761881190374;47830;40173;40468;40917.38623920643;40975;41088.1782364351;7734.845303094019;7795.532268063935;8179.345652347679;8341.332693384393;8563.61463734146;30871.691283086882;30874.382512350076;31168.376632467676;31464.37071258516;31735.206619834687;36004;38774.4183837237;39525.40711889382;40066.1986760269;40239;9536.189423899046;9689.9031009689;9761.658341957997;9794.21646268311;10074.44590547527;11099.72250693739;11108.277961932448;11129.443527823414;11186.440677966231;11596.942015290208;9880.258980576342;9942.403455792675;10049.246306527186;10159.339642923187;10872.130229581773;10265.423456164843;10327;10365.274430789772;10520.473976301308;10547.630832920811;10349.586016559253;10787.514561844893;10804.891951080388;10873.07578855806;10895.618653347095;8633.093525179765;9033.593488293174;9041.186293233377;9215.308851836005;9295.953520232355;8655.740327790176;8760.51817150063;8792.692255771017;9344.813103738023;9460.858087128836 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: __startTimestamp1449856958214__endTimestamp 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:02:38 INFO - 2015-12-11 10:02:38,226 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,227 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4724.82 Median:4877.12 stddev:496.89 (10.2%) stddev-sans-first:471.53 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: Values: 2669.6 2726.1 2748.7 2767.2 2783.6 4450.2 4765.3 4799.6 4807.0 4827.7 4641.2 4643.5 4666.7 4747.4 4845.8 4330.8 4446.6 4449.9 4474.3 4514.3 4224.1 4366.5 4384.8 4384.9 4413.1 4328.8 4388.4 4416.5 4424.5 4459.8 4465.0 4471.6 4478.9 4487.3 4517.6 4172.3 4276.9 4278.9 4440.2 4486.0 4591.6 4671.8 4687.0 4690.7 4694.0 5166.3 5179.4 5199.4 5204.8 5209.1 4871.6 5011.1 5136.5 5186.4 5206.9 4717.8 4745.5 4758.8 4793.8 4810.2 5232.1 5249.1 5254.5 5257.7 5268.9 4818.7 4931.8 4955.1 5062.8 5102.5 5166.3 5181.2 5206.6 5225.1 5229.0 5164.5 5164.8 5165.8 5168.0 5195.5 4797.5 4915.6 4945.1 5034.5 5077.8 4281.5 4312.6 4335.6 4338.9 4360.3 3644.6 3779.6 3798.1 3800.8 3844.4 4315.6 4326.4 4384.5 4403.8 4438.6 5102.6 5151.1 5151.5 5158.7 5191.1 4195.6 4278.4 4421.7 4423.9 4450.9 4530.6 4569.4 4603.2 4621.2 4644.4 4875.7 4877.1 4878.8 4887.2 4894.1 4872.9 5006.1 5017.0 5169.4 5188.7 4887.5 4912.6 4918.1 4918.5 4923.9 5153.9 5155.2 5171.0 5173.2 5202.2 4848.1 4953.6 4963.5 4970.4 5237.3 4914.7 4925.6 4945.3 5026.0 5061.0 5046.3 5059.1 5063.8 5064.5 5114.9 4696.6 4924.7 4953.4 4963.4 4971.0 4914.1 4951.7 4951.8 4990.8 5022.3 4927.3 4955.3 4964.8 4969.1 5027.1 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41490.68 Median:19077.74 stddev:68643.40 (359.8%) stddev-sans-first:68767.17 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: Values: 559.2 566.2 567.1 574.1 615.9 34655.0 35140.8 35195.0 35225.6 35283.5 36518.5 37124.1 37141.0 37227.0 37380.0 7660.4 7831.7 7838.1 7841.8 7863.9 7681.2 7819.9 7846.4 7847.5 7867.6 7867.4 7962.0 8003.2 8009.2 8019.0 7850.9 7923.4 7924.7 7925.5 7951.3 7710.5 7759.0 7804.4 7817.0 7827.5 33143.3 33433.7 33453.7 33609.5 33703.8 2935.8 2943.0 3052.8 3166.6 3400.8 27634.6 27692.6 28039.7 28185.2 28715.7 3439.4 3500.5 3554.0 3591.3 3597.6 215748.0 217503.0 217766.0 218648.9 218746.0 50665.0 51764.5 56697.0 56995.2 63339.4 55576.7 55682.4 55960.7 56065.7 56119.4 12472.4 12540.4 12630.4 12637.7 12656.7 9766.2 9769.7 9785.5 9794.5 9800.2 19371.9 19827.9 19832.3 19875.1 19911.0 7691.3 7885.4 7898.9 7972.0 8087.9 809.3 823.4 908.5 950.0 978.8 26071.3 26263.3 26397.0 29605.6 30835.2 929.2 935.2 975.5 1045.5 1067.0 13569.5 13682.2 13979.9 13989.9 14000.2 309211.0 312286.0 315126.0 315264.0 318148.0 45793.0 46298.5 46461.8 46526.8 46638.0 1166.6 1238.8 1250.7 1252.4 1254.5 25973.9 26199.7 26283.2 26430.3 26450.9 39360.0 39737.8 39769.0 39813.2 39872.8 243778.0 245580.0 247064.0 247161.0 247445.0 23895.2 24574.9 28210.2 29096.0 29905.9 36103.6 36150.6 36203.6 36450.6 36869.1 31186.2 31419.0 31727.5 32071.2 32111.8 31593.5 31661.8 31665.7 31685.8 31907.4 31653.8 31834.8 31848.5 38162.0 38615.0 28628.9 29671.0 29878.3 34092.5 35159.0 23337.2 23801.0 23841.3 23927.8 24225.0 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,228 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26682.36 Median:339.42 stddev:77926.60 (22959.0%) stddev-sans-first:78120.10 10:02:38 INFO - 2015-12-11 10:02:38,229 DEBUG : BROWSER_OUTPUT: Values: 338.5 338.6 340.2 340.5 341.0 13007.5 14943.9 15018.0 15722.8 16469.6 10092.9 10277.6 14364.9 16395.5 16499.9 4588.5 4694.3 6141.5 6344.9 6355.3 6222.4 6291.8 6332.9 6645.2 6647.9 6195.7 6400.1 6410.5 6605.3 6614.5 6351.4 6374.0 6391.4 6753.0 6763.6 6440.1 6470.0 6484.3 6484.7 6489.4 18868.0 19452.3 19792.0 19811.8 19821.1 1958.8 1971.5 1985.0 2042.4 2048.8 13713.9 13919.2 14103.3 14148.9 14179.8 1857.3 1869.4 1927.1 1930.0 1979.2 50422.7 50472.2 51658.5 60754.7 65364.7 14821.6 15855.3 16056.4 16057.8 16072.7 23442.6 23519.0 23648.0 23786.4 23841.2 8226.8 8349.1 8380.4 8398.1 8411.5 6948.1 6979.6 6990.2 7019.8 7021.7 7777.2 7844.8 7894.2 7900.2 7927.1 1751.6 1811.8 3160.4 3164.5 3216.0 819.3 823.3 854.4 924.6 954.3 13365.0 15810.2 15921.0 15950.8 16000.9 778.9 792.8 843.1 862.5 902.5 9007.0 9293.3 9339.3 9422.0 9457.1 468967.0 473081.0 479130.0 483233.0 486896.0 69221.0 69841.7 71137.3 72705.0 74269.6 1014.5 1024.0 1055.6 1068.7 1070.2 14360.5 14432.0 14557.9 14631.0 14674.6 29484.9 30090.7 30483.0 30676.2 31110.5 34643.8 36022.3 36232.0 36486.8 37035.3 8422.2 8749.9 9199.0 9202.6 9211.0 10283.8 10372.9 15215.2 15445.8 16702.5 12839.4 13060.3 13166.6 13249.8 13598.7 12457.8 12970.2 12974.2 13112.3 13421.8 13086.8 13148.7 13207.7 13282.1 13422.7 8659.7 8889.2 8902.3 8947.0 9064.5 8979.2 11561.4 14152.6 14393.9 14402.6 10:02:38 INFO - 2015-12-11 10:02:38,229 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,229 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4852.87 Median:6211.75 stddev:2522.54 (40.6%) stddev-sans-first:2516.48 10:02:38 INFO - 2015-12-11 10:02:38,230 DEBUG : BROWSER_OUTPUT: Values: 1427.6 1641.1 1698.8 1716.7 1730.9 6663.5 6857.9 7077.3 7102.8 7105.5 7057.9 7089.5 7193.4 7226.0 7241.9 2090.1 2121.6 2122.3 2126.4 2133.9 2099.4 2101.4 2108.4 2109.0 2125.7 1999.4 2025.4 2053.5 2056.7 2060.1 2079.1 2107.2 2120.8 2121.3 2122.3 2058.6 2077.2 2097.8 2100.8 2106.3 7196.2 7223.3 7224.3 7239.6 7269.7 4154.3 4223.3 4248.4 4248.7 4266.8 2739.4 2768.3 2800.0 2830.4 2831.8 860.2 872.7 886.6 894.7 904.3 9291.1 9344.2 9470.3 9506.9 9512.4 3616.5 3681.9 3703.9 3902.5 3927.7 7556.8 7563.7 7581.2 7596.0 7604.8 4208.2 4233.2 4243.7 4247.4 4268.9 3874.6 3881.8 3881.9 3892.7 3925.8 2962.7 2986.6 3029.6 3040.5 3041.2 887.5 892.8 899.8 904.0 904.6 749.4 750.1 804.5 831.8 943.3 6519.4 6600.3 6617.0 6618.2 6658.1 571.1 574.3 581.5 589.9 736.1 5004.0 5032.9 5042.2 5048.5 5076.6 7981.9 8454.2 8482.1 8501.9 8518.2 8300.3 8317.3 8321.8 8325.7 8400.5 6527.9 6529.5 6573.5 6577.2 6618.9 6345.4 6367.0 6390.0 6395.5 6404.8 7368.3 7499.4 7512.7 7523.9 7679.5 7570.8 7679.2 7727.0 7780.3 7898.7 5839.8 5897.3 5906.1 5910.7 5912.3 6170.7 6297.3 6303.7 6330.1 6331.1 6020.6 6127.1 6130.0 6207.2 6257.2 5713.9 6131.1 6216.3 6255.4 6326.4 6404.2 6423.9 6459.2 6463.8 6472.4 5620.0 5651.1 5691.4 5691.8 5750.1 5934.6 5953.2 5954.2 5955.6 5977.2 10:02:38 INFO - 2015-12-11 10:02:38,230 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,230 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4891.09 Median:5571.61 stddev:1461.86 (26.2%) stddev-sans-first:1424.77 10:02:38 INFO - 2015-12-11 10:02:38,231 DEBUG : BROWSER_OUTPUT: Values: 300.3 304.4 310.3 311.0 312.6 5495.9 5555.7 5587.5 5606.2 5655.1 5544.9 5620.7 5624.5 5633.7 5645.7 4166.0 4286.4 4330.0 4332.3 4338.6 4285.0 4295.7 4296.5 4307.7 4313.4 4244.3 4252.7 4254.8 4260.6 4261.8 4246.7 4247.0 4250.4 4254.6 4280.2 3626.5 3709.6 3709.6 3710.9 3718.2 5242.7 5356.9 5408.1 5414.9 5426.6 4950.8 4955.6 4960.3 4961.8 4969.7 5976.8 5983.1 5991.9 5993.5 5993.5 3910.5 4050.1 4056.2 4057.1 4066.3 6178.9 6248.4 6254.9 6260.3 6264.0 4176.4 4189.6 4200.6 4204.5 4218.7 4258.0 4281.4 4282.3 4282.9 4284.9 4747.5 4891.6 4932.8 4940.3 4951.7 5961.5 5964.9 5970.7 5976.6 5980.6 1481.1 1487.7 1493.1 1495.6 1506.3 982.3 983.6 1000.7 1015.4 1020.0 5128.3 5129.4 5136.6 5141.3 5145.4 6170.2 6176.1 6179.0 6179.1 6183.8 5108.9 5119.3 5120.9 5121.7 5126.5 3180.9 3285.9 3297.9 3299.7 3329.7 5633.8 5749.0 5793.0 5802.1 5812.6 6374.2 6388.6 6404.6 6417.7 6431.9 5736.7 5774.1 5774.3 5776.3 5781.1 5925.6 6136.5 6166.3 6189.0 6191.9 5967.6 6068.7 6070.4 6073.8 6083.4 5735.0 5735.6 5764.8 5789.3 5794.4 4180.8 4218.9 4228.4 4232.5 4235.7 6021.7 6155.0 6181.1 6182.4 6201.2 5922.4 5927.3 5941.6 5943.1 5953.6 5930.6 5941.8 5946.8 5955.5 5960.4 5706.4 5719.3 5812.8 5814.3 5816.0 5894.5 5945.8 5973.6 5979.4 6005.7 5765.0 5797.4 5803.6 5805.7 5808.7 10:02:38 INFO - 2015-12-11 10:02:38,231 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,232 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12314.58 Median:24154.53 stddev:13935.44 (57.7%) stddev-sans-first:13947.02 10:02:38 INFO - 2015-12-11 10:02:38,233 DEBUG : BROWSER_OUTPUT: Values: 654.1 661.9 702.8 751.7 765.6 11251.4 11455.2 11461.0 11472.4 11515.9 13067.2 13253.4 13255.5 13264.8 13279.1 797.8 810.0 813.2 832.4 839.0 811.4 814.0 817.1 818.8 822.6 860.3 861.3 862.8 866.1 868.6 856.8 860.3 862.3 863.5 865.0 629.4 630.3 633.4 633.8 640.0 11394.7 11495.5 11526.1 11594.8 11606.1 11371.9 11397.2 11803.1 12061.9 12378.0 8629.6 8899.3 8990.7 9284.7 9478.3 3143.9 3192.7 3272.8 3312.9 3319.4 40456.6 40643.0 40826.4 41045.0 41112.4 9454.2 9532.2 9603.9 9736.0 9741.8 17207.7 17479.0 17491.7 17496.1 17517.5 6302.2 6310.6 6370.6 6373.5 6442.4 3473.1 3493.2 3524.7 3639.9 3649.5 2546.4 2577.9 2578.4 2582.0 2584.6 470.5 477.5 479.1 482.2 482.4 499.3 516.7 523.8 546.3 561.2 7279.9 7307.5 7406.1 7582.9 7626.4 481.8 510.7 536.2 545.0 580.9 3379.8 3599.6 3606.4 3647.9 3750.0 48793.5 48983.5 49518.5 49525.8 49793.8 44467.6 46498.3 47172.0 47623.8 47830.0 40173.0 40468.0 40917.4 40975.0 41088.2 7734.8 7795.5 8179.3 8341.3 8563.6 30871.7 30874.4 31168.4 31464.4 31735.2 36004.0 38774.4 39525.4 40066.2 40239.0 9536.2 9689.9 9761.7 9794.2 10074.4 11099.7 11108.3 11129.4 11186.4 11596.9 9880.3 9942.4 10049.2 10159.3 10872.1 10265.4 10327.0 10365.3 10520.5 10547.6 10349.6 10787.5 10804.9 10873.1 10895.6 8633.1 9033.6 9041.2 9215.3 9296.0 8655.7 8760.5 8792.7 9344.8 9460.9 10:02:38 INFO - 2015-12-11 10:02:38,233 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:02:38 INFO - 2015-12-11 10:02:38,233 DEBUG : BROWSER_OUTPUT: 10:02:38 INFO - 2015-12-11 10:02:38,968 INFO : Browser exited with error code: 0 10:02:38 INFO - 2015-12-11 10:02:38,986 INFO : Completed test dromaeo_css (00:18:34) 10:02:38 INFO - 2015-12-11 10:02:38,987 INFO : Starting test kraken 10:02:38 INFO - 2015-12-11 10:02:38,987 DEBUG : operating with platform_type : linux_ 10:02:38 INFO - 2015-12-11 10:02:38,987 INFO : Initialising browser for kraken test... 10:02:38 INFO - 2015-12-11 10:02:38,993 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKaSaF/profile http://localhost:45339/getInfo.html 10:02:43 INFO - 2015-12-11 10:02:43,736 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:02:43 INFO - 2015-12-11 10:02:43,736 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:02:43 INFO - 2015-12-11 10:02:43,736 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:02:43 INFO - 2015-12-11 10:02:43,736 DEBUG : BROWSER_OUTPUT: __metrics 10:02:43 INFO - 2015-12-11 10:02:43,853 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] 10:02:44 INFO - 2015-12-11 10:02:44,795 INFO : Browser initialized. 10:02:44 INFO - 2015-12-11 10:02:44,796 INFO : Running cycle 1/1 for kraken test... 10:02:44 INFO - 2015-12-11 10:02:44,796 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKaSaF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:56 INFO - 2015-12-11 10:02:56,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 143478784 10:02:56 INFO - 2015-12-11 10:02:56,796 DEBUG : BROWSER_OUTPUT: 10:02:59 INFO - 2015-12-11 10:02:59,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45339/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:59 INFO - 2015-12-11 10:02:59,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 142221312 10:03:00 INFO - 2015-12-11 10:02:59,999 DEBUG : BROWSER_OUTPUT: 10:03:02 INFO - 2015-12-11 10:03:02,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45339/tests/kraken/driver.html?testName=audio-dft) 10:03:03 INFO - 2015-12-11 10:03:03,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 143458304 10:03:03 INFO - 2015-12-11 10:03:03,351 DEBUG : BROWSER_OUTPUT: 10:03:06 INFO - 2015-12-11 10:03:06,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45339/tests/kraken/driver.html?testName=audio-fft) 10:03:06 INFO - 2015-12-11 10:03:06,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 137854976 10:03:06 INFO - 2015-12-11 10:03:06,870 DEBUG : BROWSER_OUTPUT: 10:03:08 INFO - 2015-12-11 10:03:08,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45339/tests/kraken/driver.html?testName=audio-oscillator) 10:03:09 INFO - 2015-12-11 10:03:09,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 138866688 10:03:09 INFO - 2015-12-11 10:03:09,550 DEBUG : BROWSER_OUTPUT: 10:03:11 INFO - 2015-12-11 10:03:11,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:12 INFO - 2015-12-11 10:03:12,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 140234752 10:03:12 INFO - 2015-12-11 10:03:12,385 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-12-11 10:03:15,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45339/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:16 INFO - 2015-12-11 10:03:16,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 141377536 10:03:16 INFO - 2015-12-11 10:03:16,027 DEBUG : BROWSER_OUTPUT: 10:03:19 INFO - 2015-12-11 10:03:19,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45339/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:20 INFO - 2015-12-11 10:03:20,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 139186176 10:03:20 INFO - 2015-12-11 10:03:20,079 DEBUG : BROWSER_OUTPUT: 10:03:22 INFO - 2015-12-11 10:03:22,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45339/tests/kraken/driver.html?testName=json-parse-financial) 10:03:23 INFO - 2015-12-11 10:03:23,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 137502720 10:03:23 INFO - 2015-12-11 10:03:23,580 DEBUG : BROWSER_OUTPUT: 10:03:25 INFO - 2015-12-11 10:03:25,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:25 INFO - 2015-12-11 10:03:25,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 140337152 10:03:25 INFO - 2015-12-11 10:03:25,941 DEBUG : BROWSER_OUTPUT: 10:03:27 INFO - 2015-12-11 10:03:27,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:28 INFO - 2015-12-11 10:03:28,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 139517952 10:03:28 INFO - 2015-12-11 10:03:28,436 DEBUG : BROWSER_OUTPUT: 10:03:30 INFO - 2015-12-11 10:03:30,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:03:31 INFO - 2015-12-11 10:03:31,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 10:03:31 INFO - 2015-12-11 10:03:31,196 DEBUG : BROWSER_OUTPUT: 10:03:33 INFO - 2015-12-11 10:03:33,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:34 INFO - 2015-12-11 10:03:34,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 140341248 10:03:34 INFO - 2015-12-11 10:03:34,346 DEBUG : BROWSER_OUTPUT: 10:03:36 INFO - 2015-12-11 10:03:36,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:37 INFO - 2015-12-11 10:03:37,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 10:03:37 INFO - 2015-12-11 10:03:37,587 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45339/tests/kraken/driver.html?testName=ai-astar) 10:03:39 INFO - 2015-12-11 10:03:39,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 140120064 10:03:39 INFO - 2015-12-11 10:03:39,612 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,613 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:39 INFO - 2015-12-11 10:03:39,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:39 INFO - 2015-12-11 10:03:39,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;115;114;113;124;113;112;112;114 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;130;161;170;137;160;160;132;163;137 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;162;166;165;175;163;163;162 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;72;73;73;132;74;72;73 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;95;94;135;95;95;132 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;110;110;110;110;111;110;109;110;111 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;147;148;147;149;147;147;147 10:03:39 INFO - 2015-12-11 10:03:39,615 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;96;96;96;97;96 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;75;75;74;73;75;73;72 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;71;68;68;68;69;69;69;69;68 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;93;84;85;84;85;83;91 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;129;119;134;127;137;127;122;120;124 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;151;148;142;149;137;148;153;165;151 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;69;70;72;73;73;70;72;71 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,786 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857019613__endTimestamp 10:03:39 INFO - 2015-12-11 10:03:39,616 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.90 (3.4%) stddev-sans-first:4.12 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 115.0 114.0 113.0 124.0 113.0 112.0 112.0 114.0 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.00 Median:160.00 stddev:15.06 (9.4%) stddev-sans-first:15.62 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: Values: 160.0 130.0 161.0 170.0 137.0 160.0 160.0 132.0 163.0 137.0 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.79 (2.3%) stddev-sans-first:4.01 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 162.0 166.0 165.0 175.0 163.0 163.0 162.0 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:72.50 stddev:18.81 (25.9%) stddev-sans-first:19.80 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 72.0 73.0 73.0 132.0 74.0 72.0 73.0 10:03:39 INFO - 2015-12-11 10:03:39,620 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:94.50 stddev:18.74 (19.8%) stddev-sans-first:19.44 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 95.0 94.0 135.0 95.0 95.0 132.0 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: Values: 112.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 111.0 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 147.0 148.0 147.0 149.0 147.0 147.0 147.0 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,621 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:74.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 75.0 75.0 74.0 73.0 75.0 73.0 72.0 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 68.0 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:3.47 (4.1%) stddev-sans-first:3.63 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 93.0 84.0 85.0 84.0 85.0 83.0 91.0 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:6.12 (4.8%) stddev-sans-first:6.11 10:03:39 INFO - 2015-12-11 10:03:39,622 DEBUG : BROWSER_OUTPUT: Values: 120.0 129.0 119.0 134.0 127.0 137.0 127.0 122.0 120.0 124.0 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.00 stddev:8.24 (5.5%) stddev-sans-first:7.70 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: Values: 137.0 151.0 148.0 142.0 149.0 137.0 148.0 153.0 165.0 151.0 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 69.0 70.0 72.0 73.0 73.0 70.0 72.0 71.0 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:39 INFO - 2015-12-11 10:03:39,623 DEBUG : BROWSER_OUTPUT: 10:03:40 INFO - 2015-12-11 10:03:40,540 INFO : Browser exited with error code: 0 10:03:40 INFO - 2015-12-11 10:03:40,591 INFO : Completed test kraken (00:01:01) 10:03:40 INFO - 2015-12-11 10:03:40,592 INFO : Starting test v8_7 10:03:40 INFO - 2015-12-11 10:03:40,592 DEBUG : operating with platform_type : linux_ 10:03:40 INFO - 2015-12-11 10:03:40,592 INFO : Initialising browser for v8_7 test... 10:03:40 INFO - 2015-12-11 10:03:40,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0J7FzJ/profile http://localhost:45339/getInfo.html 10:03:45 INFO - 2015-12-11 10:03:45,162 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:45 INFO - 2015-12-11 10:03:45,162 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:45 INFO - 2015-12-11 10:03:45,162 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:03:45 INFO - 2015-12-11 10:03:45,162 DEBUG : BROWSER_OUTPUT: __metrics 10:03:45 INFO - 2015-12-11 10:03:45,266 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] 10:03:46 INFO - 2015-12-11 10:03:46,155 INFO : Browser initialized. 10:03:46 INFO - 2015-12-11 10:03:46,156 INFO : Running cycle 1/1 for v8_7 test... 10:03:46 INFO - 2015-12-11 10:03:46,156 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0J7FzJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:03:58 INFO - 2015-12-11 10:03:58,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 142856192 10:03:58 INFO - 2015-12-11 10:03:58,215 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45339/tests/v8_7/run.html (next: http://localhost:45339/tests/v8_7/run.html) 10:04:19 INFO - 2015-12-11 10:04:19,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 138268672 10:04:19 INFO - 2015-12-11 10:04:19,894 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,895 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:19 INFO - 2015-12-11 10:04:19,896 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:19 INFO - 2015-12-11 10:04:19,896 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:19 INFO - 2015-12-11 10:04:19,896 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:19 INFO - 2015-12-11 10:04:19,897 DEBUG : BROWSER_OUTPUT: |0;Richards;164.74464579901152 10:04:19 INFO - 2015-12-11 10:04:19,897 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 10:04:19 INFO - 2015-12-11 10:04:19,897 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 10:04:19 INFO - 2015-12-11 10:04:19,897 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:04:19 INFO - 2015-12-11 10:04:19,898 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1076.4262648008612 10:04:19 INFO - 2015-12-11 10:04:19,898 DEBUG : BROWSER_OUTPUT: |5;Earley;747.9431563201197 10:04:19 INFO - 2015-12-11 10:04:19,898 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 10:04:19 INFO - 2015-12-11 10:04:19,898 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 10:04:19 INFO - 2015-12-11 10:04:19,898 DEBUG : BROWSER_OUTPUT: |8;Splay;599.880023995201 10:04:19 INFO - 2015-12-11 10:04:19,899 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:04:19 INFO - 2015-12-11 10:04:19,899 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:19 INFO - 2015-12-11 10:04:19,899 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857059894__endTimestamp 10:04:19 INFO - 2015-12-11 10:04:19,899 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,899 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.74 Median:164.74 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: Values: 164.7 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: Values: 185.6 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,900 DEBUG : BROWSER_OUTPUT: Values: 278.9 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: Values: 1076.4 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:747.94 Median:747.94 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: Values: 747.9 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: Values: 12072.3 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,901 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: Values: 25897.4 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.88 Median:599.88 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: Values: 599.9 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:19 INFO - 2015-12-11 10:04:19,902 DEBUG : BROWSER_OUTPUT: 10:04:20 INFO - 2015-12-11 10:04:20,852 INFO : Browser exited with error code: 0 10:04:20 INFO - 2015-12-11 10:04:20,866 INFO : Completed test v8_7 (00:00:40) 10:04:20 INFO - 2015-12-11 10:04:20,901 INFO : Completed test suite (00:20:16) 10:04:20 INFO - 2015-12-11 10:04:20,901 DEBUG : Working with test: dromaeo_css 10:04:20 INFO - 2015-12-11 10:04:20,901 DEBUG : Generating results file: dromaeo_css 10:04:20 INFO - 2015-12-11 10:04:20,902 DEBUG : Working with test: kraken 10:04:20 INFO - 2015-12-11 10:04:20,903 DEBUG : Generating results file: kraken 10:04:20 INFO - 2015-12-11 10:04:20,903 INFO : javascript benchmark 10:04:20 INFO - 2015-12-11 10:04:20,903 DEBUG : Working with test: v8_7 10:04:20 INFO - 2015-12-11 10:04:20,903 DEBUG : Generating results file: v8_7 10:04:20 INFO - 2015-12-11 10:04:20,904 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:20 INFO - 2015-12-11 10:04:20,956 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:04:20 INFO - 2015-12-11 10:04:20,956 DEBUG : process_Request line: dromaeo_css 6437.48 graph.html#tests=[[72,132,43]] 10:04:20 INFO - 2015-12-11 10:04:20,956 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:20 INFO - 2015-12-11 10:04:20,990 DEBUG : process_Request line: kraken 1541.20 graph.html#tests=[[232,132,43]] 10:04:20 INFO - 2015-12-11 10:04:20,990 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:21 INFO - 2015-12-11 10:04:21,020 DEBUG : process_Request line: v8_7 21310.27 graph.html#tests=[[230,132,43]] 10:04:21 INFO - 2015-12-11 10:04:21,021 INFO : javascript benchmark 10:04:21 INFO - 2015-12-11 10:04:21,025 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2669.6395986541816, 2726.0867609350867, 2748.6701595808495, 2767.1560174146884, 2783.638127043484, 4450.221211288028, 4765.261384485406, 4799.640026997976, 4807.0, 4827.710337379751, 4641.187792136371, 4643.489216186217, 4666.696664716791, 4747.359106520618, 4845.757712114398, 4330.761808100553, 4446.55534446556, 4449.866504004877, 4474.306482495218, 4514.345419914111, 4224.134052519242, 4366.541513141106, 4384.758838263894, 4384.934225986613, 4413.073254616518, 4328.761918094519, 4388.363687265361, 4416.53626369233, 4424.491183513905, 4459.799309031069, 4465.0, 4471.597556219924, 4478.865634030984, 4487.349334346502, 4517.616002639779, 4172.332426811696, 4276.935845962313, 4278.935815962763, 4440.178566965122, 4485.9551404485865, 4591.6097131743845, 4671.836485723017, 4686.95313046872, 4690.695104818176, 4694.037722266927, 5166.328377310963, 5179.352580927384, 5199.350081239845, 5204.791808327663, 5209.1404918188455, 4871.610271178297, 5011.123053465629, 5136.537711605936, 5186.351706036746, 5206.869828254286, 4717.8348757794, 4745.525447455296, 4758.762061896891, 4793.832215872428, 4810.230363141881, 5232.084385232569, 5249.133892907627, 5254.474552544715, 5257.737113144404, 5268.894622107537, 4818.68678535894, 4931.753412329369, 4955.083309587738, 5062.848114556569, 5102.489751024942, 5166.250893620404, 5181.222816577468, 5206.635535512478, 5225.085610018307, 5229.0, 5164.535191832753, 5164.7934082636275, 5165.793368265227, 5167.974160129175, 5195.532402083831, 4797.520247975174, 4915.606751459946, 4945.134601444733, 5034.521720436553, 5077.771500282496, 4281.507626622916, 4312.633426158749, 4335.631471324909, 4338.869833904988, 4360.345948107746, 3644.6355364463343, 3779.565349984732, 3798.0504873781556, 3800.7529510581726, 3844.4233364995475, 4315.568443155722, 4326.394304797331, 4384.495782984997, 4403.8458653946955, 4438.578335058164, 5102.5662818660085, 5151.098557752378, 5151.484851514819, 5158.716270605153, 5191.065608190486, 4195.643370313557, 4278.4010238566625, 4421.712588681789, 4423.867283981485, 4450.866474005785, 4530.592246697813, 4569.428821397325, 4603.217453032992, 4621.191291524037, 4644.419447569054, 4875.731834749123, 4877.12211801879, 4878.804847806048, 4887.218045112765, 4894.094592500328, 4872.878178045436, 5006.07387633289, 5017.0216807722145, 5169.405518365436, 5188.662736922088, 4887.48224387561, 4912.557869791593, 4918.1393256180745, 4918.532739389752, 4923.876903077452, 5153.871153221199, 5155.200943853709, 5170.991656626921, 5173.249878767633, 5202.193659982709, 4848.0546293472435, 4953.554180123806, 4963.478834722302, 4970.353853998957, 5237.319148510822, 4914.70511769295, 4925.605951523798, 4945.258211268195, 5026.0, 5061.038402703474, 5046.29351890743, 5059.139946209227, 5063.772130254074, 5064.518870707277, 5114.923276150935, 4696.553827386393, 4924.657500285016, 4953.356063711694, 4963.429205641253, 4970.975145124251, 4914.140025495595, 4951.678140920829, 4951.777170027285, 4990.750462476789, 5022.347094877789, 4927.310176575354, 4955.2567114933045, 4964.751762411793, 4969.105560998911, 5027.12025395547], "unit": "ms", "name": "dojo.html", "value": 4693.956039475124}, {"lowerIsBetter": false, "replicates": [559.2422267827094, 566.1931747260153, 567.0615131956611, 574.1473911241802, 615.8799034188335, 34655.0, 35140.82429587852, 35195.0, 35225.64774352256, 35283.4707479388, 36518.45222321667, 37124.07189820256, 37141.0, 37227.0, 37380.0, 7660.387169026479, 7831.686732530692, 7838.098618658842, 7841.764747057598, 7863.921360786405, 7681.155072941972, 7819.882701759479, 7846.372290216769, 7847.450678452511, 7867.567283799389, 7867.370610351159, 7962.044554653421, 8003.1996800320085, 8009.239122283374, 8018.959905200466, 7850.882236766453, 7923.405744569181, 7924.722634707815, 7925.484843485184, 7951.324137448353, 7710.498817576896, 7759.030121234846, 7804.414668899798, 7816.960915195387, 7827.452078354518, 33143.33713325744, 33433.6656633433, 33453.6654633453, 33609.49585756216, 33703.83148084244, 2935.838528880911, 2942.970570294291, 3052.801567898102, 3166.5566820645126, 3400.778949368283, 27634.585481217797, 27692.584611230846, 28039.719602804118, 28185.154445366672, 28715.712842871722, 3439.3809114359406, 3500.474928760681, 3553.982230088859, 3591.317649646559, 3597.5503062117236, 215748.0, 217503.0, 217766.0, 218648.9067554668, 218746.0, 50665.0, 51764.48235517597, 56697.0, 56995.15541179046, 63339.36660633427, 55576.72211638916, 55682.44317556854, 55960.72019639957, 56065.7196714022, 56119.43880561224, 12472.43874025671, 12540.372981350896, 12630.368481575884, 12637.747245055047, 12656.683582910317, 9766.169875560516, 9769.706908792748, 9785.510724463747, 9794.510274486389, 9800.215982721365, 19371.903140484206, 19827.900860495603, 19832.305869294505, 19875.105620247123, 19911.0, 7691.269329413697, 7885.44801863864, 7898.9210107899335, 7971.960140199262, 8087.919120808834, 809.3323008517996, 823.4359463767339, 908.504864848659, 950.021477877787, 978.848278516831, 26071.348216294366, 26263.343416414362, 26397.0, 29605.555916661266, 30835.229119272197, 929.2473096791485, 935.1571223480543, 975.5073687787764, 1045.5399624165343, 1067.0449947297125, 13569.52506662262, 13682.179069255877, 13979.930100349433, 13989.86010139906, 14000.159990400609, 309211.0, 312286.0, 315126.0, 315264.0, 318148.0, 45793.0, 46298.5370146301, 46461.76769116133, 46526.76736616363, 46638.0, 1166.5567084507832, 1238.8451443569554, 1250.7060840702427, 1252.4364036183572, 1254.5358217459598, 25973.870130649982, 26199.738002620492, 26283.211503654922, 26430.339241518348, 26450.867745661148, 39360.0, 39737.80131099326, 39769.0, 39813.20373592454, 39872.80063599663, 243778.0, 245580.0, 247064.0, 247161.0, 247445.0, 23895.163669272188, 24574.877125614257, 28210.15369538917, 29096.0, 29905.850470747508, 36103.638963611076, 36150.63849361473, 36203.63796362003, 36450.635493644724, 36869.078273043386, 31186.22034449157, 31419.0, 31727.524087139172, 32071.198220044687, 32111.839440802647, 31593.5260971081, 31661.8416907914, 31665.683343166274, 31685.841570792, 31907.36185276328, 31653.8417307912, 31834.840825795724, 31848.5222721664, 38162.0, 38615.0, 28628.85685571559, 29671.0, 29878.25304367408, 34092.488612671325, 35159.0, 23337.18319858797, 23801.0, 23841.284761457184, 23927.81263278954, 24225.0], "unit": "ms", "name": "ext.html", "value": 16775.001455654725}, {"lowerIsBetter": false, "replicates": [338.52775378347206, 338.6494977698082, 340.181862620398, 340.50456585667854, 340.9795412275262, 13007.479700811957, 14943.850561494382, 15018.0, 15722.764158537602, 16469.588260293498, 10092.949535252314, 10277.588896444153, 14364.856351436509, 16395.508134755975, 16499.927504712185, 4588.54114588541, 4694.272387779883, 6141.477974372184, 6344.873102537947, 6355.3009168991375, 6222.439980401763, 6291.842703932392, 6332.936670633304, 6645.235797883257, 6647.867042659144, 6195.65923874189, 6400.135981642466, 6410.519211059189, 6605.339466053404, 6614.50391220658, 6351.364863513635, 6373.968130159343, 6391.424771770539, 6752.966235168842, 6763.628000459973, 6440.1305823713665, 6470.0, 6484.286728459866, 6484.675766211718, 6489.4483968862705, 18868.0, 19452.319168829166, 19792.0, 19811.80188198114, 19821.125936739238, 1958.7649482062243, 1971.4972681966008, 1984.99007504963, 2042.428120126367, 2048.7541495020546, 13713.862861371359, 13919.164850109026, 14103.294835258299, 14148.858511414857, 14179.78730319046, 1857.3313607101434, 1869.3831035758167, 1927.11352777721, 1929.9903500482408, 1979.1786408640396, 50422.7478862607, 50472.24291635665, 51658.48341516612, 60754.69622651902, 65364.673176634285, 14821.555353339418, 15855.286512106983, 16056.357745690042, 16057.759133613004, 16072.678546429006, 23442.64836027461, 23519.0, 23648.0, 23786.405339866295, 23841.165559205343, 8226.794330141794, 8349.123342049119, 8380.413371064089, 8398.076211616717, 8411.53736544496, 6948.062011628466, 6979.616121113388, 6990.161180658353, 7019.824504387329, 7021.684024218923, 7777.1833957433655, 7844.843103137905, 7894.171112033268, 7900.209979002054, 7927.128015918244, 1751.570865138024, 1811.8369346758855, 3160.383725173615, 3164.525321201792, 3215.993046501482, 819.3117781063935, 823.300194834398, 854.3891117850642, 924.6024209589806, 954.3367359684952, 13365.0, 15810.17396388795, 15921.0, 15950.76073858893, 16000.919995399949, 778.8831675248645, 792.7502836606451, 843.0894633795486, 862.5169904853302, 902.4991129922824, 9006.954965225263, 9293.349465537347, 9339.252859771203, 9422.0, 9457.10157535033, 468967.0, 473081.0, 479130.0, 483233.0, 486896.0, 69221.0, 69841.65079174572, 71137.28862711307, 72705.0, 74269.6286518564, 1014.5130337437923, 1023.9948800255951, 1055.5619417941468, 1068.7435015596202, 1070.2454769387718, 14360.497382591559, 14432.0, 14557.854421456073, 14631.0, 14674.63313417173, 29484.852575736983, 30090.69909300879, 30483.0, 30676.233094172825, 31110.53334200034, 34643.82678086594, 36022.27955440929, 36232.0, 36486.817565912, 37035.25929481449, 8422.24199822019, 8749.868751968854, 9199.0, 9202.631894724136, 9210.95394523023, 10283.794324113625, 10372.896271037494, 15215.239238038275, 15445.768313475082, 16702.49892503227, 12839.358032098171, 13060.281684507443, 13166.605001849959, 13249.801252981406, 13598.660033499242, 12457.813132802834, 12970.156939798882, 12974.221546707227, 13112.344382780631, 13421.798673020108, 13086.803697944348, 13148.671283217996, 13207.66980825487, 13282.136661116996, 13422.731545368842, 8659.696910608098, 8889.19997200255, 8902.287816974496, 8947.0, 9064.50145242018, 8979.191872731486, 11561.42192890369, 14152.646183845074, 14393.85606143967, 14402.639934001734], "unit": "ms", "name": "jquery.html", "value": 9099.332855608207}, {"lowerIsBetter": false, "replicates": [1427.55032164868, 1641.1302009934734, 1698.8216237295085, 1716.733906244531, 1730.9394171204005, 6663.466922646189, 6857.931420685792, 7077.256888026747, 7102.751403700865, 7105.467089968253, 7057.89413158803, 7089.5037347385705, 7193.4245260379175, 7226.0, 7241.927580724191, 2090.1221486975505, 2121.63932131538, 2122.299641118435, 2126.4258650164447, 2133.9146434142617, 2099.4121645939085, 2101.3695891232646, 2108.4412630652814, 2109.04038662409, 2125.670521069229, 1999.4201681512343, 2025.4227545149636, 2053.496893261153, 2056.670932650776, 2060.0626714844784, 2079.116375540397, 2107.230860735836, 2120.8303335733103, 2121.2787652198326, 2122.3420739570706, 2058.5882823435372, 2077.241806740544, 2097.769245383007, 2100.7689154193026, 2106.3470324199548, 7196.1724401693955, 7223.349898509159, 7224.349808517259, 7239.638018099126, 7269.709211631528, 4154.252234597771, 4223.324268117117, 4248.426462427564, 4248.745075295492, 4266.765327906964, 2739.4384151248946, 2768.349437882096, 2800.0339882740627, 2830.448062627788, 2831.7876159288135, 860.1871231686059, 872.7250915961451, 886.6453418632534, 894.7494701483595, 904.2946501728662, 9291.070892910722, 9344.205742511827, 9470.289728270338, 9506.90493095074, 9512.429254244767, 3616.4936908832783, 3681.9447708284397, 3703.851845926187, 3902.453656488094, 3927.7446965947124, 7556.773296801105, 7563.73526926566, 7581.166071732105, 7595.962020189863, 7604.8479030419085, 4208.242516347087, 4233.153369326147, 4243.724157929724, 4247.426597409372, 4268.91462170761, 3874.6125387461593, 3881.825317860703, 3881.922361552753, 3892.6885849132, 3925.842966281317, 2962.7333539981505, 2986.5669477926012, 3029.606151200374, 3040.452718510645, 3041.2092855857636, 887.4808237181193, 892.794657228828, 899.8290324838259, 903.9864402033975, 904.624580798961, 749.4192001199006, 750.0699133074947, 804.5454318310136, 831.7878940870161, 943.3160958305311, 6519.413252807175, 6600.306967768412, 6617.04052912325, 6618.205815302194, 6658.067870498134, 571.0691572736413, 574.2964868036622, 581.4911952041963, 589.8761260135334, 736.054170391045, 5004.0, 5032.899342013213, 5042.193249080129, 5048.495150484996, 5076.593872490266, 7981.880271795928, 8454.154584541497, 8482.10937851529, 8501.914980850112, 8518.23335899772, 8300.294474969694, 8317.251447369767, 8321.791955201048, 8325.66697332112, 8400.495970241805, 6527.902081468782, 6529.510286728514, 6573.5398522103, 6577.210734711865, 6618.867622647616, 6345.365463453618, 6366.9681651591445, 6390.041493775785, 6395.488360931021, 6404.807855764335, 7368.336849683555, 7499.437542184249, 7512.737054203077, 7523.887141692989, 7679.462437629536, 7570.848583028419, 7679.193684663253, 7726.961365193138, 7780.299773020455, 7898.723544675909, 5839.824805255849, 5897.262842144732, 5906.143609176559, 5910.734016969161, 5912.349641539513, 6170.691465426621, 6297.338779428277, 6303.716332764945, 6330.082138090043, 6331.05034244867, 6020.608660437058, 6127.142200091902, 6130.049842274455, 6207.193064901534, 6257.217847769029, 5713.857153571194, 6131.141640170469, 6216.316205217513, 6255.374462553708, 6326.367363263636, 6404.231492220963, 6423.903641445476, 6459.192600924885, 6463.7737679181, 6472.417482426604, 5619.971900140473, 5651.067573850269, 5691.430856914276, 5691.800786972436, 5750.13747937796, 5934.643921364732, 5953.226080609493, 5954.166416701752, 5955.642661440327, 5977.22296101504], "unit": "ms", "name": "mootools.html", "value": 3932.9017823418963}, {"lowerIsBetter": false, "replicates": [300.3032963524622, 304.38362316309485, 310.3018209029683, 311.02338656618224, 312.61236067276576, 5495.945040549594, 5555.749991250394, 5587.469190426913, 5606.187102870082, 5655.066913959197, 5544.889102217953, 5620.747066382012, 5624.465675760806, 5633.746481408336, 5645.717714114298, 4165.958340416602, 4286.39990401344, 4330.047389574296, 4332.2851729464755, 4338.609525142752, 4285.035866929947, 4295.742255464666, 4296.5273819879785, 4307.655387569002, 4313.396124542551, 4244.27847265964, 4252.681048921328, 4254.808533615995, 4260.552641972595, 4261.829526818923, 4246.723962942429, 4247.044415006645, 4250.3836943643155, 4254.553271906436, 4280.229558679436, 3626.528551288342, 3709.5733990591157, 3709.647583479565, 3710.888673339777, 3718.219173973469, 5242.737863106868, 5356.919646205271, 5408.13469844823, 5414.91877621836, 5426.62013659044, 4950.801967921278, 4955.603551715854, 4960.33035540201, 4961.776720047606, 4969.726665033421, 5976.790812321591, 5983.1025346197985, 5991.910121348184, 5993.460588547008, 5993.460588547052, 3910.511186101737, 4050.0887300357185, 4056.1887622475624, 4057.087155390014, 4066.2680717470844, 6178.938210617881, 6248.437640612321, 6254.937450625481, 6260.342664020258, 6264.0, 4176.352665336878, 4189.622933935961, 4200.6219440249915, 4204.495460544693, 4218.704690671623, 4257.978710106491, 4281.422008028876, 4282.250606143974, 4282.89292767677, 4284.935725964113, 4747.548982846624, 4891.559759621651, 4932.827351042696, 4940.258961155783, 4951.653384263139, 5961.5230781537375, 5964.8807023860145, 5970.731317090741, 5976.6115202512565, 5980.611260268069, 1481.052126638952, 1487.6504021554927, 1493.0742939377656, 1495.6111411032991, 1506.344740038087, 982.3074732313702, 983.5646349499937, 1000.6947880896397, 1015.3501758874327, 1019.9847002294972, 5128.25640282157, 5129.435762066169, 5136.640435169502, 5141.28022076902, 5145.382554093533, 6170.167027451236, 6176.135341052256, 6179.0422484514975, 6179.104029915727, 6183.783567575203, 5108.923366149511, 5119.334486516729, 5120.871978200575, 5121.667091639106, 5126.512981266774, 3180.920476988094, 3285.852136653856, 3297.884574039897, 3299.670032996681, 3329.716974057232, 5633.802816901389, 5749.0, 5792.9710351447975, 5802.071668533014, 5812.6221795584, 6374.171357723466, 6388.552801303864, 6404.647744374104, 6417.679116044179, 6431.903521447182, 5736.741846616912, 5774.0761478163295, 5774.335951365562, 5776.277965254427, 5781.075027995501, 5925.644461332334, 6136.5090792737365, 6166.321704612579, 6188.9690551546955, 6191.907121393093, 5967.582269241111, 6068.696565171812, 6070.423309785563, 6073.817785466266, 6083.422074902877, 5734.992752536746, 5735.598508104393, 5764.827055188351, 5789.33422656383, 5794.420557944172, 4180.83276668942, 4218.894527636711, 4228.365745138254, 4232.534421213725, 4235.661147108285, 6021.698915054142, 6155.0, 6181.103739957771, 6182.381761823782, 6201.193844800147, 5922.437368449991, 5927.2590926134235, 5941.58408911372, 5943.108533719977, 5953.583249172516, 5930.555208359477, 5941.792037278675, 5946.791862284799, 5955.5235581154275, 5960.433758792908, 5706.372299047184, 5719.256496655575, 5812.7674893003805, 5814.331351894586, 5816.01127808282, 5894.528437724886, 5945.762169513344, 5973.641581505123, 5979.431953964367, 6005.729742161526, 5764.971175144097, 5797.391273916178, 5803.593748437569, 5805.680687562224, 5808.73860676279], "unit": "ms", "name": "prototype.html", "value": 4415.535572348686}, {"lowerIsBetter": false, "replicates": [654.110409842614, 661.9238787539434, 702.7926761605324, 751.6880494594743, 765.5865832450477, 11251.381174035425, 11455.198136130473, 11461.0, 11472.426378681064, 11515.942420287907, 13067.215967041984, 13253.403596838141, 13255.46978120874, 13264.801027984588, 13279.070465067449, 797.7566842113167, 810.0360570920585, 813.1746277528314, 832.4256263178418, 838.9580520973957, 811.3995643224031, 813.9633716482742, 817.0971076959963, 818.7830224990382, 822.5558198572763, 860.3418384935499, 861.2937391339104, 862.7886167888876, 866.1338661338661, 868.6308318964415, 856.7729551668813, 860.3117505995178, 862.2843040276556, 863.4991704811226, 865.0484467086218, 629.3989240275572, 630.3318482408615, 633.4172561243666, 633.771842136835, 639.9552031357761, 11394.715132121763, 11495.482703278372, 11526.077913766878, 11594.826077608843, 11606.071514278838, 11371.886281137165, 11397.202195846294, 11803.11476639247, 12061.939690301493, 12378.0, 8629.568521573896, 8899.33255005877, 8990.730278091667, 9284.72145835626, 9478.336516443851, 3143.858526366319, 3192.74458043356, 3272.803631782077, 3312.867485300585, 3319.3859136059664, 40456.59543404587, 40643.0, 40826.38760418596, 41045.0, 41112.38331425031, 9454.196393306645, 9532.18976387001, 9603.855942160873, 9736.0, 9741.756456088513, 17207.655846882994, 17479.0, 17491.650166996587, 17496.125193740263, 17517.47447576549, 6302.212223472066, 6310.5898116622275, 6370.649614271259, 6373.52198585108, 6442.355764423613, 3473.149078475739, 3493.2314890724, 3524.6827785499427, 3639.872604458831, 3649.4525821127045, 2546.414324705328, 2577.87110644467, 2578.3940773918116, 2582.0, 2584.6123081537544, 470.5388719055345, 477.48193210366446, 479.0538686095004, 482.1658530741766, 482.38014151814747, 499.338376650939, 516.7158063065299, 523.8480840556196, 546.3171036204744, 561.166667498764, 7279.944408060802, 7307.525010874276, 7406.07424071991, 7582.938388625596, 7626.351760100342, 481.78078974066716, 510.6655140882728, 536.1555550008752, 545.0162456765577, 580.851882769891, 3379.831008449568, 3599.6220396858475, 3606.4229723244157, 3647.8723244686307, 3749.981250093732, 48793.51206487961, 48983.510164897896, 49518.50481495211, 49525.75237123863, 49793.75103124461, 44467.55532444699, 46498.30252546147, 47172.0, 47623.761881190374, 47830.0, 40173.0, 40468.0, 40917.38623920643, 40975.0, 41088.1782364351, 7734.845303094019, 7795.532268063935, 8179.345652347679, 8341.332693384393, 8563.61463734146, 30871.691283086882, 30874.382512350076, 31168.376632467676, 31464.37071258516, 31735.206619834687, 36004.0, 38774.4183837237, 39525.40711889382, 40066.1986760269, 40239.0, 9536.189423899046, 9689.9031009689, 9761.658341957997, 9794.21646268311, 10074.44590547527, 11099.72250693739, 11108.277961932448, 11129.443527823414, 11186.440677966231, 11596.942015290208, 9880.258980576342, 9942.403455792675, 10049.246306527186, 10159.339642923187, 10872.130229581773, 10265.423456164843, 10327.0, 10365.274430789772, 10520.473976301308, 10547.630832920811, 10349.586016559253, 10787.514561844893, 10804.891951080388, 10873.07578855806, 10895.618653347095, 8633.093525179765, 9033.593488293174, 9041.186293233377, 9215.308851836005, 9295.953520232355, 8655.740327790176, 8760.51817150063, 8792.692255771017, 9344.813103738023, 9460.858087128836], "unit": "ms", "name": "yui.html", "value": 5719.269221352585}], "name": "dromaeo_css", "value": 6437.477211577083}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 115.0, 114.0, 113.0, 124.0, 113.0, 112.0, 112.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 161.0, 170.0, 137.0, 160.0, 160.0, 132.0, 163.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 162.0, 166.0, 165.0, 175.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 132.0, 74.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 95.0, 94.0, 135.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 75.0, 75.0, 74.0, 73.0, 75.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 93.0, 84.0, 85.0, 84.0, 85.0, 83.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 119.0, 134.0, 127.0, 137.0, 127.0, 122.0, 120.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [137.0, 151.0, 148.0, 142.0, 149.0, 137.0, 148.0, 153.0, 165.0, 151.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 69.0, 70.0, 72.0, 73.0, 73.0, 70.0, 72.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1541.1999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.74464579901152], "unit": "score", "name": "Richards", "value": 214.28313999999997}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [747.9431563201197], "unit": "score", "name": "Earley", "value": 891.0610309999998}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [599.880023995201], "unit": "score", "name": "Splay", "value": 135.84549700000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21310.26645023282}]} 10:04:21 INFO - RETURN: dromaeo_css: 6437.48 10:04:21 INFO - RETURN: kraken: 1541.20 10:04:21 INFO - RETURN: v8_7: 21310.27 10:04:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21310.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1541.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6437.48"}}} 10:04:21 INFO - Return code: 0 10:04:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:04:21 INFO - # TBPL SUCCESS # 10:04:21 INFO - Running post-action listener: _resource_record_post_action 10:04:21 INFO - Running post-run listener: _resource_record_post_run 10:04:22 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 518209536; Read time: 0; Write time: 654628 10:04:22 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 239734784; Read time: 0; Write time: 392824 10:04:22 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 274464768; Read time: 0; Write time: 261096 10:04:22 INFO - Running post-run listener: _upload_blobber_files 10:04:22 INFO - Blob upload gear active. 10:04:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:04:22 INFO - Copying logs to upload dir... 10:04:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.942751 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-11 10:04:21.126832) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:04:21.129858) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009912 build_url: 'https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/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-11 10:04:21.180085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:04:21.180400) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449850992.556724-1249895538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:04:21.230161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:04:21.230487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:04:21.230769) ========= ========= Total master_lag: 0.23 =========