builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1450400784.09 results: success (0) buildid: 20151217160558 builduid: 3e0ff8b2a8dd46329312701db19c7fc8 revision: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.094068) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.094499) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.094797) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005758 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.138912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.139188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.168391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.168754) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012587 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.216195) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.216513) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.216916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.217199) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 17:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.7M=0s 2015-12-17 17:06:24 (64.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.244797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.474412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.474732) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.118027 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.604595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:24.604959) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --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 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 17:06:24,687 truncating revision to first 12 chars 2015-12-17 17:06:24,687 Setting DEBUG logging. 2015-12-17 17:06:24,687 attempt 1/10 2015-12-17 17:06:24,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66fb852962c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 17:06:24,995 unpacking tar archive at: mozilla-central-66fb852962c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569322 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:25.186545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:25.186901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:25.195155) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:25.195418) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:06:25.195853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 17:06:25.196163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:25 INFO - MultiFileLogger online at 20151217 17:06:25 in /builds/slave/test 17:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 17:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:25 INFO - {'append_to_log': False, 17:06:25 INFO - 'base_work_dir': '/builds/slave/test', 17:06:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:25 INFO - 'branch': 'Firefox-Non-PGO', 17:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:25 INFO - 'config_files': ('talos/linux_config.py',), 17:06:25 INFO - 'default_actions': ('clobber', 17:06:25 INFO - 'read-buildbot-config', 17:06:25 INFO - 'download-and-extract', 17:06:25 INFO - 'populate-webroot', 17:06:25 INFO - 'create-virtualenv', 17:06:25 INFO - 'install', 17:06:25 INFO - 'run-tests'), 17:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:25 INFO - 'download_minidump_stackwalk': True, 17:06:25 INFO - 'download_symbols': 'ondemand', 17:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:25 INFO - 'installer_path': 'installer.exe', 17:06:25 INFO - 'log_level': 'info', 17:06:25 INFO - 'log_name': 'talos', 17:06:25 INFO - 'log_to_console': True, 17:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:25 INFO - 'opt_config_files': (), 17:06:25 INFO - 'pip_index': False, 17:06:25 INFO - 'sps_profile': False, 17:06:25 INFO - 'sps_profile_interval': 0, 17:06:25 INFO - 'suite': 'dromaeojs-e10s', 17:06:25 INFO - 'system_bits': '64', 17:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:25 INFO - 'title': 'talos-linux64-ix-015', 17:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:25 INFO - 'use_talos_json': True, 17:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:25 INFO - 'work_dir': 'build'} 17:06:25 INFO - ##### 17:06:25 INFO - ##### Running clobber step. 17:06:25 INFO - ##### 17:06:25 INFO - Running pre-action listener: _resource_record_pre_action 17:06:25 INFO - Running main action method: clobber 17:06:25 INFO - rmtree: /builds/slave/test/build 17:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:27 INFO - Running post-action listener: _resource_record_post_action 17:06:27 INFO - ##### 17:06:27 INFO - ##### Running read-buildbot-config step. 17:06:27 INFO - ##### 17:06:27 INFO - Running pre-action listener: _resource_record_pre_action 17:06:27 INFO - Running main action method: read_buildbot_config 17:06:27 INFO - Using buildbot properties: 17:06:27 INFO - { 17:06:27 INFO - "project": "", 17:06:27 INFO - "product": "firefox", 17:06:27 INFO - "script_repo_revision": "production", 17:06:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:06:27 INFO - "repository": "", 17:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:06:27 INFO - "buildid": "20151217160558", 17:06:27 INFO - "pgo_build": "False", 17:06:27 INFO - "basedir": "/builds/slave/test", 17:06:27 INFO - "buildnumber": 148, 17:06:27 INFO - "slavename": "talos-linux64-ix-015", 17:06:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:27 INFO - "platform": "ubuntu64_hw", 17:06:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:06:27 INFO - "branch": "mozilla-central", 17:06:27 INFO - "repo_path": "mozilla-central", 17:06:27 INFO - "revision": "66fb852962c0d5f6f5fe0604204da4f5d17763c9", 17:06:27 INFO - "stage_platform": "linux64", 17:06:27 INFO - "builduid": "3e0ff8b2a8dd46329312701db19c7fc8", 17:06:27 INFO - "slavebuilddir": "test" 17:06:27 INFO - } 17:06:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:06:27 INFO - Running post-action listener: _resource_record_post_action 17:06:27 INFO - ##### 17:06:27 INFO - ##### Running download-and-extract step. 17:06:27 INFO - ##### 17:06:27 INFO - Running pre-action listener: _resource_record_pre_action 17:06:27 INFO - Running main action method: download_and_extract 17:06:27 INFO - mkdir: /builds/slave/test/build/tests 17:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:27 INFO - https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/test_packages.json 17:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/test_packages.json 17:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:06:28 INFO - Downloaded 1302 bytes. 17:06:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:06:28 INFO - Using the following test package requirements: 17:06:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'jsshell-linux-x86_64.zip'], 17:06:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:28 INFO - https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:29 INFO - Downloaded 21870791 bytes. 17:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:06:30 INFO - Return code: 0 17:06:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:30 INFO - https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:32 INFO - Downloaded 21870791 bytes. 17:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:06:33 INFO - Return code: 0 17:06:33 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')]} 17:06:33 INFO - https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:06:34 INFO - Downloaded 11132039 bytes. 17:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:06:34 INFO - Return code: 0 17:06: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')]} 17:06:34 INFO - https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:06:36 INFO - Downloaded 53021677 bytes. 17:06:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:36 INFO - mkdir: /builds/slave/test/properties 17:06:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:36 INFO - Contents: 17:06:36 INFO - build_url:https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:36 INFO - Running post-action listener: _resource_record_post_action 17:06:36 INFO - Running post-action listener: set_extra_try_arguments 17:06:36 INFO - ##### 17:06:36 INFO - ##### Running populate-webroot step. 17:06:36 INFO - ##### 17:06:36 INFO - Running pre-action listener: _resource_record_pre_action 17:06:36 INFO - Running main action method: populate_webroot 17:06:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:36 INFO - '--tppagecycles', 17:06:36 INFO - '7'], 17:06:36 INFO - 'tests': ['tsvgm']}}, 17:06:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:06:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'tests': ['damp', 'tps']}, 17:06:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['damp', 'tps']}, 17:06:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:06:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:36 INFO - 'other': {'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'other_l64': {'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'other_nol64': {'tests': ['a11yr', 17:06:36 INFO - 'ts_paint', 17:06:36 INFO - 'tpaint', 17:06:36 INFO - 'sessionrestore', 17:06:36 INFO - 'sessionrestore_no_auto_restore']}, 17:06:36 INFO - 'svgr': {'tests': ['tsvgx', 17:06:36 INFO - 'tsvgr_opacity', 17:06:36 INFO - 'tart', 17:06:36 INFO - 'tscrollx', 17:06:36 INFO - 'cart']}, 17:06:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['tsvgx', 17:06:36 INFO - 'tsvgr_opacity', 17:06:36 INFO - 'tart', 17:06:36 INFO - 'tscrollx', 17:06:36 INFO - 'cart']}, 17:06:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'tests': ['tp5o']}, 17:06:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'talos_options': ['--e10s'], 17:06:36 INFO - 'tests': ['tp5o']}, 17:06:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'talos_options': ['--xperf_path', 17:06:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:36 INFO - 'tests': ['tp5n']}, 17:06:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:36 INFO - 'talos_options': ['--e10s', 17:06:36 INFO - '--xperf_path', 17:06:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:36 INFO - 'tests': ['tp5n']}}, 17:06:36 INFO - 'talos.zip': {'path': '', 17:06:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:36 INFO - Running post-action listener: _resource_record_post_action 17:06:36 INFO - ##### 17:06:36 INFO - ##### Running create-virtualenv step. 17:06:36 INFO - ##### 17:06:36 INFO - Running pre-action listener: _resource_record_pre_action 17:06:36 INFO - Running main action method: create_virtualenv 17:06:36 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:36 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 17:06:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:36 INFO - Using real prefix '/usr' 17:06:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:38 INFO - Installing pip.................done. 17:06:38 INFO - Return code: 0 17:06:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06:38 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 17:06:38 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 17:06:38 INFO - Using env: {'DISPLAY': ':0', 17:06:38 INFO - 'HOME': '/home/cltbld', 17:06:38 INFO - 'LANG': 'en_US.UTF-8', 17:06:38 INFO - 'LANGUAGE': 'en_US:en', 17:06:38 INFO - 'LOGNAME': 'cltbld', 17:06:38 INFO - 'MAIL': '/var/mail/cltbld', 17:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:38 INFO - 'MOZ_NO_REMOTE': '1', 17:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:38 INFO - 'NO_EM_RESTART': '1', 17:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:38 INFO - 'PWD': '/builds/slave/test', 17:06:38 INFO - 'SHELL': '/bin/bash', 17:06:38 INFO - 'SHLVL': '1', 17:06:38 INFO - 'TERM': 'linux', 17:06:38 INFO - 'TMOUT': '86400', 17:06:38 INFO - 'USER': 'cltbld', 17:06:38 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:38 INFO - '_': '/tools/buildbot/bin/python'} 17:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:39 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 17:06:39 INFO - Cleaning up... 17:06:39 INFO - Return code: 0 17:06:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:06:39 INFO - Using env: {'DISPLAY': ':0', 17:06:39 INFO - 'HOME': '/home/cltbld', 17:06:39 INFO - 'LANG': 'en_US.UTF-8', 17:06:39 INFO - 'LANGUAGE': 'en_US:en', 17:06:39 INFO - 'LOGNAME': 'cltbld', 17:06:39 INFO - 'MAIL': '/var/mail/cltbld', 17:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:39 INFO - 'MOZ_NO_REMOTE': '1', 17:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:39 INFO - 'NO_EM_RESTART': '1', 17:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:39 INFO - 'PWD': '/builds/slave/test', 17:06:39 INFO - 'SHELL': '/bin/bash', 17:06:39 INFO - 'SHLVL': '1', 17:06:39 INFO - 'TERM': 'linux', 17:06:39 INFO - 'TMOUT': '86400', 17:06:39 INFO - 'USER': 'cltbld', 17:06:39 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:39 INFO - '_': '/tools/buildbot/bin/python'} 17:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:39 INFO - Downloading/unpacking psutil>=0.7.1 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:06:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:41 INFO - Installing collected packages: psutil 17:06:41 INFO - Running setup.py install for psutil 17:06:41 INFO - building 'psutil._psutil_linux' extension 17:06:41 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 17:06:43 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 17:06:43 INFO - building 'psutil._psutil_posix' extension 17:06:43 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 17:06:43 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 17:06:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:43 INFO - Successfully installed psutil 17:06:43 INFO - Cleaning up... 17:06:43 INFO - Return code: 0 17:06:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:06:43 INFO - Using env: {'DISPLAY': ':0', 17:06:43 INFO - 'HOME': '/home/cltbld', 17:06:43 INFO - 'LANG': 'en_US.UTF-8', 17:06:43 INFO - 'LANGUAGE': 'en_US:en', 17:06:43 INFO - 'LOGNAME': 'cltbld', 17:06:43 INFO - 'MAIL': '/var/mail/cltbld', 17:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:43 INFO - 'MOZ_NO_REMOTE': '1', 17:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:43 INFO - 'NO_EM_RESTART': '1', 17:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:43 INFO - 'PWD': '/builds/slave/test', 17:06:43 INFO - 'SHELL': '/bin/bash', 17:06:43 INFO - 'SHLVL': '1', 17:06:43 INFO - 'TERM': 'linux', 17:06:43 INFO - 'TMOUT': '86400', 17:06:43 INFO - 'USER': 'cltbld', 17:06:43 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:43 INFO - '_': '/tools/buildbot/bin/python'} 17:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:45 INFO - Installing collected packages: mozsystemmonitor 17:06:45 INFO - Running setup.py install for mozsystemmonitor 17:06:45 INFO - Successfully installed mozsystemmonitor 17:06:45 INFO - Cleaning up... 17:06:45 INFO - Return code: 0 17:06:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:06:45 INFO - Using env: {'DISPLAY': ':0', 17:06:45 INFO - 'HOME': '/home/cltbld', 17:06:45 INFO - 'LANG': 'en_US.UTF-8', 17:06:45 INFO - 'LANGUAGE': 'en_US:en', 17:06:45 INFO - 'LOGNAME': 'cltbld', 17:06:45 INFO - 'MAIL': '/var/mail/cltbld', 17:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:45 INFO - 'MOZ_NO_REMOTE': '1', 17:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:45 INFO - 'NO_EM_RESTART': '1', 17:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:45 INFO - 'PWD': '/builds/slave/test', 17:06:45 INFO - 'SHELL': '/bin/bash', 17:06:45 INFO - 'SHLVL': '1', 17:06:45 INFO - 'TERM': 'linux', 17:06:45 INFO - 'TMOUT': '86400', 17:06:45 INFO - 'USER': 'cltbld', 17:06:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:45 INFO - '_': '/tools/buildbot/bin/python'} 17:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:46 INFO - Downloading/unpacking blobuploader==1.2.4 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:48 INFO - Downloading docopt-0.6.1.tar.gz 17:06:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:48 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:48 INFO - Running setup.py install for blobuploader 17:06:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:48 INFO - Running setup.py install for requests 17:06:48 INFO - Running setup.py install for docopt 17:06:48 INFO - Successfully installed blobuploader requests docopt 17:06:48 INFO - Cleaning up... 17:06:49 INFO - Return code: 0 17:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06: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 17:06: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 17:06:49 INFO - Using env: {'DISPLAY': ':0', 17:06:49 INFO - 'HOME': '/home/cltbld', 17:06:49 INFO - 'LANG': 'en_US.UTF-8', 17:06:49 INFO - 'LANGUAGE': 'en_US:en', 17:06:49 INFO - 'LOGNAME': 'cltbld', 17:06:49 INFO - 'MAIL': '/var/mail/cltbld', 17:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:49 INFO - 'MOZ_NO_REMOTE': '1', 17:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:49 INFO - 'NO_EM_RESTART': '1', 17:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:49 INFO - 'PWD': '/builds/slave/test', 17:06:49 INFO - 'SHELL': '/bin/bash', 17:06:49 INFO - 'SHLVL': '1', 17:06:49 INFO - 'TERM': 'linux', 17:06:49 INFO - 'TMOUT': '86400', 17:06:49 INFO - 'USER': 'cltbld', 17:06:49 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:49 INFO - '_': '/tools/buildbot/bin/python'} 17:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:49 INFO - Running setup.py (path:/tmp/pip-aB_HG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:49 INFO - Running setup.py (path:/tmp/pip-NnUqZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:49 INFO - Running setup.py (path:/tmp/pip-3gQLci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:49 INFO - Running setup.py (path:/tmp/pip-ksU6tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:49 INFO - Running setup.py (path:/tmp/pip-g1sfBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:49 INFO - Running setup.py (path:/tmp/pip-DdpsdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:49 INFO - Running setup.py (path:/tmp/pip-e629KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:49 INFO - Running setup.py (path:/tmp/pip-Pt_v6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:49 INFO - Running setup.py (path:/tmp/pip-xIyr_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:49 INFO - Running setup.py (path:/tmp/pip-ocQFID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:49 INFO - Running setup.py (path:/tmp/pip-T6Y8_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:50 INFO - Running setup.py (path:/tmp/pip-pLbEya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:50 INFO - Running setup.py (path:/tmp/pip-P3SDoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:50 INFO - Running setup.py (path:/tmp/pip-shRDta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:50 INFO - Running setup.py (path:/tmp/pip-1J6Tsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:50 INFO - Running setup.py (path:/tmp/pip-RYJRGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:50 INFO - Running setup.py (path:/tmp/pip-me58Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:50 INFO - Running setup.py install for manifestparser 17:06:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:50 INFO - Running setup.py install for mozcrash 17:06:50 INFO - Running setup.py install for mozdebug 17:06:50 INFO - Running setup.py install for mozdevice 17:06:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:50 INFO - Running setup.py install for mozfile 17:06:50 INFO - Running setup.py install for mozhttpd 17:06:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozinfo 17:06:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozInstall 17:06:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozleak 17:06:51 INFO - Running setup.py install for mozlog 17:06:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for moznetwork 17:06:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozprocess 17:06:51 INFO - Running setup.py install for mozprofile 17:06:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozrunner 17:06:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:51 INFO - Running setup.py install for mozscreenshot 17:06:52 INFO - Running setup.py install for moztest 17:06:52 INFO - Running setup.py install for mozversion 17:06:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:52 INFO - Cleaning up... 17:06:52 INFO - Return code: 0 17:06:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06: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 17:06: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 17:06:52 INFO - Using env: {'DISPLAY': ':0', 17:06:52 INFO - 'HOME': '/home/cltbld', 17:06:52 INFO - 'LANG': 'en_US.UTF-8', 17:06:52 INFO - 'LANGUAGE': 'en_US:en', 17:06:52 INFO - 'LOGNAME': 'cltbld', 17:06:52 INFO - 'MAIL': '/var/mail/cltbld', 17:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:52 INFO - 'MOZ_NO_REMOTE': '1', 17:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:52 INFO - 'NO_EM_RESTART': '1', 17:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:52 INFO - 'PWD': '/builds/slave/test', 17:06:52 INFO - 'SHELL': '/bin/bash', 17:06:52 INFO - 'SHLVL': '1', 17:06:52 INFO - 'TERM': 'linux', 17:06:52 INFO - 'TMOUT': '86400', 17:06:52 INFO - 'USER': 'cltbld', 17:06:52 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:52 INFO - '_': '/tools/buildbot/bin/python'} 17:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:52 INFO - Running setup.py (path:/tmp/pip-VpIgra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:52 INFO - Running setup.py (path:/tmp/pip-ZyuBJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:52 INFO - Running setup.py (path:/tmp/pip-uhE6nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:52 INFO - Running setup.py (path:/tmp/pip-wdF4BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:52 INFO - Running setup.py (path:/tmp/pip-XNRiPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:52 INFO - Running setup.py (path:/tmp/pip-xAFhOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:52 INFO - Running setup.py (path:/tmp/pip-VBNRqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:52 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)) 17:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:52 INFO - Running setup.py (path:/tmp/pip-uD9fDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:53 INFO - Running setup.py (path:/tmp/pip-B8c2Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:53 INFO - Running setup.py (path:/tmp/pip-RBIfRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:53 INFO - Running setup.py (path:/tmp/pip-5mezHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:53 INFO - Running setup.py (path:/tmp/pip-aPQJRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:53 INFO - Running setup.py (path:/tmp/pip-Jp48aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:53 INFO - Running setup.py (path:/tmp/pip-RL4ONO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06: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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:53 INFO - Running setup.py (path:/tmp/pip-_di5KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:53 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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:53 INFO - Running setup.py (path:/tmp/pip-ZjjcQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:53 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)) 17:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:53 INFO - Running setup.py (path:/tmp/pip-bfQ7NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:53 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)) 17:06:53 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)) 17:06:53 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)) 17:06:53 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)) 17:06:53 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)) 17:06:53 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)) 17:06:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:55 INFO - Downloading blessings-1.5.1.tar.gz 17:06: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 17:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:55 INFO - Installing collected packages: blessings 17:06:55 INFO - Running setup.py install for blessings 17:06:55 INFO - Successfully installed blessings 17:06:55 INFO - Cleaning up... 17:06:55 INFO - Return code: 0 17:06:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:55 INFO - Reading from file tmpfile_stdout 17:06:55 INFO - Current package versions: 17:06:55 INFO - argparse == 1.2.1 17:06:55 INFO - blessings == 1.5.1 17:06:55 INFO - blobuploader == 1.2.4 17:06:55 INFO - docopt == 0.6.1 17:06:55 INFO - manifestparser == 1.1 17:06:55 INFO - mozInstall == 1.12 17:06:55 INFO - mozcrash == 0.16 17:06:55 INFO - mozdebug == 0.1 17:06:55 INFO - mozdevice == 0.47 17:06:55 INFO - mozfile == 1.2 17:06:55 INFO - mozhttpd == 0.7 17:06:55 INFO - mozinfo == 0.9 17:06:55 INFO - mozleak == 0.1 17:06:55 INFO - mozlog == 3.1 17:06:55 INFO - moznetwork == 0.27 17:06:55 INFO - mozprocess == 0.22 17:06:55 INFO - mozprofile == 0.27 17:06:55 INFO - mozrunner == 6.11 17:06:55 INFO - mozscreenshot == 0.1 17:06:55 INFO - mozsystemmonitor == 0.0 17:06:55 INFO - moztest == 0.7 17:06:55 INFO - mozversion == 1.4 17:06:55 INFO - psutil == 3.1.1 17:06:55 INFO - requests == 1.2.3 17:06:55 INFO - wsgiref == 0.1.2 17:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06:55 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 17:06:55 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 17:06:55 INFO - Using env: {'DISPLAY': ':0', 17:06:55 INFO - 'HOME': '/home/cltbld', 17:06:55 INFO - 'LANG': 'en_US.UTF-8', 17:06:55 INFO - 'LANGUAGE': 'en_US:en', 17:06:55 INFO - 'LOGNAME': 'cltbld', 17:06:55 INFO - 'MAIL': '/var/mail/cltbld', 17:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:55 INFO - 'MOZ_NO_REMOTE': '1', 17:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:55 INFO - 'NO_EM_RESTART': '1', 17:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:55 INFO - 'PWD': '/builds/slave/test', 17:06:55 INFO - 'SHELL': '/bin/bash', 17:06:55 INFO - 'SHLVL': '1', 17:06:55 INFO - 'TERM': 'linux', 17:06:55 INFO - 'TMOUT': '86400', 17:06:55 INFO - 'USER': 'cltbld', 17:06:55 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:55 INFO - '_': '/tools/buildbot/bin/python'} 17:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06: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)) 17:06:56 INFO - Cleaning up... 17:06:56 INFO - Return code: 0 17:06:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06: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 17:06: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 17:06:56 INFO - Using env: {'DISPLAY': ':0', 17:06:56 INFO - 'HOME': '/home/cltbld', 17:06:56 INFO - 'LANG': 'en_US.UTF-8', 17:06:56 INFO - 'LANGUAGE': 'en_US:en', 17:06:56 INFO - 'LOGNAME': 'cltbld', 17:06:56 INFO - 'MAIL': '/var/mail/cltbld', 17:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:56 INFO - 'MOZ_NO_REMOTE': '1', 17:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:56 INFO - 'NO_EM_RESTART': '1', 17:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:56 INFO - 'PWD': '/builds/slave/test', 17:06:56 INFO - 'SHELL': '/bin/bash', 17:06:56 INFO - 'SHLVL': '1', 17:06:56 INFO - 'TERM': 'linux', 17:06:56 INFO - 'TMOUT': '86400', 17:06:56 INFO - 'USER': 'cltbld', 17:06:56 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:56 INFO - '_': '/tools/buildbot/bin/python'} 17:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:56 INFO - Downloading/unpacking jsonschema 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06: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 17:06:58 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06: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 17:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:58 INFO - warning: no files found matching '*.txt' 17:06:58 INFO - no previously-included directories found matching 'build' 17:06:58 INFO - no previously-included directories found matching 'dist' 17:06:58 INFO - no previously-included directories found matching '.git*' 17:06:58 INFO - Installing collected packages: jsonschema, functools32 17:06:58 INFO - Running setup.py install for functools32 17:06:58 INFO - warning: no files found matching '*.txt' 17:06:58 INFO - no previously-included directories found matching 'build' 17:06:58 INFO - no previously-included directories found matching 'dist' 17:06:58 INFO - no previously-included directories found matching '.git*' 17:06:58 INFO - Successfully installed jsonschema functools32 17:06:58 INFO - Cleaning up... 17:06:58 INFO - Return code: 0 17:06:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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 0x7f390cffcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', '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 17:06: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 17:06: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 17:06:58 INFO - Using env: {'DISPLAY': ':0', 17:06:58 INFO - 'HOME': '/home/cltbld', 17:06:58 INFO - 'LANG': 'en_US.UTF-8', 17:06:58 INFO - 'LANGUAGE': 'en_US:en', 17:06:58 INFO - 'LOGNAME': 'cltbld', 17:06:58 INFO - 'MAIL': '/var/mail/cltbld', 17:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:58 INFO - 'MOZ_NO_REMOTE': '1', 17:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:58 INFO - 'NO_EM_RESTART': '1', 17:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:58 INFO - 'PWD': '/builds/slave/test', 17:06:58 INFO - 'SHELL': '/bin/bash', 17:06:58 INFO - 'SHLVL': '1', 17:06:58 INFO - 'TERM': 'linux', 17:06:58 INFO - 'TMOUT': '86400', 17:06:58 INFO - 'USER': 'cltbld', 17:06:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:58 INFO - '_': '/tools/buildbot/bin/python'} 17:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:58 INFO - Downloading/unpacking flake8 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:07:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07: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 17:07:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07: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 17:07:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:00 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 17:07:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:01 INFO - no previously-included directories found matching 'docs/_build' 17:07:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:01 INFO - Running setup.py install for pep8 17:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:01 INFO - no previously-included directories found matching 'docs/_build' 17:07:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:07:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:01 INFO - Cleaning up... 17:07:01 INFO - Return code: 0 17:07:01 INFO - Running post-action listener: _resource_record_post_action 17:07:01 INFO - Running post-action listener: _start_resource_monitoring 17:07:01 INFO - Starting resource monitoring. 17:07:01 INFO - ##### 17:07:01 INFO - ##### Running install step. 17:07:01 INFO - ##### 17:07:01 INFO - Running pre-action listener: _resource_record_pre_action 17:07:01 INFO - Running main action method: install 17:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:01 INFO - Reading from file tmpfile_stdout 17:07:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:01 INFO - Reading from file tmpfile_stdout 17:07:01 INFO - Output received: 17:07:01 INFO - Usage: mozinstall [options] installer 17:07:01 INFO - Options: 17:07:01 INFO - -h, --help show this help message and exit 17:07:01 INFO - -d DEST, --destination=DEST 17:07:01 INFO - Directory to install application into. [default: 17:07:01 INFO - "/builds/slave/test"] 17:07:01 INFO - --app=APP Application being installed. [default: firefox] 17:07:01 INFO - mkdir: /builds/slave/test/build/application 17:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:07:17 INFO - Reading from file tmpfile_stdout 17:07:17 INFO - Output received: 17:07:17 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:17 INFO - Running post-action listener: _resource_record_post_action 17:07:17 INFO - ##### 17:07:17 INFO - ##### Running run-tests step. 17:07:17 INFO - ##### 17:07:17 INFO - Running pre-action listener: _resource_record_pre_action 17:07:17 INFO - Running main action method: run_tests 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:17 INFO - Python 2.7.3 17:07:17 INFO - Return code: 0 17:07:17 INFO - grabbing minidump binary from tooltool 17:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:17 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 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:17 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 17:07:17 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 17:07:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:17 INFO - Return code: 0 17:07:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:18 INFO - Return code: 0 17:07:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 17:07:18 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 17:07:18 INFO - Using env: {'DISPLAY': ':0', 17:07:18 INFO - 'HOME': '/home/cltbld', 17:07:18 INFO - 'LANG': 'en_US.UTF-8', 17:07:18 INFO - 'LANGUAGE': 'en_US:en', 17:07:18 INFO - 'LOGNAME': 'cltbld', 17:07:18 INFO - 'MAIL': '/var/mail/cltbld', 17:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:18 INFO - 'MOZ_NO_REMOTE': '1', 17:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:18 INFO - 'NO_EM_RESTART': '1', 17:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:18 INFO - 'PWD': '/builds/slave/test', 17:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:18 INFO - 'SHELL': '/bin/bash', 17:07:18 INFO - 'SHLVL': '1', 17:07:18 INFO - 'TERM': 'linux', 17:07:18 INFO - 'TMOUT': '86400', 17:07:18 INFO - 'USER': 'cltbld', 17:07:18 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426', 17:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:18 INFO - '_': '/tools/buildbot/bin/python'} 17:07:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 17:07:18 INFO - mozversion INFO | application_buildid: 20151217160558 17:07:18 INFO - mozversion INFO | application_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 17:07:18 INFO - mozversion INFO | application_display_name: Nightly 17:07:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:18 INFO - mozversion INFO | application_name: Firefox 17:07:18 INFO - mozversion INFO | application_remotingname: firefox 17:07:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:07:18 INFO - mozversion INFO | application_vendor: Mozilla 17:07:18 INFO - mozversion INFO | application_version: 46.0a1 17:07:18 INFO - mozversion INFO | platform_buildid: 20151217160558 17:07:18 INFO - mozversion INFO | platform_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 17:07:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:07:18 INFO - mozversion INFO | platform_version: 46.0a1 17:07:18 INFO - 2015-12-17 17:07:18,586 DEBUG : using testdate: 1450400838 17:07:18 INFO - 2015-12-17 17:07:18,586 DEBUG : actual date: 1450400838 17:07:18 INFO - 2015-12-17 17:07:18,594 INFO : starting webserver on 'localhost:42770' 17:07:18 INFO - 2015-12-17 17:07:18,595 INFO : Starting test suite talos-linux64-ix-015.e 17:07:18 INFO - 2015-12-17 17:07:18,595 INFO : Starting test dromaeo_css 17:07:18 INFO - 2015-12-17 17:07:18,595 DEBUG : operating with platform_type : linux_ 17:07:18 INFO - 2015-12-17 17:07:18,595 INFO : Initialising browser for dromaeo_css test... 17:07:18 INFO - 2015-12-17 17:07:18,609 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5t0ny/profile http://localhost:42770/getInfo.html 17:07:24 INFO - 2015-12-17 17:07:24,604 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:24 INFO - 2015-12-17 17:07:24,605 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:24 INFO - 2015-12-17 17:07:24,605 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:07:24 INFO - 2015-12-17 17:07:24,605 DEBUG : BROWSER_OUTPUT: __metrics 17:07:24 INFO - 2015-12-17 17:07:24,746 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:07:25 INFO - 2015-12-17 17:07:25,704 INFO : Browser initialized. 17:07:25 INFO - 2015-12-17 17:07:25,705 INFO : Running cycle 1/1 for dromaeo_css test... 17:07:25 INFO - 2015-12-17 17:07:25,705 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC5t0ny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:37 INFO - 2015-12-17 17:07:37,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 151351296 17:07:37 INFO - 2015-12-17 17:07:37,695 DEBUG : BROWSER_OUTPUT: 17:08:27 INFO - 2015-12-17 17:08:27,313 DEBUG : BROWSER_OUTPUT: 1450400907309 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] 17:10:39 INFO - 2015-12-17 17:10:39,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42770/tests/dromaeo/cssquery-ext.html) 17:10:40 INFO - 2015-12-17 17:10:40,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 154271744 17:10:40 INFO - 2015-12-17 17:10:40,500 DEBUG : BROWSER_OUTPUT: 17:13:42 INFO - 2015-12-17 17:13:42,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-ext.html (next: http://localhost:42770/tests/dromaeo/cssquery-jquery.html) 17:13:43 INFO - 2015-12-17 17:13:43,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 152764416 17:13:43 INFO - 2015-12-17 17:13:43,084 DEBUG : BROWSER_OUTPUT: 17:16:44 INFO - 2015-12-17 17:16:44,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42770/tests/dromaeo/cssquery-mootools.html) 17:16:45 INFO - 2015-12-17 17:16:45,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 153022464 17:16:45 INFO - 2015-12-17 17:16:45,518 DEBUG : BROWSER_OUTPUT: 17:19:47 INFO - 2015-12-17 17:19:47,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42770/tests/dromaeo/cssquery-prototype.html) 17:19:47 INFO - 2015-12-17 17:19:47,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 152678400 17:19:47 INFO - 2015-12-17 17:19:47,948 DEBUG : BROWSER_OUTPUT: 17:22:50 INFO - 2015-12-17 17:22:50,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42770/tests/dromaeo/cssquery-yui.html) 17:22:51 INFO - 2015-12-17 17:22:51,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 153358336 17:22:51 INFO - 2015-12-17 17:22:51,049 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-yui.html (next: http://localhost:42770/tests/dromaeo/cssquery-dojo.html) 17:25:53 INFO - 2015-12-17 17:25:53,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 155136000 17:25:53 INFO - 2015-12-17 17:25:53,694 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,694 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:25:53 INFO - 2015-12-17 17:25:53,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:25:53 INFO - 2015-12-17 17:25:53,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:25:53 INFO - 2015-12-17 17:25:53,694 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:25:53 INFO - 2015-12-17 17:25:53,698 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2664.893404263829;2671.599260110982;2714.8914043438263;2728.9590656140163;2736.9863150684246;4524.163029839482;4690.8123675053;4691.319758635;4720.244760838266;4749.216379297412;4639.164950308943;4680.882977925554;4681.040386720722;4710.057988402316;4794.3767310249705;4377.474703035632;4445.755483448409;4509.098180363941;4523.36672865799;4541.954580454203;4411.250087485119;4439.911201775979;4467.5755803198645;4534.795934182953;4546.136234115524;4250.851220207278;4310.396544483775;4350.477942646902;4405.118976204772;4422.248217802981;4391.890202744925;4436.0906014267;4438.378626992224;4463.352813842007;4494.955050449519;4399.692021558492;4409.11817636474;4422.358757980107;4450.599446049871;4468.664850136252;4540.409746732937;4587.908241835178;4619.260918253063;4704.506026867164;4758.928616070762;5099.872503187413;5108.361454818148;5116.897662046776;5144.3312369392115;5171.198464238049;4790;5074.985002999415;5121.078205922932;5145.51117643827;5163.199704045879;4666.2067448533835;4723.858284251443;4804.111239420718;4810.7835147418455;4841.927371089437;5212.139996900545;5250.684958902478;5252.159654455345;5264.5525130363585;5302.469753024744;4776.737279449663;4809.78355973982;5026.07017701719;5033.615755667148;5050.191969284971;5023.045621331935;5050.722210278396;5073.695578265316;5149.330587023738;5165.328507294028;5103.157978933508;5109.054824857339;5111.05445492585;5124.92312615311;5154.278401023859;4737.28940658904;4851.636127290467;5059.089363914531;5068.41713202979;5081.212412076134;4189.664826813848;4254.659627229876;4259.2759230930815;4296;4318.611324980704;3672.926541469156;3673.7428380013143;3688.170161713593;3704;3723.497327860758;4182.937255941163;4290.120525292307;4308.827646894152;4325.7837108145095;4334.783260836945;5114.667546609458;5119.667221630582;5120.1039818031695;5121.28302037715;5139.6145289102715;4382.802773875183;4385.451818522684;4391.560843915583;4394.604485596312;4434;4292.806823692941;4380.561943805594;4413.13943780966;4520.141173177086;4531.478879928784;4824.734639594786;4836.903261934671;4845.200541910615;4856.927146092741;4874.390701162355;5068.873278168076;5073.808098942719;5110.1568241239775;5113.693178409308;5163.4578369270685;4537.705049171794;4687.10944920464;4773.546513081252;4850.708957462563;4854.80580776765;4977.900441991067;5011.298418221525;5020.899582008266;5058.974705126451;5089.440161582297;4872.4153101628035;5130.923036154386;5138.511841375063;5140.537351638371;5147.716875571879;4835.927461088017;4854.95145048545;4861.343718597944;4916.360873086476;5025.120603894377;4931.13705101613;4947.332110165082;4950.900981980269;4953.281774142802;5019.422766381766;4814.253790662453;4850.83022094225;4856.805727770849;4883.536064073907;4895.388076490439;4701.200795864643;4775.785089670903;4852.466228714768;4974.054929563371;4990.126727822689;4842.959974096462;4854.781534831011;4858.3441235434175;4892.217245240744;4895.828645997373 17:25:53 INFO - 2015-12-17 17:25:53,699 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.9010178167931;560.5403569073361;561.2058936604703;561.2142999800277;568.8293511946416;34238.144046398855;35318.29363412737;35366.2926741465;35462.290754184934;35684;39266.60733392665;39779.20441591166;39840.80079599605;39850.60149398505;40032;7765.1458339582605;8071.475354101994;8076.030876294823;8077;8078.71724489643;7885.250901164381;7992.200779922019;8008.119106898236;8012.238837310446;8020.719274825382;7816.218378162195;7853.489523180975;7885.684572617117;7894.092179399385;7917.7624671259955;7749.535027898316;7757.961210193941;7771.689132434696;7807.6876924922935;7830.334421574173;7822.491538050065;7939.285464308182;7973.920260797434;7982.720604778805;8003.079645840687;35794.28411431783;36354.45468317977;36403;36442.27115457676;36488.270234595424;2761.9447611047667;2814.2823579987175;2877.7985541012135;2911.5195992661183;3273.4435146025235;27781.305467363276;28000.439991200063;28152;28318;28566.143015709353;3361.494349638997;3458.1008937676133;3504.1590018395655;3517.296540691846;3538.539989801335;208545;209396;209916;211595.94202029044;211808;49762.25356619654;51648.741756290976;53104.73447632737;53109.734451328266;54281.72859135679;47854.5214547857;48077;48260.27609585859;48348.75825620849;48358;13577.52478663242;13655.180689158682;13721.804511278147;13804.792928106086;13911.513097041556;10451.425171615634;10567;10569.841452378221;10584.735381615366;10596.364218146782;18424.907875460805;18578;18592.628147436975;18638.720419193724;18701.25194992185;7497.325240728361;7579.734709285259;7627.961860190663;7681.078270607562;7703.845923081507;914.1589737441569;942.1473566422399;982.4694664881027;987.5605355616682;1087.505185140759;25794.355141121247;26406.339841503734;26556.203313900613;26897.596536051973;26947.326316841845;924.9861252081224;936.4849332867033;961.6778379242892;979.1872745621117;1043.6295115234134;12217.450214740358;12242.326672032945;12359.876401235873;12534.122611417113;12714.87285127137;260773;263284;264854;265488;265921;44849.77575112104;44905.326420103724;44965;45007.77496112498;45011.54988450074;1184.2295767826981;1200.6458094862037;1206.3304865799566;1228.7235372041398;1233.7902556565584;23783.643245350988;25527.234182974542;26165.345866353495;26510.867445663418;27262.454750905268;39473;39871.60128398679;39879;39885.401718973655;39999.60000400075;208187;209125;209725;209838;210168;27681.723182767913;27892;28745.712542874302;28911.855440722662;29012.854935725187;35551.82224088863;36231.818840905624;36331.27337453183;36411.81794091013;36443.63556364403;30946.226344341572;31621;31707.20731981719;31743;32163.51754723634;31458.213544661565;31923.68076319207;33531.4970275451;33906.83046584751;34000.65999340074;29703;29734.25664358408;29967.100986970425;30044;30046.399072018874;25775.87112064428;27040.72959270382;27669.30826729348;29043.7095629041;29080;23102.884485577466;23339.29982100472;30243.546346804374;32720.672793272715;32955.17612059718 17:25:53 INFO - 2015-12-17 17:25:53,702 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.1691927126193;326.4483023689964;326.6406952352412;328.85037308024835;341.0280700004985;12192.20750651207;12540.122191446602;15037.774433383507;15429.537113886587;15473.071615703051;14258.144511329301;14401.351939162736;14961;15482.61293467664;15557.06657600542;4810.903781924369;4846.1034708578845;4972.801087956477;4983.551480366767;4996.050750357439;4844.15227335215;4954.331165292693;5003.949960500403;5012.323336349583;5030.320906677606;4874.805007799701;4965.503449655042;4968.701877887338;4985.900281994358;5220.060389129955;5277.3139491866;5290.92063619046;5295.205719142121;5297.629165958385;5306.893862122736;4714.834980775657;5037.11850426174;5063.620228482879;5065.1895696688725;5073.644844860824;11117.666470005832;11141.164412669083;11274.830877536844;11282.153838462149;11293.943530282379;1763.0831967376891;1777.2446710148265;1788.0880750817048;1814.7550080739063;1877.0520886952002;8537.701180458716;8670.263027642657;8821.867671984925;8911.955440222757;12229.143959922809;1696.4401747423444;1739.391213075426;1780.4035648057916;1797.766290382242;1813.7732783402075;52759;56132.158017629765;56356;56953.145702814494;57200.999999999585;9734.9026509734;9748.366356186825;9820.4107753535;9873.950630246803;9883.258755593359;12312.384380780924;12379.504819807287;12384.75230495385;12386.56647017368;12391.380430978415;7022.403095736818;7062.717491300393;7097.609631470215;7124.92875071253;7155.856882862314;6732.528722989344;6806.183258008971;6813.897791533131;6835.487338449636;6871.244163142051;3998.520177578709;4117.485314335708;4156.147989662172;4163.97918010408;4170.186813571325;1754.649070185968;1797.957184832794;1809.746635471035;1822.3257394764023;1842.023727424467;759.7302957450136;846.6909578003985;849.8682704180862;949.2216382566229;956.3066776587058;15158.393664253526;15253.923730381277;15276;15779.368825246862;15831.762523561925;855.4396870050127;863.4775960543906;867.3018220332693;868.561376504861;896.6458248991612;8727.258183054384;8782.385233033627;8884.333674974274;8900.643974241088;9084.137006984325;433454;435753.21233938175;439101;452176;459902;75927;76460;77435;77731.61134194293;77854;1019.1948360795037;1041.1774697988656;1046.8953104689622;1056.228952864398;1080.8919108089285;14210.715785684022;14254.28728563547;14282.785758213427;14322.57032289033;14330.140191588538;33801.661983379854;33997.15007124743;34004.48993265053;34666.306673866886;35511;45788;46098.53901461077;46335.3049704248;48491.27263091127;48556.75721621369;8203.917960820316;8459.815625812515;8878.51168185756;8894.86657700148;8927.553622318728;11726.413679315829;11990.580329688419;15122.319495622503;15249.237538122827;15565.377384904477;12902.225866448043;13635.86364136346;13805.51680691171;13910.443582256596;13936.860631393962;13288.335583220995;13413.798793017917;13421.530246441718;13812;13876.791848122488;12594.811077833656;12598.622041338775;12869.485220591072;13638.181709097486;14172.503962361268;8544.615492302986;8606.44058136219;8765.824683506167;8886.511241881759;8896.866547001671;9289.62841486333;11227.943860280646;13797.931010345286;13842.861571384157;13973.021888467709 17:25:53 INFO - 2015-12-17 17:25:53,703 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1489.8212214534258;1668.5244705259;1725.998920626037;1729.6281299520608;1744.0233469257216;6871.450283977282;7180.28197180283;7368.189499155089;7430.368418684411;7445.255474452552;7198.604076775775;7215;7291.671874765635;7302.087239095114;7310.415166786657;2036.256766280308;2078.6570215914358;2086.3428020173674;2087.279888438486;2087.7912208779153;2065.7727649958492;2083.0418007716394;2084.1038353507984;2092.9581408371823;2101.0335245786955;1703.2675949341779;1725.2581390002356;2012.6779715245564;2063.525389160494;2087.488565301503;2034.8270397016272;2039.276056999766;2046.048587406863;2048.3445297504804;2050.897455127245;2066.772655007948;2076.2110398048794;2096.2139197800825;2121.4802373418456;2122.36329101269;6975.895361569581;6999.650017499155;7013.193482749498;7015.82460438488;7016.842221033523;4051.97974010131;4109.794510274474;4112.732672376286;4125.731827431207;4146.212219678282;2669.599560065986;2679.973200267992;2709.078913169512;2735.8084934054623;2740.2464322311325;835.5321020228631;851.3104385447807;867.7917299848054;881.823635272948;891.3003292415488;9732.90267097327;9744.805103897954;9778;9820.459874706889;9824.066713662261;3637.2361804021452;3708.3325001499447;3736.23407201523;3805.486259355007;3809.733318667722;7519.511231769918;7580.886286705704;7604.771856844303;7618.276263754934;7620.847583048308;4178.12259425518;4190.706650534434;4200.474940632421;4202.621764041251;4211.031462763582;3819.255245227154;3823.713221508398;3835.9232815343535;3839.7504162229366;3845.4616353710503;2983.508023190732;3046.832424216645;3052.9084127476212;3074.216074900886;3100.4419204543397;931.701855406277;942.7454587261401;947.5262368815593;953.3374304858196;956.5217391304348;836.3392919593452;849.3757088539918;873.7684513603773;879.5778026547293;1176.8293597428496;6367.363263673596;6537.5096867734155;6544.8363790905605;6556.704948277339;6559.803205903735;550.6998685716294;557.7518004488045;559.5439716630933;565.660603637814;716.1942814333875;4634.467036290802;4689.484156742756;4694.201985662446;4696.741679207608;4697.906041879211;8546.871796923051;8689.391742578086;8894.822103557892;8938.374313798102;8957.686480973265;8700.173483519056;8756.080611535825;8757.343199260082;8794.34042446819;8860.778480537909;6707.262201157869;6832.658367081626;6847.623380714009;6904.13698287714;6934.06390137325;6471.805845824632;6499.285078641251;6516.283208846929;6533.803985880431;6537.803865884031;7583.393328533593;7700.191479894755;7729.806754831175;7805.609719514116;7839.686412543662;7876.291133797986;7900.446968712365;7950.960245198737;7958.801029974297;7965.761027169194;5740.913886291625;5751.511121554715;5787.160861674949;5792;5820.505257053198;7026.262242464468;7048.823779405556;7125.216226215216;7127.180374256819;7138.821529461805;6638.800835974928;6711.731530738911;6713.1944166700305;6787.932120678927;6826.112605361272;5805.332386775406;5820.447057529528;6474.449671777952;6493.22081350241;6543.70553325111;6113.908291375544;6121.47967422774;6220.844478888064;6471.838204044937;6473;6002.559385747477;6038.849028774316;6041.395860413923;6042.848928776816;6044.516438684806;6128.4790792783115;6139.079138129317;6160.691965401622;6171.56799024064;6178.1659475971965 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.5143769968051;304.8643353707601;307.7722485360832;310.9455845227085;313.42330112592833;5569.081101618233;5589.385167631557;5628.887422251558;5723.828285151452;5742.598018138732;5545.611807173499;5584.888302233963;5622.4939755422;5624.268845050148;5630.943690563093;4132.070284186064;4233.555476674951;4323.654107671378;4329.913401731964;4331.6534677225745;4226.72526285792;4244.108737165199;4245.575442455761;4262.65898728101;4273.529911709725;4162.146759914211;4185.686073544481;4196.874093777176;4198.790060496963;4206.831726730942;4195.517515485728;4203.516595591515;4205.894852628679;4207.137536804948;4226;3633.582138054131;3648.4709717091137;3649.2154186849953;3650.178709790276;3657.030886814996;5220.843374698765;5373.167159090347;5379.67721936685;5385.272988146589;5401.918971215435;4847.491013443609;4864.100141473838;4868.221084626478;4870.342503761982;4874.683145595525;5842.97747894121;5848.532117430638;5854.063349864044;5856.882862342729;5865.736041878125;3994.001499625094;3995.3407687731487;3998.140399814025;4002.71912987844;4011.5988401159652;5942.821715348547;6120.785772497986;6160;6185.381461853779;6186.381361863778;4013.6387725104883;4013.799310034545;4016.3373043447505;4022.054817117975;4033;4070.4097905804083;4071.063655359284;4073;4082.5509193988637;4084.6323830855367;4780.067886762048;4782.856514304576;4787.808487660454;4794.95205047952;4796.25658023007;5728.312602487728;5833.737481813244;5845.386234445322;5857.736401861926;5884.499817515559;1452.7602945514084;1480.8519148085106;1492.9850701493062;1493.5519344196698;1494.140869000329;980.9901900981041;1006.2955930848435;1008.1468901523629;1012.9240306977006;1013.3058854684565;5084.796608135707;5091.5672167865405;5095.974520127375;5096.541311282002;5125.846224613193;5987.491063259585;6080.695965201722;6122.204113465221;6153.353897840751;6175.814725558241;5104.974475127675;5106.693598384109;5119.334486516729;5130.281760553526;5132.9743351283005;3275.394052100369;3285.4743241081314;3303.7357011439026;3303.785253958485;3313.7349012078976;5600.943990560124;5695.373508914016;5733.799317023884;5743.511801496919;5768.769249229984;6336.112944187817;6343.841403964938;6350.460210882126;6351.745930162741;6359.268684101295;5716.828495145152;5771.9711401443565;5784.942150578525;5791.391903850119;5796.246487956539;6111.908321375272;6134.969325153345;6136.8772624548155;6151.96924015377;6160.13758073861;5851.356350801493;5972.462478376967;6000.459958603747;6002.129691194665;6016.308124565556;5734.139879018181;5744.0522313817755;5754.7122643866805;5761.135829625589;5790.4209579043445;4137.565555616738;4149.730267532601;4179.2059508693255;4180.059486615487;4181.121964387513;6035.637861728311;6098.29869564988;6141.740943106742;6150.477209437248;6155.169052177898;5888.411158884077;5891.086881533369;5892.9116063258225;5894.734736936934;5897.970510147422;5868.794592189253;5887.882242355215;5889.322727886348;5893.734781934909;5895.528357731286;5618.85952851182;5741.13882917549;5768.278965129359;5769.336526299529;5789.8552536186935;5923.200367950271;5939.406059394026;5942.168096466585;5945.346011938596;5973.462388385066;5781.392953739797;5801;5808.332041815245;5811.970940145272;5821.650700957956 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.7921623512945;700.2577268095819;708.1537562612676;721.1310371002945;729.081357489563;11238.719032024193;11287.661370158889;11428.485718142683;11440.542378304868;11465.369404682739;10079.798404031915;11089.611863584776;11205.103591712665;11205.159613029035;11245.381504017276;783.6551917156462;784.3411534311192;804.8511025460308;808.2846680687575;808.9029316482001;790.5612385126252;790.7232468635989;794.0471434278888;796.5181065455374;796.9362451003934;828.4242451496212;833.770713053912;836;837.2004735477605;838.2455789789177;819.4960099538771;824.0729179672868;824.3487644760631;825.938054645898;826.2604968553171;612.6018088242678;614.8678034222619;617.102116420607;617.4257940115691;618.6350053468475;11598.130140239431;11687.649370518899;11711.1802173847;11775.528978840835;11797.705057373549;10556.524956376981;10597.364158150536;10816.567337306498;10923.180761442924;11065.391403472806;8742.694005709833;8804.251638610662;8873.73378798637;9184.724458266262;9291.349605527615;3064.6169228846393;3146.5752123463267;3149.5433162191352;3177.158053115926;3236.2880166363598;39663.99999999971;39720;40351.192976140315;40362.59637403618;40363.596364036275;8032.919670803217;8141.755747327589;8147.144549822302;8278;8375.8324833503;15484;15559.688806223812;15560.45538406173;15572.688546229012;15574.610634734223;6238.376162383725;6337.081123237105;6395.20059992501;6496.935030649633;6514.837129071716;3304.454764963802;3400.9149771255916;3420.1449637590604;3444.6727560881677;3479.9478007829903;2567.281161274846;2596.7403259673883;2603.4142317978303;2610.2299821552688;2615.64688767014;451.8847693838116;454.2640921706856;458.98106204226565;459.12078369921227;463.1755475254053;408.320146955322;417.97492150471066;433.9761313127808;457.69334545854355;467.09150701885187;6435.22777266731;6687.297833727486;6862.759803406857;6872.965635171792;6915.861682766316;484.6510512431044;507.72329080651133;545.413680293678;569.1462805791313;594.6164723753155;3157.589513363294;3176.491761318178;3354.3626710924846;3521.1725244567506;3634.727395445352;46993.295100573516;47300.29049564259;47685.76157119262;47843;49744.25383619249;43200.13599727988;43251.78374108109;43436;43523.56476435195;43594.56405435968;39503.60496394999;39939.20121597552;40837;41324.793376032925;41612.58387416148;7210.351068403659;7218.3503484686635;7227.8554428912175;7373.29953654402;7501.774946751606;31630.36739265156;31838;31868;32326;32587;35504.82247588746;35923;38387.232255355295;40729;41016;9309.348345616012;9432.339736218399;9479.620815167593;9495.335326527076;9711.9028809711;10631.468426578795;10663.733406664585;10695.94652026735;10800.837987430352;10859.2398532102;9709.757256068655;9716.611335546499;9720.125188733047;10029.749256268651;10130.08829205375;10025.548850301608;10055.597776088875;10087.596496140071;10134.189264858645;10332.948335258276;9456.479893605918;9496.19282361007;9565.760855978378;10107.3430227035;10141.49292535385;8185.4270201085355;8239.232537223847;8558.57207139653;8691.608877600649;8704.434211776213;8329.916700833157;8567.957160214159;8635.568221589021;8635.784105397415;8966.865497017681 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 17:25:53 INFO - 2015-12-17 17:25:53,706 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: __startTimestamp1450401953692__endTimestamp 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4687.30 Median:4810.78 stddev:491.73 (10.2%) stddev-sans-first:466.94 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: Values: 2664.9 2671.6 2714.9 2729.0 2737.0 4524.2 4690.8 4691.3 4720.2 4749.2 4639.2 4680.9 4681.0 4710.1 4794.4 4377.5 4445.8 4509.1 4523.4 4542.0 4411.3 4439.9 4467.6 4534.8 4546.1 4250.9 4310.4 4350.5 4405.1 4422.2 4391.9 4436.1 4438.4 4463.4 4495.0 4399.7 4409.1 4422.4 4450.6 4468.7 4540.4 4587.9 4619.3 4704.5 4758.9 5099.9 5108.4 5116.9 5144.3 5171.2 4790.0 5075.0 5121.1 5145.5 5163.2 4666.2 4723.9 4804.1 4810.8 4841.9 5212.1 5250.7 5252.2 5264.6 5302.5 4776.7 4809.8 5026.1 5033.6 5050.2 5023.0 5050.7 5073.7 5149.3 5165.3 5103.2 5109.1 5111.1 5124.9 5154.3 4737.3 4851.6 5059.1 5068.4 5081.2 4189.7 4254.7 4259.3 4296.0 4318.6 3672.9 3673.7 3688.2 3704.0 3723.5 4182.9 4290.1 4308.8 4325.8 4334.8 5114.7 5119.7 5120.1 5121.3 5139.6 4382.8 4385.5 4391.6 4394.6 4434.0 4292.8 4380.6 4413.1 4520.1 4531.5 4824.7 4836.9 4845.2 4856.9 4874.4 5068.9 5073.8 5110.2 5113.7 5163.5 4537.7 4687.1 4773.5 4850.7 4854.8 4977.9 5011.3 5020.9 5059.0 5089.4 4872.4 5130.9 5138.5 5140.5 5147.7 4835.9 4855.0 4861.3 4916.4 5025.1 4931.1 4947.3 4950.9 4953.3 5019.4 4814.3 4850.8 4856.8 4883.5 4895.4 4701.2 4775.8 4852.5 4974.1 4990.1 4843.0 4854.8 4858.3 4892.2 4895.8 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38578.39 Median:18634.16 stddev:59582.18 (319.7%) stddev-sans-first:59680.91 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: Values: 549.9 560.5 561.2 561.2 568.8 34238.1 35318.3 35366.3 35462.3 35684.0 39266.6 39779.2 39840.8 39850.6 40032.0 7765.1 8071.5 8076.0 8077.0 8078.7 7885.3 7992.2 8008.1 8012.2 8020.7 7816.2 7853.5 7885.7 7894.1 7917.8 7749.5 7758.0 7771.7 7807.7 7830.3 7822.5 7939.3 7973.9 7982.7 8003.1 35794.3 36354.5 36403.0 36442.3 36488.3 2761.9 2814.3 2877.8 2911.5 3273.4 27781.3 28000.4 28152.0 28318.0 28566.1 3361.5 3458.1 3504.2 3517.3 3538.5 208545.0 209396.0 209916.0 211595.9 211808.0 49762.3 51648.7 53104.7 53109.7 54281.7 47854.5 48077.0 48260.3 48348.8 48358.0 13577.5 13655.2 13721.8 13804.8 13911.5 10451.4 10567.0 10569.8 10584.7 10596.4 18424.9 18578.0 18592.6 18638.7 18701.3 7497.3 7579.7 7628.0 7681.1 7703.8 914.2 942.1 982.5 987.6 1087.5 25794.4 26406.3 26556.2 26897.6 26947.3 925.0 936.5 961.7 979.2 1043.6 12217.5 12242.3 12359.9 12534.1 12714.9 260773.0 263284.0 264854.0 265488.0 265921.0 44849.8 44905.3 44965.0 45007.8 45011.5 1184.2 1200.6 1206.3 1228.7 1233.8 23783.6 25527.2 26165.3 26510.9 27262.5 39473.0 39871.6 39879.0 39885.4 39999.6 208187.0 209125.0 209725.0 209838.0 210168.0 27681.7 27892.0 28745.7 28911.9 29012.9 35551.8 36231.8 36331.3 36411.8 36443.6 30946.2 31621.0 31707.2 31743.0 32163.5 31458.2 31923.7 33531.5 33906.8 34000.7 29703.0 29734.3 29967.1 30044.0 30046.4 25775.9 27040.7 27669.3 29043.7 29080.0 23102.9 23339.3 30243.5 32720.7 32955.2 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25134.90 Median:434603.61 stddev:72802.82 (16.8%) stddev-sans-first:72983.21 17:25:53 INFO - 2015-12-17 17:25:53,707 DEBUG : BROWSER_OUTPUT: Values: 325.2 326.4 326.6 328.9 341.0 12192.2 12540.1 15037.8 15429.5 15473.1 14258.1 14401.4 14961.0 15482.6 15557.1 4810.9 4846.1 4972.8 4983.6 4996.1 4844.2 4954.3 5003.9 5012.3 5030.3 4874.8 4965.5 4968.7 4985.9 5220.1 5277.3 5290.9 5295.2 5297.6 5306.9 4714.8 5037.1 5063.6 5065.2 5073.6 11117.7 11141.2 11274.8 11282.2 11293.9 1763.1 1777.2 1788.1 1814.8 1877.1 8537.7 8670.3 8821.9 8912.0 12229.1 1696.4 1739.4 1780.4 1797.8 1813.8 52759.0 56132.2 56356.0 56953.1 57201.0 9734.9 9748.4 9820.4 9874.0 9883.3 12312.4 12379.5 12384.8 12386.6 12391.4 7022.4 7062.7 7097.6 7124.9 7155.9 6732.5 6806.2 6813.9 6835.5 6871.2 3998.5 4117.5 4156.1 4164.0 4170.2 1754.6 1798.0 1809.7 1822.3 1842.0 759.7 846.7 849.9 949.2 956.3 15158.4 15253.9 15276.0 15779.4 15831.8 855.4 863.5 867.3 868.6 896.6 8727.3 8782.4 8884.3 8900.6 9084.1 433454.0 435753.2 439101.0 452176.0 459902.0 75927.0 76460.0 77435.0 77731.6 77854.0 1019.2 1041.2 1046.9 1056.2 1080.9 14210.7 14254.3 14282.8 14322.6 14330.1 33801.7 33997.2 34004.5 34666.3 35511.0 45788.0 46098.5 46335.3 48491.3 48556.8 8203.9 8459.8 8878.5 8894.9 8927.6 11726.4 11990.6 15122.3 15249.2 15565.4 12902.2 13635.9 13805.5 13910.4 13936.9 13288.3 13413.8 13421.5 13812.0 13876.8 12594.8 12598.6 12869.5 13638.2 14172.5 8544.6 8606.4 8765.8 8886.5 8896.9 9289.6 11227.9 13797.9 13842.9 13973.0 17:25:53 INFO - 2015-12-17 17:25:53,708 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4940.20 Median:6419.58 stddev:2633.15 (41.0%) stddev-sans-first:2627.77 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: Values: 1489.8 1668.5 1726.0 1729.6 1744.0 6871.5 7180.3 7368.2 7430.4 7445.3 7198.6 7215.0 7291.7 7302.1 7310.4 2036.3 2078.7 2086.3 2087.3 2087.8 2065.8 2083.0 2084.1 2093.0 2101.0 1703.3 1725.3 2012.7 2063.5 2087.5 2034.8 2039.3 2046.0 2048.3 2050.9 2066.8 2076.2 2096.2 2121.5 2122.4 6975.9 6999.7 7013.2 7015.8 7016.8 4052.0 4109.8 4112.7 4125.7 4146.2 2669.6 2680.0 2709.1 2735.8 2740.2 835.5 851.3 867.8 881.8 891.3 9732.9 9744.8 9778.0 9820.5 9824.1 3637.2 3708.3 3736.2 3805.5 3809.7 7519.5 7580.9 7604.8 7618.3 7620.8 4178.1 4190.7 4200.5 4202.6 4211.0 3819.3 3823.7 3835.9 3839.8 3845.5 2983.5 3046.8 3052.9 3074.2 3100.4 931.7 942.7 947.5 953.3 956.5 836.3 849.4 873.8 879.6 1176.8 6367.4 6537.5 6544.8 6556.7 6559.8 550.7 557.8 559.5 565.7 716.2 4634.5 4689.5 4694.2 4696.7 4697.9 8546.9 8689.4 8894.8 8938.4 8957.7 8700.2 8756.1 8757.3 8794.3 8860.8 6707.3 6832.7 6847.6 6904.1 6934.1 6471.8 6499.3 6516.3 6533.8 6537.8 7583.4 7700.2 7729.8 7805.6 7839.7 7876.3 7900.4 7951.0 7958.8 7965.8 5740.9 5751.5 5787.2 5792.0 5820.5 7026.3 7048.8 7125.2 7127.2 7138.8 6638.8 6711.7 6713.2 6787.9 6826.1 5805.3 5820.4 6474.4 6493.2 6543.7 6113.9 6121.5 6220.8 6471.8 6473.0 6002.6 6038.8 6041.4 6042.8 6044.5 6128.5 6139.1 6160.7 6171.6 6178.2 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4843.86 Median:5576.98 stddev:1453.80 (26.1%) stddev-sans-first:1417.37 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: Values: 303.5 304.9 307.8 310.9 313.4 5569.1 5589.4 5628.9 5723.8 5742.6 5545.6 5584.9 5622.5 5624.3 5630.9 4132.1 4233.6 4323.7 4329.9 4331.7 4226.7 4244.1 4245.6 4262.7 4273.5 4162.1 4185.7 4196.9 4198.8 4206.8 4195.5 4203.5 4205.9 4207.1 4226.0 3633.6 3648.5 3649.2 3650.2 3657.0 5220.8 5373.2 5379.7 5385.3 5401.9 4847.5 4864.1 4868.2 4870.3 4874.7 5843.0 5848.5 5854.1 5856.9 5865.7 3994.0 3995.3 3998.1 4002.7 4011.6 5942.8 6120.8 6160.0 6185.4 6186.4 4013.6 4013.8 4016.3 4022.1 4033.0 4070.4 4071.1 4073.0 4082.6 4084.6 4780.1 4782.9 4787.8 4795.0 4796.3 5728.3 5833.7 5845.4 5857.7 5884.5 1452.8 1480.9 1493.0 1493.6 1494.1 981.0 1006.3 1008.1 1012.9 1013.3 5084.8 5091.6 5096.0 5096.5 5125.8 5987.5 6080.7 6122.2 6153.4 6175.8 5105.0 5106.7 5119.3 5130.3 5133.0 3275.4 3285.5 3303.7 3303.8 3313.7 5600.9 5695.4 5733.8 5743.5 5768.8 6336.1 6343.8 6350.5 6351.7 6359.3 5716.8 5772.0 5784.9 5791.4 5796.2 6111.9 6135.0 6136.9 6152.0 6160.1 5851.4 5972.5 6000.5 6002.1 6016.3 5734.1 5744.1 5754.7 5761.1 5790.4 4137.6 4149.7 4179.2 4180.1 4181.1 6035.6 6098.3 6141.7 6150.5 6155.2 5888.4 5891.1 5892.9 5894.7 5898.0 5868.8 5887.9 5889.3 5893.7 5895.5 5618.9 5741.1 5768.3 5769.3 5789.9 5923.2 5939.4 5942.2 5945.3 5973.5 5781.4 5801.0 5808.3 5812.0 5821.7 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11834.52 Median:459.05 stddev:13600.91 (2962.8%) stddev-sans-first:13613.33 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: Values: 692.8 700.3 708.2 721.1 729.1 11238.7 11287.7 11428.5 11440.5 11465.4 10079.8 11089.6 11205.1 11205.2 11245.4 783.7 784.3 804.9 808.3 808.9 790.6 790.7 794.0 796.5 796.9 828.4 833.8 836.0 837.2 838.2 819.5 824.1 824.3 825.9 826.3 612.6 614.9 617.1 617.4 618.6 11598.1 11687.6 11711.2 11775.5 11797.7 10556.5 10597.4 10816.6 10923.2 11065.4 8742.7 8804.3 8873.7 9184.7 9291.3 3064.6 3146.6 3149.5 3177.2 3236.3 39664.0 39720.0 40351.2 40362.6 40363.6 8032.9 8141.8 8147.1 8278.0 8375.8 15484.0 15559.7 15560.5 15572.7 15574.6 6238.4 6337.1 6395.2 6496.9 6514.8 3304.5 3400.9 3420.1 3444.7 3479.9 2567.3 2596.7 2603.4 2610.2 2615.6 451.9 454.3 459.0 459.1 463.2 408.3 418.0 434.0 457.7 467.1 6435.2 6687.3 6862.8 6873.0 6915.9 484.7 507.7 545.4 569.1 594.6 3157.6 3176.5 3354.4 3521.2 3634.7 46993.3 47300.3 47685.8 47843.0 49744.3 43200.1 43251.8 43436.0 43523.6 43594.6 39503.6 39939.2 40837.0 41324.8 41612.6 7210.4 7218.4 7227.9 7373.3 7501.8 31630.4 31838.0 31868.0 32326.0 32587.0 35504.8 35923.0 38387.2 40729.0 41016.0 9309.3 9432.3 9479.6 9495.3 9711.9 10631.5 10663.7 10695.9 10800.8 10859.2 9709.8 9716.6 9720.1 10029.7 10130.1 10025.5 10055.6 10087.6 10134.2 10332.9 9456.5 9496.2 9565.8 10107.3 10141.5 8185.4 8239.2 8558.6 8691.6 8704.4 8329.9 8568.0 8635.6 8635.8 8966.9 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:25:53 INFO - 2015-12-17 17:25:53,709 DEBUG : BROWSER_OUTPUT: 17:25:54 INFO - 2015-12-17 17:25:54,437 INFO : Browser exited with error code: 0 17:25:54 INFO - 2015-12-17 17:25:54,455 INFO : Completed test dromaeo_css (00:18:35) 17:25:54 INFO - 2015-12-17 17:25:54,455 INFO : Starting test kraken 17:25:54 INFO - 2015-12-17 17:25:54,455 DEBUG : operating with platform_type : linux_ 17:25:54 INFO - 2015-12-17 17:25:54,455 INFO : Initialising browser for kraken test... 17:25:54 INFO - 2015-12-17 17:25:54,461 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4AgCfY/profile http://localhost:42770/getInfo.html 17:25:59 INFO - 2015-12-17 17:25:59,377 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:25:59 INFO - 2015-12-17 17:25:59,378 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:25:59 INFO - 2015-12-17 17:25:59,378 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:25:59 INFO - 2015-12-17 17:25:59,378 DEBUG : BROWSER_OUTPUT: __metrics 17:25:59 INFO - 2015-12-17 17:25:59,514 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:26:00 INFO - 2015-12-17 17:26:00,424 INFO : Browser initialized. 17:26:00 INFO - 2015-12-17 17:26:00,425 INFO : Running cycle 1/1 for kraken test... 17:26:00 INFO - 2015-12-17 17:26:00,425 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4AgCfY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:12 INFO - 2015-12-17 17:26:12,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 151433216 17:26:12 INFO - 2015-12-17 17:26:12,521 DEBUG : BROWSER_OUTPUT: 17:26:15 INFO - 2015-12-17 17:26:15,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:15 INFO - 2015-12-17 17:26:15,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 150601728 17:26:15 INFO - 2015-12-17 17:26:15,738 DEBUG : BROWSER_OUTPUT: 17:26:18 INFO - 2015-12-17 17:26:18,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-dft) 17:26:19 INFO - 2015-12-17 17:26:19,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 151334912 17:26:19 INFO - 2015-12-17 17:26:19,057 DEBUG : BROWSER_OUTPUT: 17:26:21 INFO - 2015-12-17 17:26:21,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-fft) 17:26:22 INFO - 2015-12-17 17:26:22,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 146022400 17:26:22 INFO - 2015-12-17 17:26:22,551 DEBUG : BROWSER_OUTPUT: 17:26:24 INFO - 2015-12-17 17:26:24,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator) 17:26:25 INFO - 2015-12-17 17:26:25,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 147075072 17:26:25 INFO - 2015-12-17 17:26:25,231 DEBUG : BROWSER_OUTPUT: 17:26:27 INFO - 2015-12-17 17:26:27,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:28 INFO - 2015-12-17 17:26:28,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 146698240 17:26:28 INFO - 2015-12-17 17:26:28,075 DEBUG : BROWSER_OUTPUT: 17:26:31 INFO - 2015-12-17 17:26:31,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:31 INFO - 2015-12-17 17:26:31,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 147279872 17:26:31 INFO - 2015-12-17 17:26:31,748 DEBUG : BROWSER_OUTPUT: 17:26:35 INFO - 2015-12-17 17:26:35,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:35 INFO - 2015-12-17 17:26:35,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 148717568 17:26:35 INFO - 2015-12-17 17:26:35,791 DEBUG : BROWSER_OUTPUT: 17:26:38 INFO - 2015-12-17 17:26:38,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial) 17:26:39 INFO - 2015-12-17 17:26:39,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 149241856 17:26:39 INFO - 2015-12-17 17:26:39,353 DEBUG : BROWSER_OUTPUT: 17:26:41 INFO - 2015-12-17 17:26:41,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:41 INFO - 2015-12-17 17:26:41,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 148766720 17:26:41 INFO - 2015-12-17 17:26:41,703 DEBUG : BROWSER_OUTPUT: 17:26:43 INFO - 2015-12-17 17:26:43,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:44 INFO - 2015-12-17 17:26:44,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 149319680 17:26:44 INFO - 2015-12-17 17:26:44,191 DEBUG : BROWSER_OUTPUT: 17:26:46 INFO - 2015-12-17 17:26:46,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:46 INFO - 2015-12-17 17:26:46,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 149000192 17:26:46 INFO - 2015-12-17 17:26:46,952 DEBUG : BROWSER_OUTPUT: 17:26:49 INFO - 2015-12-17 17:26:49,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:50 INFO - 2015-12-17 17:26:50,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 149557248 17:26:50 INFO - 2015-12-17 17:26:50,114 DEBUG : BROWSER_OUTPUT: 17:26:52 INFO - 2015-12-17 17:26:52,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:53 INFO - 2015-12-17 17:26:53,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 148287488 17:26:53 INFO - 2015-12-17 17:26:53,317 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42770/tests/kraken/driver.html?testName=ai-astar) 17:26:55 INFO - 2015-12-17 17:26:55,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 148647936 17:26:55 INFO - 2015-12-17 17:26:55,327 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,328 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:26:55 INFO - 2015-12-17 17:26:55,329 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:26:55 INFO - 2015-12-17 17:26:55,329 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:26:55 INFO - 2015-12-17 17:26:55,329 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:26:55 INFO - 2015-12-17 17:26:55,329 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;114;113;115;125;113;113;114;113 17:26:55 INFO - 2015-12-17 17:26:55,329 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;152;166;135;161;159;135;168;134 17:26:55 INFO - 2015-12-17 17:26:55,330 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;162;165;170;167;161;165;161 17:26:55 INFO - 2015-12-17 17:26:55,330 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;74;74;133;73;78;71;74;86 17:26:55 INFO - 2015-12-17 17:26:55,330 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;144;94;98;95;129;96;95;128 17:26:55 INFO - 2015-12-17 17:26:55,330 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;110;111;110;111;111 17:26:55 INFO - 2015-12-17 17:26:55,331 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;147;148;147;147;148;149;147 17:26:55 INFO - 2015-12-17 17:26:55,331 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;98;96;111;95;96;96;97;96 17:26:55 INFO - 2015-12-17 17:26:55,331 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;71;72;72;72;73;78;74;69 17:26:55 INFO - 2015-12-17 17:26:55,331 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;68;68;68;68 17:26:55 INFO - 2015-12-17 17:26:55,332 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;84;83;85;83;84;85;91 17:26:55 INFO - 2015-12-17 17:26:55,332 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;121;124;124;127;120;123;128;125;126 17:26:55 INFO - 2015-12-17 17:26:55,332 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;148;154;147;148;134;161;139;149;145 17:26:55 INFO - 2015-12-17 17:26:55,332 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;74;68;71;70;69;71;70;69;71 17:26:55 INFO - 2015-12-17 17:26:55,333 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:26:55 INFO - 2015-12-17 17:26:55,333 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:26:55 INFO - 2015-12-17 17:26:55,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,806 17:26:55 INFO - 2015-12-17 17:26:55,334 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:26:55 INFO - 2015-12-17 17:26:55,334 DEBUG : BROWSER_OUTPUT: __startTimestamp1450402015328__endTimestamp 17:26:55 INFO - 2015-12-17 17:26:55,335 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.27 (3.7%) stddev-sans-first:4.49 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 114.0 113.0 115.0 125.0 113.0 113.0 114.0 113.0 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.50 stddev:14.55 (9.3%) stddev-sans-first:15.33 17:26:55 INFO - 2015-12-17 17:26:55,338 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 152.0 166.0 135.0 161.0 159.0 135.0 168.0 134.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:2.98 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 162.0 165.0 170.0 167.0 161.0 165.0 161.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:18.76 (25.3%) stddev-sans-first:19.61 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 74.0 74.0 133.0 73.0 78.0 71.0 74.0 86.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:95.00 stddev:18.98 (20.0%) stddev-sans-first:19.63 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 144.0 94.0 98.0 95.0 129.0 96.0 95.0 128.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 110.0 111.0 110.0 111.0 111.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 149.0 147.0 17:26:55 INFO - 2015-12-17 17:26:55,339 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.60 Median:96.00 stddev:4.79 (5.0%) stddev-sans-first:4.99 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 98.0 96.0 111.0 95.0 96.0 96.0 97.0 96.0 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.00 stddev:2.32 (3.2%) stddev-sans-first:2.46 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 72.0 72.0 72.0 73.0 78.0 74.0 69.0 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.36 (2.8%) stddev-sans-first:2.42 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 84.0 83.0 85.0 83.0 84.0 85.0 91.0 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:124.50 stddev:2.58 (2.1%) stddev-sans-first:2.64 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: Values: 122.0 121.0 124.0 124.0 127.0 120.0 123.0 128.0 125.0 126.0 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,340 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.00 stddev:8.31 (5.6%) stddev-sans-first:7.81 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: Values: 135.0 148.0 154.0 147.0 148.0 134.0 161.0 139.0 149.0 145.0 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:1.64 (2.3%) stddev-sans-first:1.73 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 68.0 71.0 70.0 69.0 71.0 70.0 69.0 71.0 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:26:55 INFO - 2015-12-17 17:26:55,341 DEBUG : BROWSER_OUTPUT: 17:26:56 INFO - 2015-12-17 17:26:56,288 INFO : Browser exited with error code: 0 17:26:56 INFO - 2015-12-17 17:26:56,337 INFO : Completed test kraken (00:01:01) 17:26:56 INFO - 2015-12-17 17:26:56,337 INFO : Starting test v8_7 17:26:56 INFO - 2015-12-17 17:26:56,337 DEBUG : operating with platform_type : linux_ 17:26:56 INFO - 2015-12-17 17:26:56,337 INFO : Initialising browser for v8_7 test... 17:26:56 INFO - 2015-12-17 17:26:56,343 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV6Hon/profile http://localhost:42770/getInfo.html 17:27:01 INFO - 2015-12-17 17:27:01,098 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:27:01 INFO - 2015-12-17 17:27:01,098 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:27:01 INFO - 2015-12-17 17:27:01,098 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:27:01 INFO - 2015-12-17 17:27:01,098 DEBUG : BROWSER_OUTPUT: __metrics 17:27:01 INFO - 2015-12-17 17:27:01,215 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:27:02 INFO - 2015-12-17 17:27:02,164 INFO : Browser initialized. 17:27:02 INFO - 2015-12-17 17:27:02,165 INFO : Running cycle 1/1 for v8_7 test... 17:27:02 INFO - 2015-12-17 17:27:02,165 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV6Hon/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:27:14 INFO - 2015-12-17 17:27:14,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 150761472 17:27:14 INFO - 2015-12-17 17:27:14,152 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/v8_7/run.html (next: http://localhost:42770/tests/v8_7/run.html) 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 145592320 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:27:35 INFO - 2015-12-17 17:27:35,834 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7550140891762 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.11406844106463 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1074.1138560687432 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |5;Earley;699.7900629811056 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |6;Boyer;12407.407407407407 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 17:27:35 INFO - 2015-12-17 17:27:35,835 DEBUG : BROWSER_OUTPUT: |8;Splay;653.59477124183 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: __startTimestamp1450402055827__endTimestamp 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,836 DEBUG : BROWSER_OUTPUT: Values: 165.8 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: Values: 190.1 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: Values: 279.6 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: Values: 5229.2 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: Values: 1074.1 17:27:35 INFO - 2015-12-17 17:27:35,837 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:699.79 Median:699.79 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: Values: 699.8 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: Values: 12407.4 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,838 DEBUG : BROWSER_OUTPUT: Values: 26394.7 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:653.59 Median:653.59 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: Values: 653.6 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: Values: 4840.6 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:27:35 INFO - 2015-12-17 17:27:35,839 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-17 17:27:36,760 INFO : Browser exited with error code: 0 17:27:36 INFO - 2015-12-17 17:27:36,775 INFO : Completed test v8_7 (00:00:40) 17:27:36 INFO - 2015-12-17 17:27:36,848 INFO : Completed test suite (00:20:18) 17:27:36 INFO - 2015-12-17 17:27:36,848 DEBUG : Working with test: dromaeo_css 17:27:36 INFO - 2015-12-17 17:27:36,848 DEBUG : Generating results file: dromaeo_css 17:27:36 INFO - 2015-12-17 17:27:36,849 DEBUG : Working with test: kraken 17:27:36 INFO - 2015-12-17 17:27:36,850 DEBUG : Generating results file: kraken 17:27:36 INFO - 2015-12-17 17:27:36,850 INFO : javascript benchmark 17:27:36 INFO - 2015-12-17 17:27:36,850 DEBUG : Working with test: v8_7 17:27:36 INFO - 2015-12-17 17:27:36,850 DEBUG : Generating results file: v8_7 17:27:36 INFO - 2015-12-17 17:27:36,850 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - 2015-12-17 17:27:36,896 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 17:27:36 INFO - 2015-12-17 17:27:36,896 DEBUG : process_Request line: dromaeo_css 6241.50 graph.html#tests=[[72,94,43]] 17:27:36 INFO - 2015-12-17 17:27:36,896 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - 2015-12-17 17:27:36,922 DEBUG : process_Request line: kraken 1536.70 graph.html#tests=[[232,94,43]] 17:27:36 INFO - 2015-12-17 17:27:36,922 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:36 INFO - 2015-12-17 17:27:36,950 DEBUG : process_Request line: v8_7 21088.19 graph.html#tests=[[230,94,43]] 17:27:36 INFO - 2015-12-17 17:27:36,951 INFO : javascript benchmark 17:27:37 INFO - 2015-12-17 17:27:36,955 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2664.893404263829, 2671.599260110982, 2714.8914043438263, 2728.9590656140163, 2736.9863150684246, 4524.163029839482, 4690.8123675053, 4691.319758635, 4720.244760838266, 4749.216379297412, 4639.164950308943, 4680.882977925554, 4681.040386720722, 4710.057988402316, 4794.3767310249705, 4377.474703035632, 4445.755483448409, 4509.098180363941, 4523.36672865799, 4541.954580454203, 4411.250087485119, 4439.911201775979, 4467.5755803198645, 4534.795934182953, 4546.136234115524, 4250.851220207278, 4310.396544483775, 4350.477942646902, 4405.118976204772, 4422.248217802981, 4391.890202744925, 4436.0906014267, 4438.378626992224, 4463.352813842007, 4494.955050449519, 4399.692021558492, 4409.11817636474, 4422.358757980107, 4450.599446049871, 4468.664850136252, 4540.409746732937, 4587.908241835178, 4619.260918253063, 4704.506026867164, 4758.928616070762, 5099.872503187413, 5108.361454818148, 5116.897662046776, 5144.3312369392115, 5171.198464238049, 4790.0, 5074.985002999415, 5121.078205922932, 5145.51117643827, 5163.199704045879, 4666.2067448533835, 4723.858284251443, 4804.111239420718, 4810.7835147418455, 4841.927371089437, 5212.139996900545, 5250.684958902478, 5252.159654455345, 5264.5525130363585, 5302.469753024744, 4776.737279449663, 4809.78355973982, 5026.07017701719, 5033.615755667148, 5050.191969284971, 5023.045621331935, 5050.722210278396, 5073.695578265316, 5149.330587023738, 5165.328507294028, 5103.157978933508, 5109.054824857339, 5111.05445492585, 5124.92312615311, 5154.278401023859, 4737.28940658904, 4851.636127290467, 5059.089363914531, 5068.41713202979, 5081.212412076134, 4189.664826813848, 4254.659627229876, 4259.2759230930815, 4296.0, 4318.611324980704, 3672.926541469156, 3673.7428380013143, 3688.170161713593, 3704.0, 3723.497327860758, 4182.937255941163, 4290.120525292307, 4308.827646894152, 4325.7837108145095, 4334.783260836945, 5114.667546609458, 5119.667221630582, 5120.1039818031695, 5121.28302037715, 5139.6145289102715, 4382.802773875183, 4385.451818522684, 4391.560843915583, 4394.604485596312, 4434.0, 4292.806823692941, 4380.561943805594, 4413.13943780966, 4520.141173177086, 4531.478879928784, 4824.734639594786, 4836.903261934671, 4845.200541910615, 4856.927146092741, 4874.390701162355, 5068.873278168076, 5073.808098942719, 5110.1568241239775, 5113.693178409308, 5163.4578369270685, 4537.705049171794, 4687.10944920464, 4773.546513081252, 4850.708957462563, 4854.80580776765, 4977.900441991067, 5011.298418221525, 5020.899582008266, 5058.974705126451, 5089.440161582297, 4872.4153101628035, 5130.923036154386, 5138.511841375063, 5140.537351638371, 5147.716875571879, 4835.927461088017, 4854.95145048545, 4861.343718597944, 4916.360873086476, 5025.120603894377, 4931.13705101613, 4947.332110165082, 4950.900981980269, 4953.281774142802, 5019.422766381766, 4814.253790662453, 4850.83022094225, 4856.805727770849, 4883.536064073907, 4895.388076490439, 4701.200795864643, 4775.785089670903, 4852.466228714768, 4974.054929563371, 4990.126727822689, 4842.959974096462, 4854.781534831011, 4858.3441235434175, 4892.217245240744, 4895.828645997373], "unit": "score", "name": "dojo.html", "value": 4656.611216972587}, {"lowerIsBetter": false, "replicates": [549.9010178167931, 560.5403569073361, 561.2058936604703, 561.2142999800277, 568.8293511946416, 34238.144046398855, 35318.29363412737, 35366.2926741465, 35462.290754184934, 35684.0, 39266.60733392665, 39779.20441591166, 39840.80079599605, 39850.60149398505, 40032.0, 7765.1458339582605, 8071.475354101994, 8076.030876294823, 8077.0, 8078.71724489643, 7885.250901164381, 7992.200779922019, 8008.119106898236, 8012.238837310446, 8020.719274825382, 7816.218378162195, 7853.489523180975, 7885.684572617117, 7894.092179399385, 7917.7624671259955, 7749.535027898316, 7757.961210193941, 7771.689132434696, 7807.6876924922935, 7830.334421574173, 7822.491538050065, 7939.285464308182, 7973.920260797434, 7982.720604778805, 8003.079645840687, 35794.28411431783, 36354.45468317977, 36403.0, 36442.27115457676, 36488.270234595424, 2761.9447611047667, 2814.2823579987175, 2877.7985541012135, 2911.5195992661183, 3273.4435146025235, 27781.305467363276, 28000.439991200063, 28152.0, 28318.0, 28566.143015709353, 3361.494349638997, 3458.1008937676133, 3504.1590018395655, 3517.296540691846, 3538.539989801335, 208545.0, 209396.0, 209916.0, 211595.94202029044, 211808.0, 49762.25356619654, 51648.741756290976, 53104.73447632737, 53109.734451328266, 54281.72859135679, 47854.5214547857, 48077.0, 48260.27609585859, 48348.75825620849, 48358.0, 13577.52478663242, 13655.180689158682, 13721.804511278147, 13804.792928106086, 13911.513097041556, 10451.425171615634, 10567.0, 10569.841452378221, 10584.735381615366, 10596.364218146782, 18424.907875460805, 18578.0, 18592.628147436975, 18638.720419193724, 18701.25194992185, 7497.325240728361, 7579.734709285259, 7627.961860190663, 7681.078270607562, 7703.845923081507, 914.1589737441569, 942.1473566422399, 982.4694664881027, 987.5605355616682, 1087.505185140759, 25794.355141121247, 26406.339841503734, 26556.203313900613, 26897.596536051973, 26947.326316841845, 924.9861252081224, 936.4849332867033, 961.6778379242892, 979.1872745621117, 1043.6295115234134, 12217.450214740358, 12242.326672032945, 12359.876401235873, 12534.122611417113, 12714.87285127137, 260773.0, 263284.0, 264854.0, 265488.0, 265921.0, 44849.77575112104, 44905.326420103724, 44965.0, 45007.77496112498, 45011.54988450074, 1184.2295767826981, 1200.6458094862037, 1206.3304865799566, 1228.7235372041398, 1233.7902556565584, 23783.643245350988, 25527.234182974542, 26165.345866353495, 26510.867445663418, 27262.454750905268, 39473.0, 39871.60128398679, 39879.0, 39885.401718973655, 39999.60000400075, 208187.0, 209125.0, 209725.0, 209838.0, 210168.0, 27681.723182767913, 27892.0, 28745.712542874302, 28911.855440722662, 29012.854935725187, 35551.82224088863, 36231.818840905624, 36331.27337453183, 36411.81794091013, 36443.63556364403, 30946.226344341572, 31621.0, 31707.20731981719, 31743.0, 32163.51754723634, 31458.213544661565, 31923.68076319207, 33531.4970275451, 33906.83046584751, 34000.65999340074, 29703.0, 29734.25664358408, 29967.100986970425, 30044.0, 30046.399072018874, 25775.87112064428, 27040.72959270382, 27669.30826729348, 29043.7095629041, 29080.0, 23102.884485577466, 23339.29982100472, 30243.546346804374, 32720.672793272715, 32955.17612059718], "unit": "score", "name": "ext.html", "value": 16506.349792118635}, {"lowerIsBetter": false, "replicates": [325.1691927126193, 326.4483023689964, 326.6406952352412, 328.85037308024835, 341.0280700004985, 12192.20750651207, 12540.122191446602, 15037.774433383507, 15429.537113886587, 15473.071615703051, 14258.144511329301, 14401.351939162736, 14961.0, 15482.61293467664, 15557.06657600542, 4810.903781924369, 4846.1034708578845, 4972.801087956477, 4983.551480366767, 4996.050750357439, 4844.15227335215, 4954.331165292693, 5003.949960500403, 5012.323336349583, 5030.320906677606, 4874.805007799701, 4965.503449655042, 4968.701877887338, 4985.900281994358, 5220.060389129955, 5277.3139491866, 5290.92063619046, 5295.205719142121, 5297.629165958385, 5306.893862122736, 4714.834980775657, 5037.11850426174, 5063.620228482879, 5065.1895696688725, 5073.644844860824, 11117.666470005832, 11141.164412669083, 11274.830877536844, 11282.153838462149, 11293.943530282379, 1763.0831967376891, 1777.2446710148265, 1788.0880750817048, 1814.7550080739063, 1877.0520886952002, 8537.701180458716, 8670.263027642657, 8821.867671984925, 8911.955440222757, 12229.143959922809, 1696.4401747423444, 1739.391213075426, 1780.4035648057916, 1797.766290382242, 1813.7732783402075, 52759.0, 56132.158017629765, 56356.0, 56953.145702814494, 57200.999999999585, 9734.9026509734, 9748.366356186825, 9820.4107753535, 9873.950630246803, 9883.258755593359, 12312.384380780924, 12379.504819807287, 12384.75230495385, 12386.56647017368, 12391.380430978415, 7022.403095736818, 7062.717491300393, 7097.609631470215, 7124.92875071253, 7155.856882862314, 6732.528722989344, 6806.183258008971, 6813.897791533131, 6835.487338449636, 6871.244163142051, 3998.520177578709, 4117.485314335708, 4156.147989662172, 4163.97918010408, 4170.186813571325, 1754.649070185968, 1797.957184832794, 1809.746635471035, 1822.3257394764023, 1842.023727424467, 759.7302957450136, 846.6909578003985, 849.8682704180862, 949.2216382566229, 956.3066776587058, 15158.393664253526, 15253.923730381277, 15276.0, 15779.368825246862, 15831.762523561925, 855.4396870050127, 863.4775960543906, 867.3018220332693, 868.561376504861, 896.6458248991612, 8727.258183054384, 8782.385233033627, 8884.333674974274, 8900.643974241088, 9084.137006984325, 433454.0, 435753.21233938175, 439101.0, 452176.0, 459902.0, 75927.0, 76460.0, 77435.0, 77731.61134194293, 77854.0, 1019.1948360795037, 1041.1774697988656, 1046.8953104689622, 1056.228952864398, 1080.8919108089285, 14210.715785684022, 14254.28728563547, 14282.785758213427, 14322.57032289033, 14330.140191588538, 33801.661983379854, 33997.15007124743, 34004.48993265053, 34666.306673866886, 35511.0, 45788.0, 46098.53901461077, 46335.3049704248, 48491.27263091127, 48556.75721621369, 8203.917960820316, 8459.815625812515, 8878.51168185756, 8894.86657700148, 8927.553622318728, 11726.413679315829, 11990.580329688419, 15122.319495622503, 15249.237538122827, 15565.377384904477, 12902.225866448043, 13635.86364136346, 13805.51680691171, 13910.443582256596, 13936.860631393962, 13288.335583220995, 13413.798793017917, 13421.530246441718, 13812.0, 13876.791848122488, 12594.811077833656, 12598.622041338775, 12869.485220591072, 13638.181709097486, 14172.503962361268, 8544.615492302986, 8606.44058136219, 8765.824683506167, 8886.511241881759, 8896.866547001671, 9289.62841486333, 11227.943860280646, 13797.931010345286, 13842.861571384157, 13973.021888467709], "unit": "score", "name": "jquery.html", "value": 8103.06150916071}, {"lowerIsBetter": false, "replicates": [1489.8212214534258, 1668.5244705259, 1725.998920626037, 1729.6281299520608, 1744.0233469257216, 6871.450283977282, 7180.28197180283, 7368.189499155089, 7430.368418684411, 7445.255474452552, 7198.604076775775, 7215.0, 7291.671874765635, 7302.087239095114, 7310.415166786657, 2036.256766280308, 2078.6570215914358, 2086.3428020173674, 2087.279888438486, 2087.7912208779153, 2065.7727649958492, 2083.0418007716394, 2084.1038353507984, 2092.9581408371823, 2101.0335245786955, 1703.2675949341779, 1725.2581390002356, 2012.6779715245564, 2063.525389160494, 2087.488565301503, 2034.8270397016272, 2039.276056999766, 2046.048587406863, 2048.3445297504804, 2050.897455127245, 2066.772655007948, 2076.2110398048794, 2096.2139197800825, 2121.4802373418456, 2122.36329101269, 6975.895361569581, 6999.650017499155, 7013.193482749498, 7015.82460438488, 7016.842221033523, 4051.97974010131, 4109.794510274474, 4112.732672376286, 4125.731827431207, 4146.212219678282, 2669.599560065986, 2679.973200267992, 2709.078913169512, 2735.8084934054623, 2740.2464322311325, 835.5321020228631, 851.3104385447807, 867.7917299848054, 881.823635272948, 891.3003292415488, 9732.90267097327, 9744.805103897954, 9778.0, 9820.459874706889, 9824.066713662261, 3637.2361804021452, 3708.3325001499447, 3736.23407201523, 3805.486259355007, 3809.733318667722, 7519.511231769918, 7580.886286705704, 7604.771856844303, 7618.276263754934, 7620.847583048308, 4178.12259425518, 4190.706650534434, 4200.474940632421, 4202.621764041251, 4211.031462763582, 3819.255245227154, 3823.713221508398, 3835.9232815343535, 3839.7504162229366, 3845.4616353710503, 2983.508023190732, 3046.832424216645, 3052.9084127476212, 3074.216074900886, 3100.4419204543397, 931.701855406277, 942.7454587261401, 947.5262368815593, 953.3374304858196, 956.5217391304348, 836.3392919593452, 849.3757088539918, 873.7684513603773, 879.5778026547293, 1176.8293597428496, 6367.363263673596, 6537.5096867734155, 6544.8363790905605, 6556.704948277339, 6559.803205903735, 550.6998685716294, 557.7518004488045, 559.5439716630933, 565.660603637814, 716.1942814333875, 4634.467036290802, 4689.484156742756, 4694.201985662446, 4696.741679207608, 4697.906041879211, 8546.871796923051, 8689.391742578086, 8894.822103557892, 8938.374313798102, 8957.686480973265, 8700.173483519056, 8756.080611535825, 8757.343199260082, 8794.34042446819, 8860.778480537909, 6707.262201157869, 6832.658367081626, 6847.623380714009, 6904.13698287714, 6934.06390137325, 6471.805845824632, 6499.285078641251, 6516.283208846929, 6533.803985880431, 6537.803865884031, 7583.393328533593, 7700.191479894755, 7729.806754831175, 7805.609719514116, 7839.686412543662, 7876.291133797986, 7900.446968712365, 7950.960245198737, 7958.801029974297, 7965.761027169194, 5740.913886291625, 5751.511121554715, 5787.160861674949, 5792.0, 5820.505257053198, 7026.262242464468, 7048.823779405556, 7125.216226215216, 7127.180374256819, 7138.821529461805, 6638.800835974928, 6711.731530738911, 6713.1944166700305, 6787.932120678927, 6826.112605361272, 5805.332386775406, 5820.447057529528, 6474.449671777952, 6493.22081350241, 6543.70553325111, 6113.908291375544, 6121.47967422774, 6220.844478888064, 6471.838204044937, 6473.0, 6002.559385747477, 6038.849028774316, 6041.395860413923, 6042.848928776816, 6044.516438684806, 6128.4790792783115, 6139.079138129317, 6160.691965401622, 6171.56799024064, 6178.1659475971965], "unit": "score", "name": "mootools.html", "value": 3977.3332841027677}, {"lowerIsBetter": false, "replicates": [303.5143769968051, 304.8643353707601, 307.7722485360832, 310.9455845227085, 313.42330112592833, 5569.081101618233, 5589.385167631557, 5628.887422251558, 5723.828285151452, 5742.598018138732, 5545.611807173499, 5584.888302233963, 5622.4939755422, 5624.268845050148, 5630.943690563093, 4132.070284186064, 4233.555476674951, 4323.654107671378, 4329.913401731964, 4331.6534677225745, 4226.72526285792, 4244.108737165199, 4245.575442455761, 4262.65898728101, 4273.529911709725, 4162.146759914211, 4185.686073544481, 4196.874093777176, 4198.790060496963, 4206.831726730942, 4195.517515485728, 4203.516595591515, 4205.894852628679, 4207.137536804948, 4226.0, 3633.582138054131, 3648.4709717091137, 3649.2154186849953, 3650.178709790276, 3657.030886814996, 5220.843374698765, 5373.167159090347, 5379.67721936685, 5385.272988146589, 5401.918971215435, 4847.491013443609, 4864.100141473838, 4868.221084626478, 4870.342503761982, 4874.683145595525, 5842.97747894121, 5848.532117430638, 5854.063349864044, 5856.882862342729, 5865.736041878125, 3994.001499625094, 3995.3407687731487, 3998.140399814025, 4002.71912987844, 4011.5988401159652, 5942.821715348547, 6120.785772497986, 6160.0, 6185.381461853779, 6186.381361863778, 4013.6387725104883, 4013.799310034545, 4016.3373043447505, 4022.054817117975, 4033.0, 4070.4097905804083, 4071.063655359284, 4073.0, 4082.5509193988637, 4084.6323830855367, 4780.067886762048, 4782.856514304576, 4787.808487660454, 4794.95205047952, 4796.25658023007, 5728.312602487728, 5833.737481813244, 5845.386234445322, 5857.736401861926, 5884.499817515559, 1452.7602945514084, 1480.8519148085106, 1492.9850701493062, 1493.5519344196698, 1494.140869000329, 980.9901900981041, 1006.2955930848435, 1008.1468901523629, 1012.9240306977006, 1013.3058854684565, 5084.796608135707, 5091.5672167865405, 5095.974520127375, 5096.541311282002, 5125.846224613193, 5987.491063259585, 6080.695965201722, 6122.204113465221, 6153.353897840751, 6175.814725558241, 5104.974475127675, 5106.693598384109, 5119.334486516729, 5130.281760553526, 5132.9743351283005, 3275.394052100369, 3285.4743241081314, 3303.7357011439026, 3303.785253958485, 3313.7349012078976, 5600.943990560124, 5695.373508914016, 5733.799317023884, 5743.511801496919, 5768.769249229984, 6336.112944187817, 6343.841403964938, 6350.460210882126, 6351.745930162741, 6359.268684101295, 5716.828495145152, 5771.9711401443565, 5784.942150578525, 5791.391903850119, 5796.246487956539, 6111.908321375272, 6134.969325153345, 6136.8772624548155, 6151.96924015377, 6160.13758073861, 5851.356350801493, 5972.462478376967, 6000.459958603747, 6002.129691194665, 6016.308124565556, 5734.139879018181, 5744.0522313817755, 5754.7122643866805, 5761.135829625589, 5790.4209579043445, 4137.565555616738, 4149.730267532601, 4179.2059508693255, 4180.059486615487, 4181.121964387513, 6035.637861728311, 6098.29869564988, 6141.740943106742, 6150.477209437248, 6155.169052177898, 5888.411158884077, 5891.086881533369, 5892.9116063258225, 5894.734736936934, 5897.970510147422, 5868.794592189253, 5887.882242355215, 5889.322727886348, 5893.734781934909, 5895.528357731286, 5618.85952851182, 5741.13882917549, 5768.278965129359, 5769.336526299529, 5789.8552536186935, 5923.200367950271, 5939.406059394026, 5942.168096466585, 5945.346011938596, 5973.462388385066, 5781.392953739797, 5801.0, 5808.332041815245, 5811.970940145272, 5821.650700957956], "unit": "score", "name": "prototype.html", "value": 4373.777422373041}, {"lowerIsBetter": false, "replicates": [692.7921623512945, 700.2577268095819, 708.1537562612676, 721.1310371002945, 729.081357489563, 11238.719032024193, 11287.661370158889, 11428.485718142683, 11440.542378304868, 11465.369404682739, 10079.798404031915, 11089.611863584776, 11205.103591712665, 11205.159613029035, 11245.381504017276, 783.6551917156462, 784.3411534311192, 804.8511025460308, 808.2846680687575, 808.9029316482001, 790.5612385126252, 790.7232468635989, 794.0471434278888, 796.5181065455374, 796.9362451003934, 828.4242451496212, 833.770713053912, 836.0, 837.2004735477605, 838.2455789789177, 819.4960099538771, 824.0729179672868, 824.3487644760631, 825.938054645898, 826.2604968553171, 612.6018088242678, 614.8678034222619, 617.102116420607, 617.4257940115691, 618.6350053468475, 11598.130140239431, 11687.649370518899, 11711.1802173847, 11775.528978840835, 11797.705057373549, 10556.524956376981, 10597.364158150536, 10816.567337306498, 10923.180761442924, 11065.391403472806, 8742.694005709833, 8804.251638610662, 8873.73378798637, 9184.724458266262, 9291.349605527615, 3064.6169228846393, 3146.5752123463267, 3149.5433162191352, 3177.158053115926, 3236.2880166363598, 39663.99999999971, 39720.0, 40351.192976140315, 40362.59637403618, 40363.596364036275, 8032.919670803217, 8141.755747327589, 8147.144549822302, 8278.0, 8375.8324833503, 15484.0, 15559.688806223812, 15560.45538406173, 15572.688546229012, 15574.610634734223, 6238.376162383725, 6337.081123237105, 6395.20059992501, 6496.935030649633, 6514.837129071716, 3304.454764963802, 3400.9149771255916, 3420.1449637590604, 3444.6727560881677, 3479.9478007829903, 2567.281161274846, 2596.7403259673883, 2603.4142317978303, 2610.2299821552688, 2615.64688767014, 451.8847693838116, 454.2640921706856, 458.98106204226565, 459.12078369921227, 463.1755475254053, 408.320146955322, 417.97492150471066, 433.9761313127808, 457.69334545854355, 467.09150701885187, 6435.22777266731, 6687.297833727486, 6862.759803406857, 6872.965635171792, 6915.861682766316, 484.6510512431044, 507.72329080651133, 545.413680293678, 569.1462805791313, 594.6164723753155, 3157.589513363294, 3176.491761318178, 3354.3626710924846, 3521.1725244567506, 3634.727395445352, 46993.295100573516, 47300.29049564259, 47685.76157119262, 47843.0, 49744.25383619249, 43200.13599727988, 43251.78374108109, 43436.0, 43523.56476435195, 43594.56405435968, 39503.60496394999, 39939.20121597552, 40837.0, 41324.793376032925, 41612.58387416148, 7210.351068403659, 7218.3503484686635, 7227.8554428912175, 7373.29953654402, 7501.774946751606, 31630.36739265156, 31838.0, 31868.0, 32326.0, 32587.0, 35504.82247588746, 35923.0, 38387.232255355295, 40729.0, 41016.0, 9309.348345616012, 9432.339736218399, 9479.620815167593, 9495.335326527076, 9711.9028809711, 10631.468426578795, 10663.733406664585, 10695.94652026735, 10800.837987430352, 10859.2398532102, 9709.757256068655, 9716.611335546499, 9720.125188733047, 10029.749256268651, 10130.08829205375, 10025.548850301608, 10055.597776088875, 10087.596496140071, 10134.189264858645, 10332.948335258276, 9456.479893605918, 9496.19282361007, 9565.760855978378, 10107.3430227035, 10141.49292535385, 8185.4270201085355, 8239.232537223847, 8558.57207139653, 8691.608877600649, 8704.434211776213, 8329.916700833157, 8567.957160214159, 8635.568221589021, 8635.784105397415, 8966.865497017681], "unit": "score", "name": "yui.html", "value": 5455.988820537131}], "name": "dromaeo_css", "value": 6241.505270535423}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 114.0, 113.0, 115.0, 125.0, 113.0, 113.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 152.0, 166.0, 135.0, 161.0, 159.0, 135.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 165.0, 170.0, 167.0, 161.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 74.0, 74.0, 133.0, 73.0, 78.0, 71.0, 74.0, 86.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 144.0, 94.0, 98.0, 95.0, 129.0, 96.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 98.0, 96.0, 111.0, 95.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 73.0, 78.0, 74.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 83.0, 85.0, 83.0, 84.0, 85.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 124.0, 124.0, 127.0, 120.0, 123.0, 128.0, 125.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 154.0, 147.0, 148.0, 134.0, 161.0, 139.0, 149.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 68.0, 71.0, 70.0, 69.0, 71.0, 70.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1536.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [699.7900629811056], "unit": "score", "name": "Earley", "value": 952.3756270000003}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [653.59477124183], "unit": "score", "name": "Splay", "value": 124.68123000000001}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21088.18654762963}]} 17:27:37 INFO - RETURN: dromaeo_css: 6241.50 17:27:37 INFO - RETURN: kraken: 1536.70 17:27:37 INFO - RETURN: v8_7: 21088.19 17:27:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21088.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1536.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6241.50"}}} 17:27:37 INFO - Return code: 0 17:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:37 INFO - # TBPL SUCCESS # 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - Running post-run listener: _resource_record_post_run 17:27:38 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10387456; Write bytes: 440299520; Read time: 2960; Write time: 379588 17:27:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 44384256; Read time: 0; Write time: 13096 17:27:38 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8646656; Write bytes: 290992128; Read time: 2688; Write time: 247344 17:27:38 INFO - Running post-run listener: _upload_blobber_files 17:27:38 INFO - Blob upload gear active. 17:27:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:27:38 INFO - Copying logs to upload dir... 17:27:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.950824 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 17:27:38.168809) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:27:38.172995) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009863 build_url: 'https://queue.taskcluster.net/v1/task/O8PS9_g7T4qrUkAx8UVx9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:27:38.224476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:27:38.224816) ========= 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=70a720fcaf18edea6683c2dc000001ad-1450396506.926531-703837426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:27:38.275241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 17:27:38.275569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 17:27:38.275874) ========= ========= Total master_lag: 0.22 =========