builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1448558489.3 results: success (0) buildid: 20151126075510 builduid: f477684d07c94501a41f725dcaef228f revision: 74c7941a9e22d50057800771ebae07f69deecc9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.304544) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.305037) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.305363) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005619 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.322885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.323279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.332540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.332957) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004274 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.382333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.382677) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.383130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.383442) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 09:21:29-- 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% 15.9M=0.001s 2015-11-26 09:21:29 (15.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.587432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.587898) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.638718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:29.639167) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 74c7941a9e22d50057800771ebae07f69deecc9f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 74c7941a9e22d50057800771ebae07f69deecc9f --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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 09:21:29,969 truncating revision to first 12 chars 2015-11-26 09:21:29,969 Setting DEBUG logging. 2015-11-26 09:21:29,969 attempt 1/10 2015-11-26 09:21:29,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/74c7941a9e22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 09:21:30,240 unpacking tar archive at: mozilla-central-74c7941a9e22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:30.229238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:30.229649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:30.242773) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:30.243183) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:21:30.243668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 09:21:30.244012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:30 INFO - MultiFileLogger online at 20151126 09:21:30 in /builds/slave/test 09:21:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:21:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:30 INFO - {'append_to_log': False, 09:21:30 INFO - 'base_work_dir': '/builds/slave/test', 09:21:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:21:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:30 INFO - 'branch': 'Firefox-Non-PGO', 09:21:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:30 INFO - 'config_files': ('talos/linux_config.py',), 09:21:30 INFO - 'default_actions': ('clobber', 09:21:30 INFO - 'read-buildbot-config', 09:21:30 INFO - 'download-and-extract', 09:21:30 INFO - 'populate-webroot', 09:21:30 INFO - 'create-virtualenv', 09:21:30 INFO - 'install', 09:21:30 INFO - 'run-tests'), 09:21:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:30 INFO - 'download_minidump_stackwalk': True, 09:21:30 INFO - 'download_symbols': 'ondemand', 09:21:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:30 INFO - 'installer_path': 'installer.exe', 09:21:30 INFO - 'log_level': 'info', 09:21:30 INFO - 'log_name': 'talos', 09:21:30 INFO - 'log_to_console': True, 09:21:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:30 INFO - 'opt_config_files': (), 09:21:30 INFO - 'pip_index': False, 09:21:30 INFO - 'sps_profile': False, 09:21:30 INFO - 'sps_profile_interval': 0, 09:21:30 INFO - 'suite': 'dromaeojs', 09:21:30 INFO - 'system_bits': '64', 09:21:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:30 INFO - 'title': 'talos-linux64-ix-023', 09:21:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:30 INFO - 'use_talos_json': True, 09:21:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:30 INFO - 'work_dir': 'build'} 09:21:30 INFO - ##### 09:21:30 INFO - ##### Running clobber step. 09:21:30 INFO - ##### 09:21:30 INFO - Running pre-action listener: _resource_record_pre_action 09:21:30 INFO - Running main action method: clobber 09:21:30 INFO - rmtree: /builds/slave/test/build 09:21:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:31 INFO - Running post-action listener: _resource_record_post_action 09:21:31 INFO - ##### 09:21:31 INFO - ##### Running read-buildbot-config step. 09:21:31 INFO - ##### 09:21:31 INFO - Running pre-action listener: _resource_record_pre_action 09:21:31 INFO - Running main action method: read_buildbot_config 09:21:31 INFO - Using buildbot properties: 09:21:31 INFO - { 09:21:31 INFO - "properties": { 09:21:31 INFO - "buildnumber": 379, 09:21:31 INFO - "product": "firefox", 09:21:31 INFO - "script_repo_revision": "production", 09:21:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:21:31 INFO - "repository": "", 09:21:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:21:31 INFO - "buildid": "20151126075510", 09:21:31 INFO - "slavename": "talos-linux64-ix-023", 09:21:31 INFO - "pgo_build": "False", 09:21:31 INFO - "basedir": "/builds/slave/test", 09:21:31 INFO - "project": "", 09:21:31 INFO - "platform": "ubuntu64_hw", 09:21:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:21:31 INFO - "slavebuilddir": "test", 09:21:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:21:31 INFO - "branch": "mozilla-central", 09:21:31 INFO - "repo_path": "mozilla-central", 09:21:31 INFO - "stage_platform": "linux64", 09:21:31 INFO - "builduid": "f477684d07c94501a41f725dcaef228f", 09:21:31 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:21:31 INFO - }, 09:21:31 INFO - "sourcestamp": { 09:21:31 INFO - "repository": "", 09:21:31 INFO - "hasPatch": false, 09:21:31 INFO - "project": "", 09:21:31 INFO - "branch": "mozilla-central-linux64-talos", 09:21:31 INFO - "changes": [ 09:21:31 INFO - { 09:21:31 INFO - "category": null, 09:21:31 INFO - "files": [ 09:21:31 INFO - { 09:21:31 INFO - "url": null, 09:21:31 INFO - "name": "https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:21:31 INFO - } 09:21:31 INFO - ], 09:21:31 INFO - "repository": "", 09:21:31 INFO - "rev": "74c7941a9e22d50057800771ebae07f69deecc9f", 09:21:31 INFO - "who": "cbook@mozilla.com", 09:21:31 INFO - "when": 1448558386, 09:21:31 INFO - "number": 6711725, 09:21:31 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 09:21:31 INFO - "project": "", 09:21:31 INFO - "at": "Thu 26 Nov 2015 09:19:46", 09:21:31 INFO - "branch": "mozilla-central-linux64-talos", 09:21:31 INFO - "revlink": "", 09:21:31 INFO - "properties": [ 09:21:31 INFO - [ 09:21:31 INFO - "buildid", 09:21:31 INFO - "20151126075510", 09:21:31 INFO - "Change" 09:21:31 INFO - ], 09:21:31 INFO - [ 09:21:31 INFO - "builduid", 09:21:31 INFO - "f477684d07c94501a41f725dcaef228f", 09:21:31 INFO - "Change" 09:21:31 INFO - ], 09:21:31 INFO - [ 09:21:31 INFO - "pgo_build", 09:21:31 INFO - "False", 09:21:31 INFO - "Change" 09:21:31 INFO - ] 09:21:31 INFO - ], 09:21:31 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:21:31 INFO - } 09:21:31 INFO - ], 09:21:31 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:21:31 INFO - } 09:21:31 INFO - } 09:21:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:21:31 INFO - Running post-action listener: _resource_record_post_action 09:21:31 INFO - ##### 09:21:31 INFO - ##### Running download-and-extract step. 09:21:31 INFO - ##### 09:21:31 INFO - Running pre-action listener: _resource_record_pre_action 09:21:31 INFO - Running main action method: download_and_extract 09:21:31 INFO - mkdir: /builds/slave/test/build/tests 09:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:31 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json 09:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json 09:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:21:31 INFO - Downloaded 1302 bytes. 09:21:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:21:31 INFO - Using the following test package requirements: 09:21:31 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'jsshell-linux-x86_64.zip'], 09:21:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:21:31 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:21:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:31 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:33 INFO - Downloaded 21515050 bytes. 09:21:33 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:21:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:33 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:21:34 INFO - Return code: 0 09:21:34 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:21:34 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:21:34 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:35 INFO - Downloaded 21515050 bytes. 09:21:35 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:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:21:35 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:21:36 INFO - Return code: 0 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:36 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:21:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:37 INFO - Downloaded 11131728 bytes. 09:21:37 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:21:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:37 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:21:37 INFO - Return code: 0 09:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:37 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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:21:38 INFO - Downloaded 56868239 bytes. 09:21:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:21:38 INFO - mkdir: /builds/slave/test/properties 09:21:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:38 INFO - Contents: 09:21:38 INFO - build_url:https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:21:38 INFO - Running post-action listener: _resource_record_post_action 09:21:38 INFO - Running post-action listener: set_extra_try_arguments 09:21:38 INFO - ##### 09:21:38 INFO - ##### Running populate-webroot step. 09:21:38 INFO - ##### 09:21:38 INFO - Running pre-action listener: _resource_record_pre_action 09:21:38 INFO - Running main action method: populate_webroot 09:21:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:21:38 INFO - '../fennec_ids.txt'], 09:21:38 INFO - 'tests': ['tcheck2']}, 09:21:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:38 INFO - '--tppagecycles', 09:21:38 INFO - '7'], 09:21:38 INFO - 'tests': ['tsvgm']}}, 09:21:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:21:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:21:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:21:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'tests': ['damp', 'tps']}, 09:21:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['damp', 'tps']}, 09:21:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:21:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:38 INFO - 'other': {'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'other_l64': {'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'other_nol64': {'tests': ['a11yr', 09:21:38 INFO - 'ts_paint', 09:21:38 INFO - 'tpaint', 09:21:38 INFO - 'sessionrestore', 09:21:38 INFO - 'sessionrestore_no_auto_restore']}, 09:21:38 INFO - 'svgr': {'tests': ['tsvgx', 09:21:38 INFO - 'tsvgr_opacity', 09:21:38 INFO - 'tart', 09:21:38 INFO - 'tscrollx', 09:21:38 INFO - 'cart']}, 09:21:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['tsvgx', 09:21:38 INFO - 'tsvgr_opacity', 09:21:38 INFO - 'tart', 09:21:38 INFO - 'tscrollx', 09:21:38 INFO - 'cart']}, 09:21:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'tests': ['tp5o']}, 09:21:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'talos_options': ['--e10s'], 09:21:38 INFO - 'tests': ['tp5o']}, 09:21:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'talos_options': ['--xperf_path', 09:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:38 INFO - 'tests': ['tp5n']}, 09:21:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:38 INFO - 'talos_options': ['--e10s', 09:21:38 INFO - '--xperf_path', 09:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:38 INFO - 'tests': ['tp5n']}}, 09:21:38 INFO - 'talos.zip': {'path': '', 09:21:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:38 INFO - Running post-action listener: _resource_record_post_action 09:21:38 INFO - ##### 09:21:38 INFO - ##### Running create-virtualenv step. 09:21:38 INFO - ##### 09:21:38 INFO - Running pre-action listener: _resource_record_pre_action 09:21:38 INFO - Running main action method: create_virtualenv 09:21:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:38 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:21:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:39 INFO - Using real prefix '/usr' 09:21:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:41 INFO - Installing pip.................done. 09:21:41 INFO - Return code: 0 09:21:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:41 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:21:41 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:21:41 INFO - Using env: {'DISPLAY': ':0', 09:21:41 INFO - 'HOME': '/home/cltbld', 09:21:41 INFO - 'LANG': 'en_US.UTF-8', 09:21:41 INFO - 'LANGUAGE': 'en_US:en', 09:21:41 INFO - 'LOGNAME': 'cltbld', 09:21:41 INFO - 'MAIL': '/var/mail/cltbld', 09:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:41 INFO - 'MOZ_NO_REMOTE': '1', 09:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:41 INFO - 'NO_EM_RESTART': '1', 09:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:41 INFO - 'PWD': '/builds/slave/test', 09:21:41 INFO - 'SHELL': '/bin/bash', 09:21:41 INFO - 'SHLVL': '1', 09:21:41 INFO - 'TERM': 'linux', 09:21:41 INFO - 'TMOUT': '86400', 09:21:41 INFO - 'USER': 'cltbld', 09:21:41 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:41 INFO - '_': '/tools/buildbot/bin/python'} 09:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:41 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:21:41 INFO - Cleaning up... 09:21:41 INFO - Return code: 0 09:21:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:41 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:21:41 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:21:41 INFO - Using env: {'DISPLAY': ':0', 09:21:41 INFO - 'HOME': '/home/cltbld', 09:21:41 INFO - 'LANG': 'en_US.UTF-8', 09:21:41 INFO - 'LANGUAGE': 'en_US:en', 09:21:41 INFO - 'LOGNAME': 'cltbld', 09:21:41 INFO - 'MAIL': '/var/mail/cltbld', 09:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:41 INFO - 'MOZ_NO_REMOTE': '1', 09:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:41 INFO - 'NO_EM_RESTART': '1', 09:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:41 INFO - 'PWD': '/builds/slave/test', 09:21:41 INFO - 'SHELL': '/bin/bash', 09:21:41 INFO - 'SHLVL': '1', 09:21:41 INFO - 'TERM': 'linux', 09:21:41 INFO - 'TMOUT': '86400', 09:21:41 INFO - 'USER': 'cltbld', 09:21:41 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:41 INFO - '_': '/tools/buildbot/bin/python'} 09:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:41 INFO - Downloading/unpacking psutil>=0.7.1 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:21:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:43 INFO - Installing collected packages: psutil 09:21:43 INFO - Running setup.py install for psutil 09:21:43 INFO - building 'psutil._psutil_linux' extension 09:21:43 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:21:44 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:21:44 INFO - building 'psutil._psutil_posix' extension 09:21:44 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:21:44 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:21:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:44 INFO - Successfully installed psutil 09:21:44 INFO - Cleaning up... 09:21:44 INFO - Return code: 0 09:21:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:44 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:21:44 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:21:44 INFO - Using env: {'DISPLAY': ':0', 09:21:44 INFO - 'HOME': '/home/cltbld', 09:21:44 INFO - 'LANG': 'en_US.UTF-8', 09:21:44 INFO - 'LANGUAGE': 'en_US:en', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MAIL': '/var/mail/cltbld', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SHLVL': '1', 09:21:44 INFO - 'TERM': 'linux', 09:21:44 INFO - 'TMOUT': '86400', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - '_': '/tools/buildbot/bin/python'} 09:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:21: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:21: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:21: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:21: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:21: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:21: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:21:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:21:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:46 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:21:46 INFO - Installing collected packages: mozsystemmonitor 09:21:46 INFO - Running setup.py install for mozsystemmonitor 09:21:46 INFO - Successfully installed mozsystemmonitor 09:21:46 INFO - Cleaning up... 09:21:46 INFO - Return code: 0 09:21:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:46 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:21:46 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:21:46 INFO - Using env: {'DISPLAY': ':0', 09:21:46 INFO - 'HOME': '/home/cltbld', 09:21:46 INFO - 'LANG': 'en_US.UTF-8', 09:21:46 INFO - 'LANGUAGE': 'en_US:en', 09:21:46 INFO - 'LOGNAME': 'cltbld', 09:21:46 INFO - 'MAIL': '/var/mail/cltbld', 09:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:46 INFO - 'MOZ_NO_REMOTE': '1', 09:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:46 INFO - 'NO_EM_RESTART': '1', 09:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:46 INFO - 'PWD': '/builds/slave/test', 09:21:46 INFO - 'SHELL': '/bin/bash', 09:21:46 INFO - 'SHLVL': '1', 09:21:46 INFO - 'TERM': 'linux', 09:21:46 INFO - 'TMOUT': '86400', 09:21:46 INFO - 'USER': 'cltbld', 09:21:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:46 INFO - '_': '/tools/buildbot/bin/python'} 09:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 INFO - Downloading docopt-0.6.1.tar.gz 09:21:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:48 INFO - Running setup.py install for blobuploader 09:21:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:49 INFO - Running setup.py install for requests 09:21:49 INFO - Running setup.py install for docopt 09:21:49 INFO - Successfully installed blobuploader requests docopt 09:21:49 INFO - Cleaning up... 09:21:49 INFO - Return code: 0 09:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:49 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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:49 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:21:49 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:21:49 INFO - Using env: {'DISPLAY': ':0', 09:21:49 INFO - 'HOME': '/home/cltbld', 09:21:49 INFO - 'LANG': 'en_US.UTF-8', 09:21:49 INFO - 'LANGUAGE': 'en_US:en', 09:21:49 INFO - 'LOGNAME': 'cltbld', 09:21:49 INFO - 'MAIL': '/var/mail/cltbld', 09:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:49 INFO - 'MOZ_NO_REMOTE': '1', 09:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:49 INFO - 'NO_EM_RESTART': '1', 09:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:49 INFO - 'PWD': '/builds/slave/test', 09:21:49 INFO - 'SHELL': '/bin/bash', 09:21:49 INFO - 'SHLVL': '1', 09:21:49 INFO - 'TERM': 'linux', 09:21:49 INFO - 'TMOUT': '86400', 09:21:49 INFO - 'USER': 'cltbld', 09:21:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:49 INFO - '_': '/tools/buildbot/bin/python'} 09:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:49 INFO - Running setup.py (path:/tmp/pip-l_VRWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:49 INFO - Running setup.py (path:/tmp/pip-d4zpCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:49 INFO - Running setup.py (path:/tmp/pip-mudNRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:50 INFO - Running setup.py (path:/tmp/pip-0uGflb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:50 INFO - Running setup.py (path:/tmp/pip-uupiY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:50 INFO - Running setup.py (path:/tmp/pip-URdouG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:50 INFO - Running setup.py (path:/tmp/pip-Zij0rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:50 INFO - Running setup.py (path:/tmp/pip-i6qauM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:50 INFO - Running setup.py (path:/tmp/pip-PsNgZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:50 INFO - Running setup.py (path:/tmp/pip-hO_eXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:50 INFO - Running setup.py (path:/tmp/pip-L2a27C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:50 INFO - Running setup.py (path:/tmp/pip-Fvcsgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:50 INFO - Running setup.py (path:/tmp/pip-Y5YMcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:50 INFO - Running setup.py (path:/tmp/pip-yDigWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:50 INFO - Running setup.py (path:/tmp/pip-niWJ2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:50 INFO - Running setup.py (path:/tmp/pip-cn28vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:50 INFO - Running setup.py (path:/tmp/pip-vfQkGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:51 INFO - Running setup.py install for manifestparser 09:21:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Running setup.py install for mozcrash 09:21:51 INFO - Running setup.py install for mozdebug 09:21:51 INFO - Running setup.py install for mozdevice 09:21:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Running setup.py install for mozfile 09:21:51 INFO - Running setup.py install for mozhttpd 09:21:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Running setup.py install for mozinfo 09:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Running setup.py install for mozInstall 09:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Running setup.py install for mozleak 09:21:51 INFO - Running setup.py install for mozlog 09:21:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for moznetwork 09:21:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for mozprocess 09:21:52 INFO - Running setup.py install for mozprofile 09:21:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for mozrunner 09:21:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Running setup.py install for mozscreenshot 09:21:52 INFO - Running setup.py install for moztest 09:21:52 INFO - Running setup.py install for mozversion 09:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:52 INFO - Cleaning up... 09:21:52 INFO - Return code: 0 09:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:52 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:21:52 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:21:52 INFO - Using env: {'DISPLAY': ':0', 09:21:52 INFO - 'HOME': '/home/cltbld', 09:21:52 INFO - 'LANG': 'en_US.UTF-8', 09:21:52 INFO - 'LANGUAGE': 'en_US:en', 09:21:52 INFO - 'LOGNAME': 'cltbld', 09:21:52 INFO - 'MAIL': '/var/mail/cltbld', 09:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:52 INFO - 'MOZ_NO_REMOTE': '1', 09:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:52 INFO - 'NO_EM_RESTART': '1', 09:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:52 INFO - 'PWD': '/builds/slave/test', 09:21:52 INFO - 'SHELL': '/bin/bash', 09:21:52 INFO - 'SHLVL': '1', 09:21:52 INFO - 'TERM': 'linux', 09:21:52 INFO - 'TMOUT': '86400', 09:21:52 INFO - 'USER': 'cltbld', 09:21:52 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:52 INFO - '_': '/tools/buildbot/bin/python'} 09:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:52 INFO - Running setup.py (path:/tmp/pip-G15DLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:53 INFO - Running setup.py (path:/tmp/pip-F1uDG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:53 INFO - Running setup.py (path:/tmp/pip-FVT32L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:53 INFO - Running setup.py (path:/tmp/pip-JJgx41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:53 INFO - Running setup.py (path:/tmp/pip-MeN_D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:53 INFO - Running setup.py (path:/tmp/pip-e1xQpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:53 INFO - Running setup.py (path:/tmp/pip-XsEtt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:53 INFO - Running setup.py (path:/tmp/pip-8yHBrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:53 INFO - Running setup.py (path:/tmp/pip-u6tnjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:53 INFO - Running setup.py (path:/tmp/pip-Ud9BYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:53 INFO - Running setup.py (path:/tmp/pip-6oPmFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:53 INFO - Running setup.py (path:/tmp/pip-AxtY0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:53 INFO - Running setup.py (path:/tmp/pip-WkHi1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:53 INFO - Running setup.py (path:/tmp/pip-CaayeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:53 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:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:53 INFO - Running setup.py (path:/tmp/pip-AKWCbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:54 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:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:54 INFO - Running setup.py (path:/tmp/pip-WMpL6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:54 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:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:54 INFO - Running setup.py (path:/tmp/pip-2yYelf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:54 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:21:54 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:21:54 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:21:54 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:21:54 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:21:54 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:21:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:55 INFO - Downloading blessings-1.5.1.tar.gz 09:21:55 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:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:55 INFO - Installing collected packages: blessings 09:21:55 INFO - Running setup.py install for blessings 09:21:56 INFO - Successfully installed blessings 09:21:56 INFO - Cleaning up... 09:21:56 INFO - Return code: 0 09:21:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:56 INFO - Reading from file tmpfile_stdout 09:21:56 INFO - Current package versions: 09:21:56 INFO - argparse == 1.2.1 09:21:56 INFO - blessings == 1.5.1 09:21:56 INFO - blobuploader == 1.2.4 09:21:56 INFO - docopt == 0.6.1 09:21:56 INFO - manifestparser == 1.1 09:21:56 INFO - mozInstall == 1.12 09:21:56 INFO - mozcrash == 0.16 09:21:56 INFO - mozdebug == 0.1 09:21:56 INFO - mozdevice == 0.47 09:21:56 INFO - mozfile == 1.2 09:21:56 INFO - mozhttpd == 0.7 09:21:56 INFO - mozinfo == 0.9 09:21:56 INFO - mozleak == 0.1 09:21:56 INFO - mozlog == 3.1 09:21:56 INFO - moznetwork == 0.27 09:21:56 INFO - mozprocess == 0.22 09:21:56 INFO - mozprofile == 0.27 09:21:56 INFO - mozrunner == 6.11 09:21:56 INFO - mozscreenshot == 0.1 09:21:56 INFO - mozsystemmonitor == 0.0 09:21:56 INFO - moztest == 0.7 09:21:56 INFO - mozversion == 1.4 09:21:56 INFO - psutil == 3.1.1 09:21:56 INFO - requests == 1.2.3 09:21:56 INFO - wsgiref == 0.1.2 09:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:56 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:21:56 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:21:56 INFO - Using env: {'DISPLAY': ':0', 09:21:56 INFO - 'HOME': '/home/cltbld', 09:21:56 INFO - 'LANG': 'en_US.UTF-8', 09:21:56 INFO - 'LANGUAGE': 'en_US:en', 09:21:56 INFO - 'LOGNAME': 'cltbld', 09:21:56 INFO - 'MAIL': '/var/mail/cltbld', 09:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:56 INFO - 'MOZ_NO_REMOTE': '1', 09:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:56 INFO - 'NO_EM_RESTART': '1', 09:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:56 INFO - 'PWD': '/builds/slave/test', 09:21:56 INFO - 'SHELL': '/bin/bash', 09:21:56 INFO - 'SHLVL': '1', 09:21:56 INFO - 'TERM': 'linux', 09:21:56 INFO - 'TMOUT': '86400', 09:21:56 INFO - 'USER': 'cltbld', 09:21:56 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:56 INFO - '_': '/tools/buildbot/bin/python'} 09:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 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:21:56 INFO - Cleaning up... 09:21:56 INFO - Return code: 0 09:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:56 INFO - Using env: {'DISPLAY': ':0', 09:21:56 INFO - 'HOME': '/home/cltbld', 09:21:56 INFO - 'LANG': 'en_US.UTF-8', 09:21:56 INFO - 'LANGUAGE': 'en_US:en', 09:21:56 INFO - 'LOGNAME': 'cltbld', 09:21:56 INFO - 'MAIL': '/var/mail/cltbld', 09:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:56 INFO - 'MOZ_NO_REMOTE': '1', 09:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:56 INFO - 'NO_EM_RESTART': '1', 09:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:56 INFO - 'PWD': '/builds/slave/test', 09:21:56 INFO - 'SHELL': '/bin/bash', 09:21:56 INFO - 'SHLVL': '1', 09:21:56 INFO - 'TERM': 'linux', 09:21:56 INFO - 'TMOUT': '86400', 09:21:56 INFO - 'USER': 'cltbld', 09:21:56 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:56 INFO - '_': '/tools/buildbot/bin/python'} 09:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:56 INFO - Downloading/unpacking jsonschema 09:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:58 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:21:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:58 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:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:58 INFO - warning: no files found matching '*.txt' 09:21:58 INFO - no previously-included directories found matching 'build' 09:21:58 INFO - no previously-included directories found matching 'dist' 09:21:58 INFO - no previously-included directories found matching '.git*' 09:21:58 INFO - Installing collected packages: jsonschema, functools32 09:21:58 INFO - Running setup.py install for functools32 09:21:58 INFO - warning: no files found matching '*.txt' 09:21:58 INFO - no previously-included directories found matching 'build' 09:21:58 INFO - no previously-included directories found matching 'dist' 09:21:58 INFO - no previously-included directories found matching '.git*' 09:21:58 INFO - Successfully installed jsonschema functools32 09:21:58 INFO - Cleaning up... 09:21:58 INFO - Return code: 0 09:21:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe74032bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d39240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, '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': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', '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:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:21:58 INFO - Using env: {'DISPLAY': ':0', 09:21:58 INFO - 'HOME': '/home/cltbld', 09:21:58 INFO - 'LANG': 'en_US.UTF-8', 09:21:58 INFO - 'LANGUAGE': 'en_US:en', 09:21:58 INFO - 'LOGNAME': 'cltbld', 09:21:58 INFO - 'MAIL': '/var/mail/cltbld', 09:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:58 INFO - 'MOZ_NO_REMOTE': '1', 09:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:58 INFO - 'NO_EM_RESTART': '1', 09:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:58 INFO - 'PWD': '/builds/slave/test', 09:21:58 INFO - 'SHELL': '/bin/bash', 09:21:58 INFO - 'SHLVL': '1', 09:21:58 INFO - 'TERM': 'linux', 09:21:58 INFO - 'TMOUT': '86400', 09:21:58 INFO - 'USER': 'cltbld', 09:21:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:58 INFO - '_': '/tools/buildbot/bin/python'} 09:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:59 INFO - Downloading/unpacking flake8 09:21:59 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:21:59 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:21:59 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:21:59 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:21:59 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:21:59 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:22:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:00 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:22:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:00 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:22:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:01 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:22:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:01 INFO - no previously-included directories found matching 'docs/_build' 09:22:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:01 INFO - Running setup.py install for pep8 09:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:01 INFO - no previously-included directories found matching 'docs/_build' 09:22:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:22:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:01 INFO - Cleaning up... 09:22:01 INFO - Return code: 0 09:22:01 INFO - Running post-action listener: _resource_record_post_action 09:22:01 INFO - Running post-action listener: _start_resource_monitoring 09:22:01 INFO - Starting resource monitoring. 09:22:01 INFO - ##### 09:22:01 INFO - ##### Running install step. 09:22:01 INFO - ##### 09:22:01 INFO - Running pre-action listener: _resource_record_pre_action 09:22:01 INFO - Running main action method: install 09:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:01 INFO - Reading from file tmpfile_stdout 09:22:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:01 INFO - Reading from file tmpfile_stdout 09:22:01 INFO - Output received: 09:22:01 INFO - Usage: mozinstall [options] installer 09:22:01 INFO - Options: 09:22:01 INFO - -h, --help show this help message and exit 09:22:01 INFO - -d DEST, --destination=DEST 09:22:01 INFO - Directory to install application into. [default: 09:22:01 INFO - "/builds/slave/test"] 09:22:01 INFO - --app=APP Application being installed. [default: firefox] 09:22:01 INFO - mkdir: /builds/slave/test/build/application 09:22:01 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:22:01 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:22:16 INFO - Reading from file tmpfile_stdout 09:22:16 INFO - Output received: 09:22:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:16 INFO - Running post-action listener: _resource_record_post_action 09:22:16 INFO - ##### 09:22:16 INFO - ##### Running run-tests step. 09:22:16 INFO - ##### 09:22:16 INFO - Running pre-action listener: _resource_record_pre_action 09:22:16 INFO - Running main action method: run_tests 09:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:16 INFO - Python 2.7.3 09:22:16 INFO - Return code: 0 09:22:16 INFO - grabbing minidump binary from tooltool 09:22: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:22:16 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 0x1dc80b0>, '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 0x1dc8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:16 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:22:16 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:22:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:16 INFO - Return code: 0 09:22:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:22:17 INFO - Return code: 0 09:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test/build 09:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 09:22:17 INFO - Using env: {'DISPLAY': ':0', 09:22:17 INFO - 'HOME': '/home/cltbld', 09:22:17 INFO - 'LANG': 'en_US.UTF-8', 09:22:17 INFO - 'LANGUAGE': 'en_US:en', 09:22:17 INFO - 'LOGNAME': 'cltbld', 09:22:17 INFO - 'MAIL': '/var/mail/cltbld', 09:22:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:17 INFO - 'MOZ_NO_REMOTE': '1', 09:22:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:17 INFO - 'NO_EM_RESTART': '1', 09:22:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:17 INFO - 'PWD': '/builds/slave/test', 09:22:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:17 INFO - 'SHELL': '/bin/bash', 09:22:17 INFO - 'SHLVL': '1', 09:22:17 INFO - 'TERM': 'linux', 09:22:17 INFO - 'TMOUT': '86400', 09:22:17 INFO - 'USER': 'cltbld', 09:22:17 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808', 09:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:17 INFO - '_': '/tools/buildbot/bin/python'} 09:22:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 09:22:17 INFO - mozversion INFO | application_buildid: 20151126075510 09:22:17 INFO - mozversion INFO | application_changeset: 74c7941a9e22d50057800771ebae07f69deecc9f 09:22:17 INFO - mozversion INFO | application_display_name: Nightly 09:22:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:17 INFO - mozversion INFO | application_name: Firefox 09:22:17 INFO - mozversion INFO | application_remotingname: firefox 09:22:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:22:17 INFO - mozversion INFO | application_vendor: Mozilla 09:22:17 INFO - mozversion INFO | application_version: 45.0a1 09:22:17 INFO - mozversion INFO | platform_buildid: 20151126075510 09:22:17 INFO - mozversion INFO | platform_changeset: 74c7941a9e22d50057800771ebae07f69deecc9f 09:22:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:22:17 INFO - mozversion INFO | platform_version: 45.0a1 09:22:17 INFO - 2015-11-26 09:22:17,479 DEBUG : using testdate: 1448558537 09:22:17 INFO - 2015-11-26 09:22:17,479 DEBUG : actual date: 1448558537 09:22:17 INFO - 2015-11-26 09:22:17,488 INFO : starting webserver on 'localhost:58306' 09:22:17 INFO - 2015-11-26 09:22:17,489 INFO : Starting test suite talos-linux64-ix-023 09:22:17 INFO - 2015-11-26 09:22:17,489 INFO : Starting test dromaeo_css 09:22:17 INFO - 2015-11-26 09:22:17,489 DEBUG : operating with platform_type : linux_ 09:22:17 INFO - 2015-11-26 09:22:17,490 INFO : Initialising browser for dromaeo_css test... 09:22:17 INFO - 2015-11-26 09:22:17,507 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXoADY/profile http://localhost:58306/getInfo.html 09:22:21 INFO - 2015-11-26 09:22:21,329 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:22:21 INFO - 2015-11-26 09:22:21,329 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:22:21 INFO - 2015-11-26 09:22:21,329 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:22:21 INFO - 2015-11-26 09:22:21,329 DEBUG : BROWSER_OUTPUT: __metrics 09:22:21 INFO - 2015-11-26 09:22:21,452 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:22 INFO - 2015-11-26 09:22:22,726 INFO : Browser initialized. 09:22:22 INFO - 2015-11-26 09:22:22,727 INFO : Running cycle 1/1 for dromaeo_css test... 09:22:22 INFO - 2015-11-26 09:22:22,727 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXoADY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:22:34 INFO - 2015-11-26 09:22:34,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 141357056 09:22:34 INFO - 2015-11-26 09:22:34,620 DEBUG : BROWSER_OUTPUT: 09:23:25 INFO - 2015-11-26 09:23:25,947 DEBUG : BROWSER_OUTPUT: 1448558605943 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:25:38 INFO - 2015-11-26 09:25:38,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58306/tests/dromaeo/cssquery-ext.html) 09:25:39 INFO - 2015-11-26 09:25:39,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 239702016 09:25:39 INFO - 2015-11-26 09:25:39,246 DEBUG : BROWSER_OUTPUT: 09:28:41 INFO - 2015-11-26 09:28:41,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-ext.html (next: http://localhost:58306/tests/dromaeo/cssquery-jquery.html) 09:28:42 INFO - 2015-11-26 09:28:42,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 226402304 09:28:42 INFO - 2015-11-26 09:28:42,288 DEBUG : BROWSER_OUTPUT: 09:31:44 INFO - 2015-11-26 09:31:44,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58306/tests/dromaeo/cssquery-mootools.html) 09:31:45 INFO - 2015-11-26 09:31:45,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 212316160 09:31:45 INFO - 2015-11-26 09:31:45,053 DEBUG : BROWSER_OUTPUT: 09:34:47 INFO - 2015-11-26 09:34:47,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58306/tests/dromaeo/cssquery-prototype.html) 09:34:47 INFO - 2015-11-26 09:34:47,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 201179136 09:34:47 INFO - 2015-11-26 09:34:47,699 DEBUG : BROWSER_OUTPUT: 09:37:50 INFO - 2015-11-26 09:37:50,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58306/tests/dromaeo/cssquery-yui.html) 09:37:51 INFO - 2015-11-26 09:37:51,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 208015360 09:37:51 INFO - 2015-11-26 09:37:51,027 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-yui.html (next: http://localhost:58306/tests/dromaeo/cssquery-dojo.html) 09:40:53 INFO - 2015-11-26 09:40:53,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 249683968 09:40:53 INFO - 2015-11-26 09:40:53,713 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,713 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:40:53 INFO - 2015-11-26 09:40:53,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:40:53 INFO - 2015-11-26 09:40:53,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:40:53 INFO - 2015-11-26 09:40:53,713 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:40:53 INFO - 2015-11-26 09:40:53,714 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.585594232894;2784;2790.4558611070847;2806.4667713134504;2813.873375698094;4635.072985402924;4734.053189362133;4810.5189481051875;4818.759062046896;4837.63717721171;4698.45967713713;4725.574698277163;4816.638752093599;4823.107725070864;4837.540433658805;4382.233109205884;4442.489113751912;4469.64242860572;4471.083427897273;4529.614982726473;4287.699861009731;4501.819927202908;4507.752073635948;4543.341215523747;4549.476810166823;4349.41282926804;4374.956250437503;4396.802143903532;4422.6682998774895;4440.689151759379;4411.735295882258;4432.889177770549;4433.977830110861;4436.889077773049;4479.1489616972995;4404.933925991113;4408.20652282589;4411.735295882225;4444.355568442557;4460.264056430685;4528.479224889114;4653.441587009546;4693.389859318301;4694.201985662446;4737.123632128068;5141.974290128525;5144.176931690949;5145.665531740425;5158.148905430599;5228.79084836606;5159;5161.767720452589;5170.922436163461;5211.687298762048;5215.58275337972;4610.608098311681;4715.504871988392;4718.197906355927;4719.5752382285755;4814.181589129857;5271.182966640177;5354.9464505354445;5356.705381204071;5363.651362661414;5369.221462887859;5118.59051275897;5133.12736834739;5138.203578445347;5141.897162056738;5196.58427325813;4935.975320123376;5042.218456139304;5042.596592272609;5050.242463630485;5216.21756736485;5048.899022019613;5122.820701275437;5123.38519377677;5127.6154288428515;5149.588032957355;5132.769025393866;5172.353455818023;5179.938112686966;5183.222516622537;5188.45521220274;4150.771707556053;4251.851185208503;4279.2083464559155;4328.091100868853;4369.47566292047;3621.366260904384;3662.249238906018;3704.981475092607;3707.536557930259;3755;4388.692791504564;4394.868153955386;4406.383106365111;4407.977960110179;4448.644108471314;4981.277714731344;5092.6180536459915;5201;5208.062548741263;5256;4263.232618128704;4366.978165109154;4373.584509471595;4382.408374869416;4409.14021765759;4536.160810250114;4556.567126123013;4556.886077848014;4564.452265728134;4600.5169457207185;4882.4385195701525;4888;4888.364512613338;4890.217565189624;4931.531504506995;5077.720725360141;5167.199084141964;5205.349331333583;5212.817551385683;5299.8410047698635;4930.186519224431;4931.876703082452;4940.258961155711;4942.357493525818;4980.626453016111;5127.769250383816;5133.563647090039;5134.589232861287;5136.332276803992;5149.613778966667;4910.484399138039;5120.513551212629;5132.178851383761;5187.325647665779;5283.445238250082;5022.146235140108;5027.899442011066;5032.84901452957;5036.874078148076;5078.162103252922;5030.119729047476;5031.974840125776;5035.571976382049;5037.168867136881;5038.7984480621835;4740.170470167775;4807.567318941312;4848.17581011236;4861.1006963711825;4966.652334336706;5084.491550844886;5104.744762761921;5120.692758434506;5123.974380128076;5125.154349532286;4976.900461990812;4990.476000019946;5002.849914502571;5009.0482808266315;5043.798248070036 09:40:53 INFO - 2015-11-26 09:40:53,715 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.61869310176;555.5638823523534;564.2270089976732;569.3395661033202;580.6342004537141;27074.86462567687;27653.723462765367;27678.3080422989;27685.446291074193;27708.168754937386;36897.44653830195;37446;37741.81129094357;37815;37864.81067594658;7895.289423951857;8118.959405202995;8127.837443251161;8133.633986470623;8135.75592732219;7156.785296441115;7334.706611735524;7880.290773830354;7995.920550725665;10006.749831254205;9582.185514231263;9656.5171741413;9662.371945823534;9664.081912218327;9665.033496650349;10041.648542301022;10146.695599132037;10174.084332410119;10174.135198508136;10177.084062434342;7154.570725756471;7356.96321518389;7358.153812311599;7358.41132709382;9987.300888937778;36187.81906090479;36912.26175476475;36924.446133308025;36932.07669808249;37007.25985480275;2946.175070980129;2997.7501974164597;2998.8800447982053;3013;3559.341521818472;27713.307167320978;30051.248718782204;30407.543886841715;30473.085807425592;30695.232619184477;3367.3265346930466;3482.7387945904156;3486.337595856779;3522.4892390603477;3553.3248682750195;204893;206299;206574.96712516493;206968;207100;54306;54387;54650;54859.72570137124;54876.45123548793;58001.4199857996;58191.709041454524;58221;58248;58565;13610.251436170907;13889.305534723224;13991.090579112528;14001.789973150411;14020.228887411291;10397.272190946562;10419.739506512398;10486.73783155412;10529.894701052892;10545.525451354708;18386.448406547825;18444.35444759454;18457;18581.25674973013;18601.348952786586;7372.152202496782;7591.3547348475995;7629.819845924708;7630.618469076524;7732.729354472566;899.2266650680409;906.6509393883271;938.8685584018243;1002.8317010682619;1048.7483004078965;26274.21177364644;26527.668960561376;26659.46681066368;26761.866190668923;26812;861.5907443964193;935.158357478275;992.692265397729;1018.2719355660738;1033.421284080917;12661.49354025847;14883.181425021512;15488.303026363616;15511.767323490156;15676.451324203597;243659;244286;246063;246405;247079;47733;48229.27656085161;48242.27636585454;48298.75850620725;48330.758346208044;1220.0727447140237;1222.2483172848633;1223.1865809236936;1229.0474881966547;1244.402686710366;26698.332541686614;27223;27412.862935685192;27643.30891727723;27794.305142370795;38415;38773.2245355097;38778.6122138775;38796.2240755189;38832.80583597064;247974;249482;250382;251050;251288;24478.63282050735;24910.37724056913;28095;28628.427431450837;29182.708172918;33524;33622.83188584042;36293.45559816552;36820.263594728494;37328.44007339946;31775.841120794248;32148.35703285968;32229.677703222667;32638.83680581677;32738.672613274513;29816.850915745283;31391.84304078465;34573.30853382868;38009.80995095007;39008.41487377748;34588.30823383468;34833;34873.65126348704;34906.30187396187;37614.24771504609;28192;28775.85612071926;29736.851315743283;30018.849905750332;30092;23879.76120238845;23983.236878866213;24047.348873015177;24269.51460970806;24388 09:40:53 INFO - 2015-11-26 09:40:53,715 DEBUG : BROWSER_OUTPUT: |2;jquery.html;302.6413699765778;311.09936733157525;316.1621702488406;316.22997999870313;316.8447460744235;12528.749425011494;13007.804882926765;14791.482298119568;15173.696526069485;15353.539393818175;14344.497942572012;14992.250387480637;16012.359505619761;16420.507384778444;16519;5241.659292146008;5615.971920140393;5624.943750562504;5646.124850648156;5646.6894320812335;3895.357266051112;3992.121733218687;4002.2995975704134;5638.097904335307;6358.300586935434;6456.9354306457035;6548.770793022221;6605.108310378109;6606.801795946105;6608.471322294205;6504.2194936607675;6566.146400967891;6570.605763654196;6576.177977752781;6579.309172536887;6130.816075517741;6244.625322480666;6257.405546473078;6290.182276304051;6314.557980941336;19904.80095199044;20503.897480512653;20602.969851507365;20806.687899681518;21584.352469425943;1832;1999.4301624037225;2061.8247448966854;2073.6474799284006;2118.8410869184872;13093.607191784167;13506.31171103612;14060.437582496688;14188.290585470788;14298.428062877472;1765.4262364731385;1874.109797846026;1878.7557617509774;1930.536671198916;1942.5337918899504;60822;65266;65315.02027469592;66561;66924;15155.621109472351;15186.772198417033;15218.543443696706;15248;15258.923705381401;22807.771922280896;23014;23094.307170784905;23108.07567697307;23112.537749244922;8571.699990500303;8589.184027517376;8672.523011234443;8693.956530217309;8871.778205544784;7260.52806567582;7284.817879553054;7334.193238743841;7404.703811847574;7408.296211859864;7521.473496855277;7613.505122167152;7624.313811756858;7654.8086297843;7755.72854950074;1531.5175719648275;1680.4790514940407;1687.8902871313326;1705.8550023247915;2143.38174678117;683.6156782515446;828.1842385250524;830.485099238476;871.9389642724948;886.6409104312763;15304.617384565476;15811.446599369197;15897.046177229404;16312;16893.577660558338;736.2269616902231;796.9003874515686;844.8901642786399;845.8815765792793;879.5118709116374;5253.842384728464;5299.693364895762;5354.651947623392;5380.188002867812;5395.70323632204;493918;509148;525161;529663;535738;73143;75717.62141189369;76054.61972690212;76503.61748191334;76723.61638191773;395.97822119783115;400.4753772557958;400.87773229165384;400.89153490598517;401.7147825044193;8919.197272245528;9094.408863423856;9238.122378374044;9252.676156334495;9364.157225849705;32788.508172376954;33605.83197083999;33741.83129084339;33931.83034084814;33961.66038339585;41900.652262942676;43984.34023489714;44902.55097448984;47530.28704569503;50088.74955625198;8398.244158025807;8626.217109507767;8758.518281494578;8765.211130998241;8775.210231078978;13220.603381898558;15438.768418473957;15687.29407176657;15837.128957907426;15845.049297042215;13303.866961330263;13701.177929324273;13889.305534723022;14098.50655227062;14244.074135181594;13381.39783709716;13537.661558461117;13930.930345348208;13994.65013374633;14289.71420571562;10505.68482945513;13876.236806975714;14208.289585520475;14346.139231646135;14555.272236387926;7450.254974502506;8492.787680308042;8690.304775618062;8748.431351962103;8751.737447876574;13025.413856376676;13184.077114601885;13351.198928064347;13671.521496747566;13843.653908652364 09:40:53 INFO - 2015-11-26 09:40:53,717 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1406.54287356609;1583.9366425342987;1611.6454380036396;1636.3945340224118;1659.5851037240686;5863.648181109136;6426.518011149165;6669.86660266795;6671.099401580797;6676;6582.4075833175;6670.933290667092;6717.59694418334;6735.528513004092;6735.797926062214;1708.7436884467304;1736.2360561353028;1910.2168111074461;1913.4642300155979;1936.1674479973606;1949.7172909928051;1950.580625165589;1953.8534609904243;1954;1954.4039068084228;1896.2320260294534;1923.9807601924012;1928.479310586148;1943.4946913802441;1945;1921.9711704324445;1939.1177014458387;1962.587856550119;1969.2910552201197;1971.2607772085469;1912.8852268863914;1952.4142757172933;1955.599102184049;1957.628050670368;1958.2852258925532;6566.540342176049;6631.701573429207;6637;6639.3692599203;6642.5350225484235;3829.5596006459336;3875.1280961783655;3900.180961997984;3912.56961734209;3915.7846318452475;2183.5087105401317;2555.7060937992183;2564.2050964201158;2603.960940585893;2625.619285203654;709.7799682098514;754.2495217258808;780.4692808889953;784.3411534311149;859.613174071664;8631.395802293842;8633.438826476196;8641.049484556694;8650.178233067849;8702.912970870337;3558.893233203008;3575.8212089395424;3615.385384484644;3633.6366363363454;3636.4908912752235;7594.430417718693;7611.3530349920875;7612.238776122344;7615.048118985127;7616.69533218665;3931.7811478441204;3955.940660890089;3969.583193764671;3970.0471886746973;3979.2837289288204;3599.7300202484394;3610.350136975317;3611.4041183205004;3612.259486805199;3613.1147868771795;2819.9859000705274;2852.757515611196;2856.200263926104;3137.105924811418;3150.1652062203534;951.5860600638745;1011.8178727828914;1016.9288149829589;1025.3642741500319;1029.8506716526063;791.8168960777641;842.9747107586783;991.3506653142204;992.0922356044139;993.3642468819961;6247.250329960434;6312.210973628296;6344.365563443619;6528.869422611521;6534.281229064799;985.261054209343;987.244757760314;1002.7593377589326;1003.1172568140136;1005.4520286443906;4864.343313652612;4946.431160416526;4999.275105109811;5004.524570165829;5009.298698182258;7849.450538462367;8026.27763501276;8031.277185053256;8035.758927232192;8048.83902321962;7953.0456345238945;7959.960200199078;7960.044794624682;7961.203879611992;7963.721269755531;6164.7842325518395;6200.441960223511;6231;6238.313785483593;6254.906176407358;5967.104934259895;5977.731002104829;5990.7903223386975;5995.100734889627;5997.100434934795;6865.382115609619;7060.364567188978;7064.470164737768;7117.537360071578;7159.713611455483;7130.5365151265005;7311.488195826241;7491.138519070377;7517.398608111447;7543.660535276035;5998.4601385875485;6029.638221706711;6073.908891366721;6079.574429789872;6095.207623008981;5415.729213539386;5598.048331783525;6184.443400094013;6332.556721029484;6367.395097465734;5693.316801983623;5902.852428689317;5935.080062590306;5981.52147828164;6094.024956007018;5541.944580554304;5706.6005379624685;5712.571557133148;5723.227364305932;5833.387494313036;6025.367336429612;6065.423784740443;6065.969670151621;6069.150318955438;6073.726682299395;5455;5569.582281328835;5617.354004289559;5633.1831884375715;5642.210090587403;5657.236273103078;5705.572082093777;5708.942910570841;5711.571632127524;5723.084306510938 09:40:53 INFO - 2015-11-26 09:40:53,718 DEBUG : BROWSER_OUTPUT: |4;prototype.html;283.5859644918419;288.2620491541652;289.5381865923852;290.8342244920396;294.0253061102445;5342.973285133578;5425.674459532426;5442.346918369792;5464.180372944061;5508.228847961279;5334.653247538917;5389.487998640133;5393.460653934604;5400.675959442437;5407.621466497347;4107.753534787922;4112.9588704112875;4118.546959834416;4119.258533463968;4120.917581648365;3937.2912875682364;4026.5973402659647;4040.373742069969;4090.365993271048;4091.488563929509;4051.149258655686;4058.1680755445063;4077.368007958771;4078.1028173801715;4083.2854250506043;3876.457295978565;3972.980135099306;4085.060436099699;4088.080181959065;4088.713790034684;3453.6028356739043;3455.671711187433;3458.7405944554007;3461.4288642373976;3466.722662187019;5171.715555644438;5184.066867963765;5192.71440070796;5200.167973124319;5202.739863006835;4664;4664.743439110847;4666.743329116897;4674.065186962587;4674.953250467486;5466.371367292772;5602.411746766612;5608.046632072516;5613.775448982035;5615.241942337773;3836.9040773980873;3837.539495260559;3840.8079596020366;3841.8079096045367;3848.2111167210655;5880.059190529538;5935.584509084366;5941.524678025748;5948.375420580864;5954.1664167016215;3937.9803100984313;3938;3942.014496375906;3944.3294639911283;3946.230485055444;3902.969368722413;3980.681545476355;3986.5614782374496;3987.5613682494904;3993.7803420812133;4590.40324757786;4662.533746625379;4665.090307390026;4669.486356500782;4669.789859456333;5568;5657.094864821609;5666.858328541819;5677.2619559457835;5685.943140568624;1398.3637444962721;1399.5731301952799;1406.2054938959454;1407.5425486716654;1409.2530958591963;902.9277657787361;905.4657751926395;931.8741969834122;936.3164889630608;938.3759799733238;4948.579370753526;4962.15643340633;4964.478729733398;4971.701697898137;4972.776225069881;5898.203742494708;5905.616134951214;5911.940880591225;5914.260717410324;5915.467607915309;4947.084789313988;4951.678140920829;4960.603151747851;4961.950380496221;4964.528369804862;3073.6772638872594;3099.5815564898903;3165.699258570432;3178.030700636328;3187.314727333588;5491.423400542965;5512.5589952803675;5644.463775941361;5646.943530564642;5652.802151924745;6096.207493025967;6116.4922381823235;6117;6118.816435506942;6119.969400152971;5574.247476590608;5625.296837895263;5625.578081643975;5632.12702031194;5637.661740295595;5817.680027598353;5961.791337303173;5971.134185543159;5987.730552125077;5998.790042348497;5814.186013958134;5823.534117270524;5826.73779679907;5829.5336373090895;5830.53355731549;5632.507385542753;5638.041532939328;5649.435056494318;5651.547876169814;5655.699189186593;3951.4572307876156;4008.4388185654616;4011;4037.8990525237105;4045.150518391171;5884.35272120075;5887.676177810262;5891.94108058931;5902.5277977762535;5903.11453281994;5653.491185793298;5662.03745363281;5663.263775709132;5675.943240567542;5676.2337084493065;5654.660720356627;5661.150827375926;5668.801591944262;5670.943290567042;5672.432756724294;5379.462053794589;5541.612087153861;5545.750441230073;5546.223528706065;5553.750081246434;5689.829305120853;5709.22925405065;5709.286339207599;5709.9714501427225;5712.228849105318;5568.638038527482;5571.888562228652;5572.86067848307;5573.052581061148;5573.414791446839 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: |5;yui.html;633.0599060395315;676.7529851604166;681.8193178807616;688.5730846874939;747.3012733094555;10951.123910087194;11173.83239251412;11180.552777888885;11204.383758893258;11212.887871121286;11614.128940329489;11717.882821171786;11958.342291173982;12047.518099276018;12076.516939322439;581.2269681323829;593.4777395891609;749.8837680159584;767.7312940470819;769.0732667136116;759.760675387254;765.7358211417052;766.4826242286434;766.6205228411944;766.9961650191741;804.0592506767097;804.3082948664144;804.7223707820792;804.7625950344662;806.1495122645606;602.0457574744014;615.7998650438603;794.606669698503;796.319147129202;796.5021861336664;597.2922087326532;597.6414151509103;597.7340083662772;597.9970100149471;601.7803501721884;11345;11575.36335501547;11616.94191529037;11622.941885290604;11645.825312620318;11000;11278.887211127947;11447.656570302905;11529.769404611861;11763.88236117645;9373.578188981444;9413.57638906251;9513.952430237805;9568.09103135201;9608.807823843485;3113.128324069264;3129.0612816155062;3132.15431833406;3161.525771134325;3196.9360612787846;39671.20657586861;39789;39794.20411591752;39799.20401591952;39833.60166398328;8802.735917922473;9018.59416326267;9188;9269.953650231706;9273.629054837731;15779.447719329768;16763.91618041902;16972.575685607957;17002.14989250557;17014.659706806044;5964.7912323068485;6085.5435842312;6085.847853803691;6089.330173680892;6097.969510152509;3476.0788391076385;3564.7148228141687;3571.714262858965;3573.0888623400865;3608.8736894208578;2696.258528904528;2705.269577214141;2722.754952054325;2725.2914242296747;2726.114012945761;484.82788610043633;485.6988667026466;491.7737840593367;497.16972655665126;500.7070863544867;448.91695036418366;449.6784798868759;456.63697360598405;463.5133110234241;486.03279473847493;7666.846663066819;7784.299413052852;8173.67305307781;8327.292180164754;8328.458650187718;433.62491444899933;461.4670056085227;540.3084052412918;543.0849019402319;549.2063967566908;3686.1337585667347;3709.703223742094;3740.5137332146646;3760.417135344026;3820.6943444524372;52121.739391303556;52745.47254527405;52767.208491872654;52773;52807.735961319944;44835.77582112069;46505;47003;47378.289325660146;47575.5242447578;42066.58668266359;42108.57891421046;42798.14403711971;42807;42840;7490.250974902466;7536.284053014955;7708.691652333844;7728.4590078693955;7769.883451748341;30947;31371.372572548877;31554.211144721565;31567;31660.525092123175;37429.251414971004;38963;40317.1936561273;40658;40793.59206408016;8819.735407937773;8995.100489951214;9000.819983600422;9142.908570914205;9212.723618291462;10116.1401280889;10288.182573687898;10434;10439;10444.68665940023;9743.905060412046;9769.413835169913;9818.75453113678;9821.607135714492;9920.801583968136;9498.715038548855;9560.808783824146;9565.473898935346;9590.616375345187;9708.126268635857;8404.898374381308;9607.231421486125;10772.24594278393;10832.458377081271;11183;9376.859347109936;9472.810543789223;9609.375390599589;9616.663416780379;9812.803743924938;9304.395214311047;9388.202002829563;9780.41317520951;9823.544113971508;9918.454485003394 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559653712__endTimestamp 09:40:53 INFO - 2015-11-26 09:40:53,719 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4753.15 Median:4890.22 stddev:508.94 (10.4%) stddev-sans-first:483.65 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: Values: 2673.6 2784.0 2790.5 2806.5 2813.9 4635.1 4734.1 4810.5 4818.8 4837.6 4698.5 4725.6 4816.6 4823.1 4837.5 4382.2 4442.5 4469.6 4471.1 4529.6 4287.7 4501.8 4507.8 4543.3 4549.5 4349.4 4375.0 4396.8 4422.7 4440.7 4411.7 4432.9 4434.0 4436.9 4479.1 4404.9 4408.2 4411.7 4444.4 4460.3 4528.5 4653.4 4693.4 4694.2 4737.1 5142.0 5144.2 5145.7 5158.1 5228.8 5159.0 5161.8 5170.9 5211.7 5215.6 4610.6 4715.5 4718.2 4719.6 4814.2 5271.2 5354.9 5356.7 5363.7 5369.2 5118.6 5133.1 5138.2 5141.9 5196.6 4936.0 5042.2 5042.6 5050.2 5216.2 5048.9 5122.8 5123.4 5127.6 5149.6 5132.8 5172.4 5179.9 5183.2 5188.5 4150.8 4251.9 4279.2 4328.1 4369.5 3621.4 3662.2 3705.0 3707.5 3755.0 4388.7 4394.9 4406.4 4408.0 4448.6 4981.3 5092.6 5201.0 5208.1 5256.0 4263.2 4367.0 4373.6 4382.4 4409.1 4536.2 4556.6 4556.9 4564.5 4600.5 4882.4 4888.0 4888.4 4890.2 4931.5 5077.7 5167.2 5205.3 5212.8 5299.8 4930.2 4931.9 4940.3 4942.4 4980.6 5127.8 5133.6 5134.6 5136.3 5149.6 4910.5 5120.5 5132.2 5187.3 5283.4 5022.1 5027.9 5032.8 5036.9 5078.2 5030.1 5032.0 5035.6 5037.2 5038.8 4740.2 4807.6 4848.2 4861.1 4966.7 5084.5 5104.7 5120.7 5124.0 5125.2 4976.9 4990.5 5002.8 5009.0 5043.8 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39585.23 Median:31583.84 stddev:61025.25 (193.2%) stddev-sans-first:61126.07 09:40:53 INFO - 2015-11-26 09:40:53,723 DEBUG : BROWSER_OUTPUT: Values: 552.6 555.6 564.2 569.3 580.6 27074.9 27653.7 27678.3 27685.4 27708.2 36897.4 37446.0 37741.8 37815.0 37864.8 7895.3 8119.0 8127.8 8133.6 8135.8 7156.8 7334.7 7880.3 7995.9 10006.7 9582.2 9656.5 9662.4 9664.1 9665.0 10041.6 10146.7 10174.1 10174.1 10177.1 7154.6 7357.0 7358.2 7358.4 9987.3 36187.8 36912.3 36924.4 36932.1 37007.3 2946.2 2997.8 2998.9 3013.0 3559.3 27713.3 30051.2 30407.5 30473.1 30695.2 3367.3 3482.7 3486.3 3522.5 3553.3 204893.0 206299.0 206575.0 206968.0 207100.0 54306.0 54387.0 54650.0 54859.7 54876.5 58001.4 58191.7 58221.0 58248.0 58565.0 13610.3 13889.3 13991.1 14001.8 14020.2 10397.3 10419.7 10486.7 10529.9 10545.5 18386.4 18444.4 18457.0 18581.3 18601.3 7372.2 7591.4 7629.8 7630.6 7732.7 899.2 906.7 938.9 1002.8 1048.7 26274.2 26527.7 26659.5 26761.9 26812.0 861.6 935.2 992.7 1018.3 1033.4 12661.5 14883.2 15488.3 15511.8 15676.5 243659.0 244286.0 246063.0 246405.0 247079.0 47733.0 48229.3 48242.3 48298.8 48330.8 1220.1 1222.2 1223.2 1229.0 1244.4 26698.3 27223.0 27412.9 27643.3 27794.3 38415.0 38773.2 38778.6 38796.2 38832.8 247974.0 249482.0 250382.0 251050.0 251288.0 24478.6 24910.4 28095.0 28628.4 29182.7 33524.0 33622.8 36293.5 36820.3 37328.4 31775.8 32148.4 32229.7 32638.8 32738.7 29816.9 31391.8 34573.3 38009.8 39008.4 34588.3 34833.0 34873.7 34906.3 37614.2 28192.0 28775.9 29736.9 30018.8 30092.0 23879.8 23983.2 24047.3 24269.5 24388.0 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28333.14 Median:2201.60 stddev:84774.82 (3850.6%) stddev-sans-first:84986.51 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: Values: 302.6 311.1 316.2 316.2 316.8 12528.7 13007.8 14791.5 15173.7 15353.5 14344.5 14992.3 16012.4 16420.5 16519.0 5241.7 5616.0 5624.9 5646.1 5646.7 3895.4 3992.1 4002.3 5638.1 6358.3 6456.9 6548.8 6605.1 6606.8 6608.5 6504.2 6566.1 6570.6 6576.2 6579.3 6130.8 6244.6 6257.4 6290.2 6314.6 19904.8 20503.9 20603.0 20806.7 21584.4 1832.0 1999.4 2061.8 2073.6 2118.8 13093.6 13506.3 14060.4 14188.3 14298.4 1765.4 1874.1 1878.8 1930.5 1942.5 60822.0 65266.0 65315.0 66561.0 66924.0 15155.6 15186.8 15218.5 15248.0 15258.9 22807.8 23014.0 23094.3 23108.1 23112.5 8571.7 8589.2 8672.5 8694.0 8871.8 7260.5 7284.8 7334.2 7404.7 7408.3 7521.5 7613.5 7624.3 7654.8 7755.7 1531.5 1680.5 1687.9 1705.9 2143.4 683.6 828.2 830.5 871.9 886.6 15304.6 15811.4 15897.0 16312.0 16893.6 736.2 796.9 844.9 845.9 879.5 5253.8 5299.7 5354.7 5380.2 5395.7 493918.0 509148.0 525161.0 529663.0 535738.0 73143.0 75717.6 76054.6 76503.6 76723.6 396.0 400.5 400.9 400.9 401.7 8919.2 9094.4 9238.1 9252.7 9364.2 32788.5 33605.8 33741.8 33931.8 33961.7 41900.7 43984.3 44902.6 47530.3 50088.7 8398.2 8626.2 8758.5 8765.2 8775.2 13220.6 15438.8 15687.3 15837.1 15845.0 13303.9 13701.2 13889.3 14098.5 14244.1 13381.4 13537.7 13930.9 13994.7 14289.7 10505.7 13876.2 14208.3 14346.1 14555.3 7450.3 8492.8 8690.3 8748.4 8751.7 13025.4 13184.1 13351.2 13671.5 13843.7 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4623.54 Median:5883.25 stddev:2378.85 (40.4%) stddev-sans-first:2373.24 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: Values: 1406.5 1583.9 1611.6 1636.4 1659.6 5863.6 6426.5 6669.9 6671.1 6676.0 6582.4 6670.9 6717.6 6735.5 6735.8 1708.7 1736.2 1910.2 1913.5 1936.2 1949.7 1950.6 1953.9 1954.0 1954.4 1896.2 1924.0 1928.5 1943.5 1945.0 1922.0 1939.1 1962.6 1969.3 1971.3 1912.9 1952.4 1955.6 1957.6 1958.3 6566.5 6631.7 6637.0 6639.4 6642.5 3829.6 3875.1 3900.2 3912.6 3915.8 2183.5 2555.7 2564.2 2604.0 2625.6 709.8 754.2 780.5 784.3 859.6 8631.4 8633.4 8641.0 8650.2 8702.9 3558.9 3575.8 3615.4 3633.6 3636.5 7594.4 7611.4 7612.2 7615.0 7616.7 3931.8 3955.9 3969.6 3970.0 3979.3 3599.7 3610.4 3611.4 3612.3 3613.1 2820.0 2852.8 2856.2 3137.1 3150.2 951.6 1011.8 1016.9 1025.4 1029.9 791.8 843.0 991.4 992.1 993.4 6247.3 6312.2 6344.4 6528.9 6534.3 985.3 987.2 1002.8 1003.1 1005.5 4864.3 4946.4 4999.3 5004.5 5009.3 7849.5 8026.3 8031.3 8035.8 8048.8 7953.0 7960.0 7960.0 7961.2 7963.7 6164.8 6200.4 6231.0 6238.3 6254.9 5967.1 5977.7 5990.8 5995.1 5997.1 6865.4 7060.4 7064.5 7117.5 7159.7 7130.5 7311.5 7491.1 7517.4 7543.7 5998.5 6029.6 6073.9 6079.6 6095.2 5415.7 5598.0 6184.4 6332.6 6367.4 5693.3 5902.9 5935.1 5981.5 6094.0 5541.9 5706.6 5712.6 5723.2 5833.4 6025.4 6065.4 6066.0 6069.2 6073.7 5455.0 5569.6 5617.4 5633.2 5642.2 5657.2 5705.6 5708.9 5711.6 5723.1 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4675.26 Median:5404.15 stddev:1414.78 (26.2%) stddev-sans-first:1379.81 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: Values: 283.6 288.3 289.5 290.8 294.0 5343.0 5425.7 5442.3 5464.2 5508.2 5334.7 5389.5 5393.5 5400.7 5407.6 4107.8 4113.0 4118.5 4119.3 4120.9 3937.3 4026.6 4040.4 4090.4 4091.5 4051.1 4058.2 4077.4 4078.1 4083.3 3876.5 3973.0 4085.1 4088.1 4088.7 3453.6 3455.7 3458.7 3461.4 3466.7 5171.7 5184.1 5192.7 5200.2 5202.7 4664.0 4664.7 4666.7 4674.1 4675.0 5466.4 5602.4 5608.0 5613.8 5615.2 3836.9 3837.5 3840.8 3841.8 3848.2 5880.1 5935.6 5941.5 5948.4 5954.2 3938.0 3938.0 3942.0 3944.3 3946.2 3903.0 3980.7 3986.6 3987.6 3993.8 4590.4 4662.5 4665.1 4669.5 4669.8 5568.0 5657.1 5666.9 5677.3 5685.9 1398.4 1399.6 1406.2 1407.5 1409.3 902.9 905.5 931.9 936.3 938.4 4948.6 4962.2 4964.5 4971.7 4972.8 5898.2 5905.6 5911.9 5914.3 5915.5 4947.1 4951.7 4960.6 4962.0 4964.5 3073.7 3099.6 3165.7 3178.0 3187.3 5491.4 5512.6 5644.5 5646.9 5652.8 6096.2 6116.5 6117.0 6118.8 6120.0 5574.2 5625.3 5625.6 5632.1 5637.7 5817.7 5961.8 5971.1 5987.7 5998.8 5814.2 5823.5 5826.7 5829.5 5830.5 5632.5 5638.0 5649.4 5651.5 5655.7 3951.5 4008.4 4011.0 4037.9 4045.2 5884.4 5887.7 5891.9 5902.5 5903.1 5653.5 5662.0 5663.3 5675.9 5676.2 5654.7 5661.2 5668.8 5670.9 5672.4 5379.5 5541.6 5545.8 5546.2 5553.8 5689.8 5709.2 5709.3 5710.0 5712.2 5568.6 5571.9 5572.9 5573.1 5573.4 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: 09:40:53 INFO - 2015-11-26 09:40:53,724 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12299.39 Median:52433.61 stddev:14289.07 (27.3%) stddev-sans-first:14302.29 09:40:53 INFO - 2015-11-26 09:40:53,726 DEBUG : BROWSER_OUTPUT: Values: 633.1 676.8 681.8 688.6 747.3 10951.1 11173.8 11180.6 11204.4 11212.9 11614.1 11717.9 11958.3 12047.5 12076.5 581.2 593.5 749.9 767.7 769.1 759.8 765.7 766.5 766.6 767.0 804.1 804.3 804.7 804.8 806.1 602.0 615.8 794.6 796.3 796.5 597.3 597.6 597.7 598.0 601.8 11345.0 11575.4 11616.9 11622.9 11645.8 11000.0 11278.9 11447.7 11529.8 11763.9 9373.6 9413.6 9514.0 9568.1 9608.8 3113.1 3129.1 3132.2 3161.5 3196.9 39671.2 39789.0 39794.2 39799.2 39833.6 8802.7 9018.6 9188.0 9270.0 9273.6 15779.4 16763.9 16972.6 17002.1 17014.7 5964.8 6085.5 6085.8 6089.3 6098.0 3476.1 3564.7 3571.7 3573.1 3608.9 2696.3 2705.3 2722.8 2725.3 2726.1 484.8 485.7 491.8 497.2 500.7 448.9 449.7 456.6 463.5 486.0 7666.8 7784.3 8173.7 8327.3 8328.5 433.6 461.5 540.3 543.1 549.2 3686.1 3709.7 3740.5 3760.4 3820.7 52121.7 52745.5 52767.2 52773.0 52807.7 44835.8 46505.0 47003.0 47378.3 47575.5 42066.6 42108.6 42798.1 42807.0 42840.0 7490.3 7536.3 7708.7 7728.5 7769.9 30947.0 31371.4 31554.2 31567.0 31660.5 37429.3 38963.0 40317.2 40658.0 40793.6 8819.7 8995.1 9000.8 9142.9 9212.7 10116.1 10288.2 10434.0 10439.0 10444.7 9743.9 9769.4 9818.8 9821.6 9920.8 9498.7 9560.8 9565.5 9590.6 9708.1 8404.9 9607.2 10772.2 10832.5 11183.0 9376.9 9472.8 9609.4 9616.7 9812.8 9304.4 9388.2 9780.4 9823.5 9918.5 09:40:53 INFO - 2015-11-26 09:40:53,726 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:40:53 INFO - 2015-11-26 09:40:53,726 DEBUG : BROWSER_OUTPUT: 09:40:54 INFO - 2015-11-26 09:40:54,465 INFO : Browser exited with error code: 0 09:40:54 INFO - 2015-11-26 09:40:54,484 INFO : Completed test dromaeo_css (00:18:36) 09:40:54 INFO - 2015-11-26 09:40:54,484 INFO : Starting test kraken 09:40:54 INFO - 2015-11-26 09:40:54,484 DEBUG : operating with platform_type : linux_ 09:40:54 INFO - 2015-11-26 09:40:54,484 INFO : Initialising browser for kraken test... 09:40:54 INFO - 2015-11-26 09:40:54,490 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVQqaX/profile http://localhost:58306/getInfo.html 09:40:58 INFO - 2015-11-26 09:40:58,265 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:40:58 INFO - 2015-11-26 09:40:58,266 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:40:58 INFO - 2015-11-26 09:40:58,266 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:40:58 INFO - 2015-11-26 09:40:58,266 DEBUG : BROWSER_OUTPUT: __metrics 09:40:58 INFO - 2015-11-26 09:40:58,427 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:59 INFO - 2015-11-26 09:40:59,659 INFO : Browser initialized. 09:40:59 INFO - 2015-11-26 09:40:59,659 INFO : Running cycle 1/1 for kraken test... 09:40:59 INFO - 2015-11-26 09:40:59,660 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVQqaX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:41:11 INFO - 2015-11-26 09:41:11,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 141021184 09:41:11 INFO - 2015-11-26 09:41:11,478 DEBUG : BROWSER_OUTPUT: 09:41:14 INFO - 2015-11-26 09:41:14,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:14 INFO - 2015-11-26 09:41:14,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 174694400 09:41:14 INFO - 2015-11-26 09:41:14,699 DEBUG : BROWSER_OUTPUT: 09:41:17 INFO - 2015-11-26 09:41:17,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-dft) 09:41:18 INFO - 2015-11-26 09:41:18,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 165765120 09:41:18 INFO - 2015-11-26 09:41:18,022 DEBUG : BROWSER_OUTPUT: 09:41:21 INFO - 2015-11-26 09:41:21,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-fft) 09:41:21 INFO - 2015-11-26 09:41:21,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 152137728 09:41:21 INFO - 2015-11-26 09:41:21,610 DEBUG : BROWSER_OUTPUT: 09:41:23 INFO - 2015-11-26 09:41:23,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-oscillator) 09:41:24 INFO - 2015-11-26 09:41:24,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 153235456 09:41:24 INFO - 2015-11-26 09:41:24,215 DEBUG : BROWSER_OUTPUT: 09:41:26 INFO - 2015-11-26 09:41:26,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:27 INFO - 2015-11-26 09:41:27,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 154873856 09:41:27 INFO - 2015-11-26 09:41:27,020 DEBUG : BROWSER_OUTPUT: 09:41:30 INFO - 2015-11-26 09:41:30,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:30 INFO - 2015-11-26 09:41:30,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 156291072 09:41:30 INFO - 2015-11-26 09:41:30,586 DEBUG : BROWSER_OUTPUT: 09:41:33 INFO - 2015-11-26 09:41:33,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:34 INFO - 2015-11-26 09:41:34,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 156033024 09:41:34 INFO - 2015-11-26 09:41:34,554 DEBUG : BROWSER_OUTPUT: 09:41:37 INFO - 2015-11-26 09:41:37,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58306/tests/kraken/driver.html?testName=json-parse-financial) 09:41:38 INFO - 2015-11-26 09:41:38,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 154353664 09:41:38 INFO - 2015-11-26 09:41:38,014 DEBUG : BROWSER_OUTPUT: 09:41:39 INFO - 2015-11-26 09:41:39,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:40 INFO - 2015-11-26 09:41:40,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 163500032 09:41:40 INFO - 2015-11-26 09:41:40,385 DEBUG : BROWSER_OUTPUT: 09:41:42 INFO - 2015-11-26 09:41:42,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:42 INFO - 2015-11-26 09:41:42,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 164151296 09:41:42 INFO - 2015-11-26 09:41:42,851 DEBUG : BROWSER_OUTPUT: 09:41:44 INFO - 2015-11-26 09:41:44,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:45 INFO - 2015-11-26 09:41:45,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 175083520 09:41:45 INFO - 2015-11-26 09:41:45,558 DEBUG : BROWSER_OUTPUT: 09:41:48 INFO - 2015-11-26 09:41:48,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:48 INFO - 2015-11-26 09:41:48,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 178044928 09:41:48 INFO - 2015-11-26 09:41:48,705 DEBUG : BROWSER_OUTPUT: 09:41:51 INFO - 2015-11-26 09:41:51,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:51 INFO - 2015-11-26 09:41:51,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 177356800 09:41:51 INFO - 2015-11-26 09:41:51,931 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58306/tests/kraken/driver.html?testName=ai-astar) 09:41:53 INFO - 2015-11-26 09:41:53,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 236068864 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;108;114;114;114;103;112;111;104 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;151;160;162;131;151;155;135;181;131 09:41:53 INFO - 2015-11-26 09:41:53,946 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;163;164;161;159;160;161;161 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;81;94;71;72;71;98;90;73 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;93;94;94;133;94;94;139 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;110;109;109;110 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;146 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;95;95;95;96;96 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;73;71;70;71;78;70;70 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;69;69;70;70;69;69;69 09:41:53 INFO - 2015-11-26 09:41:53,947 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;90;83;82;83;83;83;85;87;83 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;119;129;119;128;124;130;126;122;131 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;148;147;148;147;133;149;148;162;135 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;69;70;69;70;69;70;69;68 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:41:53 INFO - 2015-11-26 09:41:53,948 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559713941__endTimestamp 09:41:53 INFO - 2015-11-26 09:41:53,949 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:113.00 stddev:4.17 (3.7%) stddev-sans-first:4.42 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 108.0 114.0 114.0 114.0 103.0 112.0 111.0 104.0 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.50 stddev:15.71 (10.0%) stddev-sans-first:16.48 09:41:53 INFO - 2015-11-26 09:41:53,950 DEBUG : BROWSER_OUTPUT: Values: 158.0 151.0 160.0 162.0 131.0 151.0 155.0 135.0 181.0 131.0 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 163.0 164.0 161.0 159.0 160.0 161.0 161.0 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:77.00 stddev:10.73 (13.9%) stddev-sans-first:11.05 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 81.0 94.0 71.0 72.0 71.0 98.0 90.0 73.0 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:19.12 (20.3%) stddev-sans-first:19.86 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 93.0 94.0 94.0 133.0 94.0 94.0 139.0 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,951 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.50 (3.5%) stddev-sans-first:2.60 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 73.0 71.0 70.0 71.0 78.0 70.0 70.0 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 69.0 69.0 70.0 70.0 69.0 69.0 69.0 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,952 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.60 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: Values: 81.0 90.0 83.0 82.0 83.0 83.0 83.0 85.0 87.0 83.0 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:128.50 stddev:4.57 (3.6%) stddev-sans-first:4.58 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: Values: 130.0 119.0 129.0 119.0 128.0 124.0 130.0 126.0 122.0 131.0 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.00 stddev:9.04 (6.1%) stddev-sans-first:8.43 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: Values: 160.0 148.0 147.0 148.0 147.0 133.0 149.0 148.0 162.0 135.0 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 69.0 70.0 69.0 70.0 69.0 70.0 69.0 68.0 09:41:53 INFO - 2015-11-26 09:41:53,953 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:41:53 INFO - 2015-11-26 09:41:53,954 DEBUG : BROWSER_OUTPUT: 09:41:54 INFO - 2015-11-26 09:41:54,805 INFO : Browser exited with error code: 0 09:41:54 INFO - 2015-11-26 09:41:54,861 INFO : Completed test kraken (00:01:00) 09:41:54 INFO - 2015-11-26 09:41:54,861 INFO : Starting test v8_7 09:41:54 INFO - 2015-11-26 09:41:54,861 DEBUG : operating with platform_type : linux_ 09:41:54 INFO - 2015-11-26 09:41:54,861 INFO : Initialising browser for v8_7 test... 09:41:54 INFO - 2015-11-26 09:41:54,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZqrfW/profile http://localhost:58306/getInfo.html 09:41:58 INFO - 2015-11-26 09:41:58,570 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:41:58 INFO - 2015-11-26 09:41:58,570 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:41:58 INFO - 2015-11-26 09:41:58,570 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:41:58 INFO - 2015-11-26 09:41:58,570 DEBUG : BROWSER_OUTPUT: __metrics 09:41:58 INFO - 2015-11-26 09:41:58,699 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:42:00 INFO - 2015-11-26 09:42:00,086 INFO : Browser initialized. 09:42:00 INFO - 2015-11-26 09:42:00,086 INFO : Running cycle 1/1 for v8_7 test... 09:42:00 INFO - 2015-11-26 09:42:00,086 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZqrfW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:42:11 INFO - 2015-11-26 09:42:11,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 141111296 09:42:11 INFO - 2015-11-26 09:42:11,972 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58306/tests/v8_7/run.html (next: http://localhost:58306/tests/v8_7/run.html) 09:42:33 INFO - 2015-11-26 09:42:33,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 446681088 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 09:42:33 INFO - 2015-11-26 09:42:33,711 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.34880123743233 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |2;Encrypt;289.77108084613155 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2012.0724346076458 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |5;Earley;803.2128514056225 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |7;RegExp;26605.263157894737 09:42:33 INFO - 2015-11-26 09:42:33,712 DEBUG : BROWSER_OUTPUT: |8;Splay;627.3525721455458 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559753703__endTimestamp 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:42:33 INFO - 2015-11-26 09:42:33,713 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: Values: 165.8 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.35 Median:193.35 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: Values: 193.3 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,714 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:289.77 Median:289.77 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: Values: 289.8 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: Values: 5196.9 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2012.07 Median:2012.07 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: Values: 2012.1 09:42:33 INFO - 2015-11-26 09:42:33,715 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.21 Median:803.21 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: Values: 803.2 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: Values: 12000.0 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,716 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: Values: 26605.3 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:627.35 Median:627.35 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: Values: 627.4 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:42:33 INFO - 2015-11-26 09:42:33,717 DEBUG : BROWSER_OUTPUT: 09:42:34 INFO - 2015-11-26 09:42:34,581 INFO : Browser exited with error code: 0 09:42:34 INFO - 2015-11-26 09:42:34,598 INFO : Completed test v8_7 (00:00:39) 09:42:34 INFO - 2015-11-26 09:42:34,671 INFO : Completed test suite (00:20:17) 09:42:34 INFO - 2015-11-26 09:42:34,672 DEBUG : Working with test: dromaeo_css 09:42:34 INFO - 2015-11-26 09:42:34,672 DEBUG : Generating results file: dromaeo_css 09:42:34 INFO - 2015-11-26 09:42:34,673 DEBUG : Working with test: kraken 09:42:34 INFO - 2015-11-26 09:42:34,673 DEBUG : Generating results file: kraken 09:42:34 INFO - 2015-11-26 09:42:34,673 INFO : javascript benchmark 09:42:34 INFO - 2015-11-26 09:42:34,673 DEBUG : Working with test: v8_7 09:42:34 INFO - 2015-11-26 09:42:34,674 DEBUG : Generating results file: v8_7 09:42:34 INFO - 2015-11-26 09:42:34,674 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:42:34 INFO - 2015-11-26 09:42:34,740 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 09:42:34 INFO - 2015-11-26 09:42:34,740 DEBUG : process_Request line: dromaeo_css 6284.19 graph.html#tests=[[72,94,35]] 09:42:34 INFO - 2015-11-26 09:42:34,740 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:42:34 INFO - 2015-11-26 09:42:34,774 DEBUG : process_Request line: kraken 1527.10 graph.html#tests=[[232,94,35]] 09:42:34 INFO - 2015-11-26 09:42:34,774 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:42:34 INFO - 2015-11-26 09:42:34,810 DEBUG : process_Request line: v8_7 19572.93 graph.html#tests=[[230,94,35]] 09:42:34 INFO - 2015-11-26 09:42:34,811 INFO : javascript benchmark 09:42:34 INFO - 2015-11-26 09:42:34,815 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.585594232894, 2784.0, 2790.4558611070847, 2806.4667713134504, 2813.873375698094, 4635.072985402924, 4734.053189362133, 4810.5189481051875, 4818.759062046896, 4837.63717721171, 4698.45967713713, 4725.574698277163, 4816.638752093599, 4823.107725070864, 4837.540433658805, 4382.233109205884, 4442.489113751912, 4469.64242860572, 4471.083427897273, 4529.614982726473, 4287.699861009731, 4501.819927202908, 4507.752073635948, 4543.341215523747, 4549.476810166823, 4349.41282926804, 4374.956250437503, 4396.802143903532, 4422.6682998774895, 4440.689151759379, 4411.735295882258, 4432.889177770549, 4433.977830110861, 4436.889077773049, 4479.1489616972995, 4404.933925991113, 4408.20652282589, 4411.735295882225, 4444.355568442557, 4460.264056430685, 4528.479224889114, 4653.441587009546, 4693.389859318301, 4694.201985662446, 4737.123632128068, 5141.974290128525, 5144.176931690949, 5145.665531740425, 5158.148905430599, 5228.79084836606, 5159.0, 5161.767720452589, 5170.922436163461, 5211.687298762048, 5215.58275337972, 4610.608098311681, 4715.504871988392, 4718.197906355927, 4719.5752382285755, 4814.181589129857, 5271.182966640177, 5354.9464505354445, 5356.705381204071, 5363.651362661414, 5369.221462887859, 5118.59051275897, 5133.12736834739, 5138.203578445347, 5141.897162056738, 5196.58427325813, 4935.975320123376, 5042.218456139304, 5042.596592272609, 5050.242463630485, 5216.21756736485, 5048.899022019613, 5122.820701275437, 5123.38519377677, 5127.6154288428515, 5149.588032957355, 5132.769025393866, 5172.353455818023, 5179.938112686966, 5183.222516622537, 5188.45521220274, 4150.771707556053, 4251.851185208503, 4279.2083464559155, 4328.091100868853, 4369.47566292047, 3621.366260904384, 3662.249238906018, 3704.981475092607, 3707.536557930259, 3755.0, 4388.692791504564, 4394.868153955386, 4406.383106365111, 4407.977960110179, 4448.644108471314, 4981.277714731344, 5092.6180536459915, 5201.0, 5208.062548741263, 5256.0, 4263.232618128704, 4366.978165109154, 4373.584509471595, 4382.408374869416, 4409.14021765759, 4536.160810250114, 4556.567126123013, 4556.886077848014, 4564.452265728134, 4600.5169457207185, 4882.4385195701525, 4888.0, 4888.364512613338, 4890.217565189624, 4931.531504506995, 5077.720725360141, 5167.199084141964, 5205.349331333583, 5212.817551385683, 5299.8410047698635, 4930.186519224431, 4931.876703082452, 4940.258961155711, 4942.357493525818, 4980.626453016111, 5127.769250383816, 5133.563647090039, 5134.589232861287, 5136.332276803992, 5149.613778966667, 4910.484399138039, 5120.513551212629, 5132.178851383761, 5187.325647665779, 5283.445238250082, 5022.146235140108, 5027.899442011066, 5032.84901452957, 5036.874078148076, 5078.162103252922, 5030.119729047476, 5031.974840125776, 5035.571976382049, 5037.168867136881, 5038.7984480621835, 4740.170470167775, 4807.567318941312, 4848.17581011236, 4861.1006963711825, 4966.652334336706, 5084.491550844886, 5104.744762761921, 5120.692758434506, 5123.974380128076, 5125.154349532286, 4976.900461990812, 4990.476000019946, 5002.849914502571, 5009.0482808266315, 5043.798248070036], "unit": "ms", "name": "dojo.html", "value": 4720.9550833188705}, {"lowerIsBetter": false, "replicates": [552.61869310176, 555.5638823523534, 564.2270089976732, 569.3395661033202, 580.6342004537141, 27074.86462567687, 27653.723462765367, 27678.3080422989, 27685.446291074193, 27708.168754937386, 36897.44653830195, 37446.0, 37741.81129094357, 37815.0, 37864.81067594658, 7895.289423951857, 8118.959405202995, 8127.837443251161, 8133.633986470623, 8135.75592732219, 7156.785296441115, 7334.706611735524, 7880.290773830354, 7995.920550725665, 10006.749831254205, 9582.185514231263, 9656.5171741413, 9662.371945823534, 9664.081912218327, 9665.033496650349, 10041.648542301022, 10146.695599132037, 10174.084332410119, 10174.135198508136, 10177.084062434342, 7154.570725756471, 7356.96321518389, 7358.153812311599, 7358.41132709382, 9987.300888937778, 36187.81906090479, 36912.26175476475, 36924.446133308025, 36932.07669808249, 37007.25985480275, 2946.175070980129, 2997.7501974164597, 2998.8800447982053, 3013.0, 3559.341521818472, 27713.307167320978, 30051.248718782204, 30407.543886841715, 30473.085807425592, 30695.232619184477, 3367.3265346930466, 3482.7387945904156, 3486.337595856779, 3522.4892390603477, 3553.3248682750195, 204893.0, 206299.0, 206574.96712516493, 206968.0, 207100.0, 54306.0, 54387.0, 54650.0, 54859.72570137124, 54876.45123548793, 58001.4199857996, 58191.709041454524, 58221.0, 58248.0, 58565.0, 13610.251436170907, 13889.305534723224, 13991.090579112528, 14001.789973150411, 14020.228887411291, 10397.272190946562, 10419.739506512398, 10486.73783155412, 10529.894701052892, 10545.525451354708, 18386.448406547825, 18444.35444759454, 18457.0, 18581.25674973013, 18601.348952786586, 7372.152202496782, 7591.3547348475995, 7629.819845924708, 7630.618469076524, 7732.729354472566, 899.2266650680409, 906.6509393883271, 938.8685584018243, 1002.8317010682619, 1048.7483004078965, 26274.21177364644, 26527.668960561376, 26659.46681066368, 26761.866190668923, 26812.0, 861.5907443964193, 935.158357478275, 992.692265397729, 1018.2719355660738, 1033.421284080917, 12661.49354025847, 14883.181425021512, 15488.303026363616, 15511.767323490156, 15676.451324203597, 243659.0, 244286.0, 246063.0, 246405.0, 247079.0, 47733.0, 48229.27656085161, 48242.27636585454, 48298.75850620725, 48330.758346208044, 1220.0727447140237, 1222.2483172848633, 1223.1865809236936, 1229.0474881966547, 1244.402686710366, 26698.332541686614, 27223.0, 27412.862935685192, 27643.30891727723, 27794.305142370795, 38415.0, 38773.2245355097, 38778.6122138775, 38796.2240755189, 38832.80583597064, 247974.0, 249482.0, 250382.0, 251050.0, 251288.0, 24478.63282050735, 24910.37724056913, 28095.0, 28628.427431450837, 29182.708172918, 33524.0, 33622.83188584042, 36293.45559816552, 36820.263594728494, 37328.44007339946, 31775.841120794248, 32148.35703285968, 32229.677703222667, 32638.83680581677, 32738.672613274513, 29816.850915745283, 31391.84304078465, 34573.30853382868, 38009.80995095007, 39008.41487377748, 34588.30823383468, 34833.0, 34873.65126348704, 34906.30187396187, 37614.24771504609, 28192.0, 28775.85612071926, 29736.851315743283, 30018.849905750332, 30092.0, 23879.76120238845, 23983.236878866213, 24047.348873015177, 24269.51460970806, 24388.0], "unit": "ms", "name": "ext.html", "value": 16949.156703630255}, {"lowerIsBetter": false, "replicates": [302.6413699765778, 311.09936733157525, 316.1621702488406, 316.22997999870313, 316.8447460744235, 12528.749425011494, 13007.804882926765, 14791.482298119568, 15173.696526069485, 15353.539393818175, 14344.497942572012, 14992.250387480637, 16012.359505619761, 16420.507384778444, 16519.0, 5241.659292146008, 5615.971920140393, 5624.943750562504, 5646.124850648156, 5646.6894320812335, 3895.357266051112, 3992.121733218687, 4002.2995975704134, 5638.097904335307, 6358.300586935434, 6456.9354306457035, 6548.770793022221, 6605.108310378109, 6606.801795946105, 6608.471322294205, 6504.2194936607675, 6566.146400967891, 6570.605763654196, 6576.177977752781, 6579.309172536887, 6130.816075517741, 6244.625322480666, 6257.405546473078, 6290.182276304051, 6314.557980941336, 19904.80095199044, 20503.897480512653, 20602.969851507365, 20806.687899681518, 21584.352469425943, 1832.0, 1999.4301624037225, 2061.8247448966854, 2073.6474799284006, 2118.8410869184872, 13093.607191784167, 13506.31171103612, 14060.437582496688, 14188.290585470788, 14298.428062877472, 1765.4262364731385, 1874.109797846026, 1878.7557617509774, 1930.536671198916, 1942.5337918899504, 60822.0, 65266.0, 65315.02027469592, 66561.0, 66924.0, 15155.621109472351, 15186.772198417033, 15218.543443696706, 15248.0, 15258.923705381401, 22807.771922280896, 23014.0, 23094.307170784905, 23108.07567697307, 23112.537749244922, 8571.699990500303, 8589.184027517376, 8672.523011234443, 8693.956530217309, 8871.778205544784, 7260.52806567582, 7284.817879553054, 7334.193238743841, 7404.703811847574, 7408.296211859864, 7521.473496855277, 7613.505122167152, 7624.313811756858, 7654.8086297843, 7755.72854950074, 1531.5175719648275, 1680.4790514940407, 1687.8902871313326, 1705.8550023247915, 2143.38174678117, 683.6156782515446, 828.1842385250524, 830.485099238476, 871.9389642724948, 886.6409104312763, 15304.617384565476, 15811.446599369197, 15897.046177229404, 16312.0, 16893.577660558338, 736.2269616902231, 796.9003874515686, 844.8901642786399, 845.8815765792793, 879.5118709116374, 5253.842384728464, 5299.693364895762, 5354.651947623392, 5380.188002867812, 5395.70323632204, 493918.0, 509148.0, 525161.0, 529663.0, 535738.0, 73143.0, 75717.62141189369, 76054.61972690212, 76503.61748191334, 76723.61638191773, 395.97822119783115, 400.4753772557958, 400.87773229165384, 400.89153490598517, 401.7147825044193, 8919.197272245528, 9094.408863423856, 9238.122378374044, 9252.676156334495, 9364.157225849705, 32788.508172376954, 33605.83197083999, 33741.83129084339, 33931.83034084814, 33961.66038339585, 41900.652262942676, 43984.34023489714, 44902.55097448984, 47530.28704569503, 50088.74955625198, 8398.244158025807, 8626.217109507767, 8758.518281494578, 8765.211130998241, 8775.210231078978, 13220.603381898558, 15438.768418473957, 15687.29407176657, 15837.128957907426, 15845.049297042215, 13303.866961330263, 13701.177929324273, 13889.305534723022, 14098.50655227062, 14244.074135181594, 13381.39783709716, 13537.661558461117, 13930.930345348208, 13994.65013374633, 14289.71420571562, 10505.68482945513, 13876.236806975714, 14208.289585520475, 14346.139231646135, 14555.272236387926, 7450.254974502506, 8492.787680308042, 8690.304775618062, 8748.431351962103, 8751.737447876574, 13025.413856376676, 13184.077114601885, 13351.198928064347, 13671.521496747566, 13843.653908652364], "unit": "ms", "name": "jquery.html", "value": 8637.925751160756}, {"lowerIsBetter": false, "replicates": [1406.54287356609, 1583.9366425342987, 1611.6454380036396, 1636.3945340224118, 1659.5851037240686, 5863.648181109136, 6426.518011149165, 6669.86660266795, 6671.099401580797, 6676.0, 6582.4075833175, 6670.933290667092, 6717.59694418334, 6735.528513004092, 6735.797926062214, 1708.7436884467304, 1736.2360561353028, 1910.2168111074461, 1913.4642300155979, 1936.1674479973606, 1949.7172909928051, 1950.580625165589, 1953.8534609904243, 1954.0, 1954.4039068084228, 1896.2320260294534, 1923.9807601924012, 1928.479310586148, 1943.4946913802441, 1945.0, 1921.9711704324445, 1939.1177014458387, 1962.587856550119, 1969.2910552201197, 1971.2607772085469, 1912.8852268863914, 1952.4142757172933, 1955.599102184049, 1957.628050670368, 1958.2852258925532, 6566.540342176049, 6631.701573429207, 6637.0, 6639.3692599203, 6642.5350225484235, 3829.5596006459336, 3875.1280961783655, 3900.180961997984, 3912.56961734209, 3915.7846318452475, 2183.5087105401317, 2555.7060937992183, 2564.2050964201158, 2603.960940585893, 2625.619285203654, 709.7799682098514, 754.2495217258808, 780.4692808889953, 784.3411534311149, 859.613174071664, 8631.395802293842, 8633.438826476196, 8641.049484556694, 8650.178233067849, 8702.912970870337, 3558.893233203008, 3575.8212089395424, 3615.385384484644, 3633.6366363363454, 3636.4908912752235, 7594.430417718693, 7611.3530349920875, 7612.238776122344, 7615.048118985127, 7616.69533218665, 3931.7811478441204, 3955.940660890089, 3969.583193764671, 3970.0471886746973, 3979.2837289288204, 3599.7300202484394, 3610.350136975317, 3611.4041183205004, 3612.259486805199, 3613.1147868771795, 2819.9859000705274, 2852.757515611196, 2856.200263926104, 3137.105924811418, 3150.1652062203534, 951.5860600638745, 1011.8178727828914, 1016.9288149829589, 1025.3642741500319, 1029.8506716526063, 791.8168960777641, 842.9747107586783, 991.3506653142204, 992.0922356044139, 993.3642468819961, 6247.250329960434, 6312.210973628296, 6344.365563443619, 6528.869422611521, 6534.281229064799, 985.261054209343, 987.244757760314, 1002.7593377589326, 1003.1172568140136, 1005.4520286443906, 4864.343313652612, 4946.431160416526, 4999.275105109811, 5004.524570165829, 5009.298698182258, 7849.450538462367, 8026.27763501276, 8031.277185053256, 8035.758927232192, 8048.83902321962, 7953.0456345238945, 7959.960200199078, 7960.044794624682, 7961.203879611992, 7963.721269755531, 6164.7842325518395, 6200.441960223511, 6231.0, 6238.313785483593, 6254.906176407358, 5967.104934259895, 5977.731002104829, 5990.7903223386975, 5995.100734889627, 5997.100434934795, 6865.382115609619, 7060.364567188978, 7064.470164737768, 7117.537360071578, 7159.713611455483, 7130.5365151265005, 7311.488195826241, 7491.138519070377, 7517.398608111447, 7543.660535276035, 5998.4601385875485, 6029.638221706711, 6073.908891366721, 6079.574429789872, 6095.207623008981, 5415.729213539386, 5598.048331783525, 6184.443400094013, 6332.556721029484, 6367.395097465734, 5693.316801983623, 5902.852428689317, 5935.080062590306, 5981.52147828164, 6094.024956007018, 5541.944580554304, 5706.6005379624685, 5712.571557133148, 5723.227364305932, 5833.387494313036, 6025.367336429612, 6065.423784740443, 6065.969670151621, 6069.150318955438, 6073.726682299395, 5455.0, 5569.582281328835, 5617.354004289559, 5633.1831884375715, 5642.210090587403, 5657.236273103078, 5705.572082093777, 5708.942910570841, 5711.571632127524, 5723.084306510938], "unit": "ms", "name": "mootools.html", "value": 3804.8729872561594}, {"lowerIsBetter": false, "replicates": [283.5859644918419, 288.2620491541652, 289.5381865923852, 290.8342244920396, 294.0253061102445, 5342.973285133578, 5425.674459532426, 5442.346918369792, 5464.180372944061, 5508.228847961279, 5334.653247538917, 5389.487998640133, 5393.460653934604, 5400.675959442437, 5407.621466497347, 4107.753534787922, 4112.9588704112875, 4118.546959834416, 4119.258533463968, 4120.917581648365, 3937.2912875682364, 4026.5973402659647, 4040.373742069969, 4090.365993271048, 4091.488563929509, 4051.149258655686, 4058.1680755445063, 4077.368007958771, 4078.1028173801715, 4083.2854250506043, 3876.457295978565, 3972.980135099306, 4085.060436099699, 4088.080181959065, 4088.713790034684, 3453.6028356739043, 3455.671711187433, 3458.7405944554007, 3461.4288642373976, 3466.722662187019, 5171.715555644438, 5184.066867963765, 5192.71440070796, 5200.167973124319, 5202.739863006835, 4664.0, 4664.743439110847, 4666.743329116897, 4674.065186962587, 4674.953250467486, 5466.371367292772, 5602.411746766612, 5608.046632072516, 5613.775448982035, 5615.241942337773, 3836.9040773980873, 3837.539495260559, 3840.8079596020366, 3841.8079096045367, 3848.2111167210655, 5880.059190529538, 5935.584509084366, 5941.524678025748, 5948.375420580864, 5954.1664167016215, 3937.9803100984313, 3938.0, 3942.014496375906, 3944.3294639911283, 3946.230485055444, 3902.969368722413, 3980.681545476355, 3986.5614782374496, 3987.5613682494904, 3993.7803420812133, 4590.40324757786, 4662.533746625379, 4665.090307390026, 4669.486356500782, 4669.789859456333, 5568.0, 5657.094864821609, 5666.858328541819, 5677.2619559457835, 5685.943140568624, 1398.3637444962721, 1399.5731301952799, 1406.2054938959454, 1407.5425486716654, 1409.2530958591963, 902.9277657787361, 905.4657751926395, 931.8741969834122, 936.3164889630608, 938.3759799733238, 4948.579370753526, 4962.15643340633, 4964.478729733398, 4971.701697898137, 4972.776225069881, 5898.203742494708, 5905.616134951214, 5911.940880591225, 5914.260717410324, 5915.467607915309, 4947.084789313988, 4951.678140920829, 4960.603151747851, 4961.950380496221, 4964.528369804862, 3073.6772638872594, 3099.5815564898903, 3165.699258570432, 3178.030700636328, 3187.314727333588, 5491.423400542965, 5512.5589952803675, 5644.463775941361, 5646.943530564642, 5652.802151924745, 6096.207493025967, 6116.4922381823235, 6117.0, 6118.816435506942, 6119.969400152971, 5574.247476590608, 5625.296837895263, 5625.578081643975, 5632.12702031194, 5637.661740295595, 5817.680027598353, 5961.791337303173, 5971.134185543159, 5987.730552125077, 5998.790042348497, 5814.186013958134, 5823.534117270524, 5826.73779679907, 5829.5336373090895, 5830.53355731549, 5632.507385542753, 5638.041532939328, 5649.435056494318, 5651.547876169814, 5655.699189186593, 3951.4572307876156, 4008.4388185654616, 4011.0, 4037.8990525237105, 4045.150518391171, 5884.35272120075, 5887.676177810262, 5891.94108058931, 5902.5277977762535, 5903.11453281994, 5653.491185793298, 5662.03745363281, 5663.263775709132, 5675.943240567542, 5676.2337084493065, 5654.660720356627, 5661.150827375926, 5668.801591944262, 5670.943290567042, 5672.432756724294, 5379.462053794589, 5541.612087153861, 5545.750441230073, 5546.223528706065, 5553.750081246434, 5689.829305120853, 5709.22925405065, 5709.286339207599, 5709.9714501427225, 5712.228849105318, 5568.638038527482, 5571.888562228652, 5572.86067848307, 5573.052581061148, 5573.414791446839], "unit": "ms", "name": "prototype.html", "value": 4210.692327700893}, {"lowerIsBetter": false, "replicates": [633.0599060395315, 676.7529851604166, 681.8193178807616, 688.5730846874939, 747.3012733094555, 10951.123910087194, 11173.83239251412, 11180.552777888885, 11204.383758893258, 11212.887871121286, 11614.128940329489, 11717.882821171786, 11958.342291173982, 12047.518099276018, 12076.516939322439, 581.2269681323829, 593.4777395891609, 749.8837680159584, 767.7312940470819, 769.0732667136116, 759.760675387254, 765.7358211417052, 766.4826242286434, 766.6205228411944, 766.9961650191741, 804.0592506767097, 804.3082948664144, 804.7223707820792, 804.7625950344662, 806.1495122645606, 602.0457574744014, 615.7998650438603, 794.606669698503, 796.319147129202, 796.5021861336664, 597.2922087326532, 597.6414151509103, 597.7340083662772, 597.9970100149471, 601.7803501721884, 11345.0, 11575.36335501547, 11616.94191529037, 11622.941885290604, 11645.825312620318, 11000.0, 11278.887211127947, 11447.656570302905, 11529.769404611861, 11763.88236117645, 9373.578188981444, 9413.57638906251, 9513.952430237805, 9568.09103135201, 9608.807823843485, 3113.128324069264, 3129.0612816155062, 3132.15431833406, 3161.525771134325, 3196.9360612787846, 39671.20657586861, 39789.0, 39794.20411591752, 39799.20401591952, 39833.60166398328, 8802.735917922473, 9018.59416326267, 9188.0, 9269.953650231706, 9273.629054837731, 15779.447719329768, 16763.91618041902, 16972.575685607957, 17002.14989250557, 17014.659706806044, 5964.7912323068485, 6085.5435842312, 6085.847853803691, 6089.330173680892, 6097.969510152509, 3476.0788391076385, 3564.7148228141687, 3571.714262858965, 3573.0888623400865, 3608.8736894208578, 2696.258528904528, 2705.269577214141, 2722.754952054325, 2725.2914242296747, 2726.114012945761, 484.82788610043633, 485.6988667026466, 491.7737840593367, 497.16972655665126, 500.7070863544867, 448.91695036418366, 449.6784798868759, 456.63697360598405, 463.5133110234241, 486.03279473847493, 7666.846663066819, 7784.299413052852, 8173.67305307781, 8327.292180164754, 8328.458650187718, 433.62491444899933, 461.4670056085227, 540.3084052412918, 543.0849019402319, 549.2063967566908, 3686.1337585667347, 3709.703223742094, 3740.5137332146646, 3760.417135344026, 3820.6943444524372, 52121.739391303556, 52745.47254527405, 52767.208491872654, 52773.0, 52807.735961319944, 44835.77582112069, 46505.0, 47003.0, 47378.289325660146, 47575.5242447578, 42066.58668266359, 42108.57891421046, 42798.14403711971, 42807.0, 42840.0, 7490.250974902466, 7536.284053014955, 7708.691652333844, 7728.4590078693955, 7769.883451748341, 30947.0, 31371.372572548877, 31554.211144721565, 31567.0, 31660.525092123175, 37429.251414971004, 38963.0, 40317.1936561273, 40658.0, 40793.59206408016, 8819.735407937773, 8995.100489951214, 9000.819983600422, 9142.908570914205, 9212.723618291462, 10116.1401280889, 10288.182573687898, 10434.0, 10439.0, 10444.68665940023, 9743.905060412046, 9769.413835169913, 9818.75453113678, 9821.607135714492, 9920.801583968136, 9498.715038548855, 9560.808783824146, 9565.473898935346, 9590.616375345187, 9708.126268635857, 8404.898374381308, 9607.231421486125, 10772.24594278393, 10832.458377081271, 11183.0, 9376.859347109936, 9472.810543789223, 9609.375390599589, 9616.663416780379, 9812.803743924938, 9304.395214311047, 9388.202002829563, 9780.41317520951, 9823.544113971508, 9918.454485003394], "unit": "ms", "name": "yui.html", "value": 5561.154333432164}], "name": "dromaeo_css", "value": 6284.187126691484}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 108.0, 114.0, 114.0, 114.0, 103.0, 112.0, 111.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [158.0, 151.0, 160.0, 162.0, 131.0, 151.0, 155.0, 135.0, 181.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 163.0, 164.0, 161.0, 159.0, 160.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 81.0, 94.0, 71.0, 72.0, 71.0, 98.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 93.0, 94.0, 94.0, 133.0, 94.0, 94.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 73.0, 71.0, 70.0, 71.0, 78.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 83.0, 82.0, 83.0, 83.0, 83.0, 85.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 129.0, 119.0, 128.0, 124.0, 130.0, 126.0, 122.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [160.0, 148.0, 147.0, 148.0, 147.0, 133.0, 149.0, 148.0, 162.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 69.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1527.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [193.34880123743233], "unit": "score", "name": "DeltaBlue", "value": 341.96229600000015}, {"lowerIsBetter": false, "replicates": [289.77108084613155], "unit": "score", "name": "Encrypt", "value": 918.5906310000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [2012.0724346076458], "unit": "score", "name": "RayTrace", "value": 367.77453300000013}, {"lowerIsBetter": false, "replicates": [803.2128514056225], "unit": "score", "name": "Earley", "value": 829.7464350000001}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [627.3525721455458], "unit": "score", "name": "Splay", "value": 129.89665399999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19572.925012519845}]} 09:42:34 INFO - RETURN: dromaeo_css: 6284.19 09:42:34 INFO - RETURN: kraken: 1527.10 09:42:34 INFO - RETURN: v8_7: 19572.93 09:42:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19572.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1527.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6284.19"}}} 09:42:34 INFO - Return code: 0 09:42:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:42:34 INFO - # TBPL SUCCESS # 09:42:34 INFO - Running post-action listener: _resource_record_post_action 09:42:34 INFO - Running post-run listener: _resource_record_post_run 09:42:36 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519036928; Read time: 8; Write time: 352412 09:42:36 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 229466112; Read time: 0; Write time: 196156 09:42:36 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274710528; Read time: 8; Write time: 152524 09:42:36 INFO - Running post-run listener: _upload_blobber_files 09:42:36 INFO - Blob upload gear active. 09:42:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:42:36 INFO - Copying logs to upload dir... 09:42:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.517520 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 09:42:35.774691) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:42:35.778580) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009894 build_url: 'https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/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-11-26 09:42:35.829975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:42:35.830316) ========= 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=e10134013339c31d8d0c4708000001d6-1448558488.869448-1787285808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:42:35.880104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:42:35.880409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:42:35.880713) ========= ========= Total master_lag: 0.22 =========