builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1450453444.24 results: success (0) buildid: 20151218062559 builduid: f28b054323b04a6399dddc95523d778b revision: c5cb194cc9cb56d742fb3a7a826f0080b0404edc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.241757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.242257) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.242548) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004356 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.259718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.260107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.273529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.273919) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.322856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.323167) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.323523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.323806) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 07:44:04-- 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% 221M=0s 2015-12-18 07:44:04 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.457534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.457922) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018032 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:04.508012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 07:44:04.508397) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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 c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 07:44:04,846 truncating revision to first 12 chars 2015-12-18 07:44:04,846 Setting DEBUG logging. 2015-12-18 07:44:04,846 attempt 1/10 2015-12-18 07:44:04,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5cb194cc9cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 07:44:05,848 unpacking tar archive at: mozilla-central-c5cb194cc9cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.304975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 07:44:05.826828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:05.827184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:05.834889) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:05.835283) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 07:44:05.835730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-12-18 07:44:05.836027) ========= /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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:06 INFO - MultiFileLogger online at 20151218 07:44:06 in /builds/slave/test 07:44:06 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 07:44:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:06 INFO - {'append_to_log': False, 07:44:06 INFO - 'base_work_dir': '/builds/slave/test', 07:44:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:44:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:06 INFO - 'branch': 'Firefox-Non-PGO', 07:44:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:06 INFO - 'config_files': ('talos/linux_config.py',), 07:44:06 INFO - 'default_actions': ('clobber', 07:44:06 INFO - 'read-buildbot-config', 07:44:06 INFO - 'download-and-extract', 07:44:06 INFO - 'populate-webroot', 07:44:06 INFO - 'create-virtualenv', 07:44:06 INFO - 'install', 07:44:06 INFO - 'run-tests'), 07:44:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:06 INFO - 'download_minidump_stackwalk': True, 07:44:06 INFO - 'download_symbols': 'ondemand', 07:44:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:06 INFO - 'installer_path': 'installer.exe', 07:44:06 INFO - 'log_level': 'info', 07:44:06 INFO - 'log_name': 'talos', 07:44:06 INFO - 'log_to_console': True, 07:44:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:06 INFO - 'opt_config_files': (), 07:44:06 INFO - 'pip_index': False, 07:44:06 INFO - 'sps_profile': False, 07:44:06 INFO - 'sps_profile_interval': 0, 07:44:06 INFO - 'suite': 'dromaeojs-e10s', 07:44:06 INFO - 'system_bits': '64', 07:44:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:06 INFO - 'title': 'talos-linux64-ix-036', 07:44:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:06 INFO - 'use_talos_json': True, 07:44:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:06 INFO - 'work_dir': 'build'} 07:44:06 INFO - ##### 07:44:06 INFO - ##### Running clobber step. 07:44:06 INFO - ##### 07:44:06 INFO - Running pre-action listener: _resource_record_pre_action 07:44:06 INFO - Running main action method: clobber 07:44:06 INFO - rmtree: /builds/slave/test/build 07:44:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:07 INFO - Running post-action listener: _resource_record_post_action 07:44:07 INFO - ##### 07:44:07 INFO - ##### Running read-buildbot-config step. 07:44:07 INFO - ##### 07:44:07 INFO - Running pre-action listener: _resource_record_pre_action 07:44:07 INFO - Running main action method: read_buildbot_config 07:44:07 INFO - Using buildbot properties: 07:44:07 INFO - { 07:44:07 INFO - "project": "", 07:44:07 INFO - "product": "firefox", 07:44:07 INFO - "script_repo_revision": "production", 07:44:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:44:07 INFO - "repository": "", 07:44:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:44:07 INFO - "buildid": "20151218062559", 07:44:07 INFO - "pgo_build": "False", 07:44:07 INFO - "basedir": "/builds/slave/test", 07:44:07 INFO - "buildnumber": 181, 07:44:07 INFO - "slavename": "talos-linux64-ix-036", 07:44:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:44:07 INFO - "platform": "ubuntu64_hw", 07:44:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:44:07 INFO - "branch": "mozilla-central", 07:44:07 INFO - "repo_path": "mozilla-central", 07:44:07 INFO - "revision": "c5cb194cc9cb56d742fb3a7a826f0080b0404edc", 07:44:07 INFO - "stage_platform": "linux64", 07:44:07 INFO - "builduid": "f28b054323b04a6399dddc95523d778b", 07:44:07 INFO - "slavebuilddir": "test" 07:44:07 INFO - } 07:44:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:44:07 INFO - Running post-action listener: _resource_record_post_action 07:44:07 INFO - ##### 07:44:07 INFO - ##### Running download-and-extract step. 07:44:07 INFO - ##### 07:44:07 INFO - Running pre-action listener: _resource_record_pre_action 07:44:07 INFO - Running main action method: download_and_extract 07:44:07 INFO - mkdir: /builds/slave/test/build/tests 07:44:07 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')]} 07:44:07 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json 07:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json 07:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:44:07 INFO - Downloaded 1302 bytes. 07:44:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:44:07 INFO - Using the following test package requirements: 07:44:07 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:07 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'jsshell-linux-x86_64.zip'], 07:44:07 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:07 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:07 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:07 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:07 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:07 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:07 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44:07 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')]} 07:44:07 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:08 INFO - Downloaded 21871955 bytes. 07:44:08 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 07:44:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:08 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 07:44:10 INFO - Return code: 0 07:44:10 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 07:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:10 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:11 INFO - Downloaded 21871955 bytes. 07:44:11 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 07:44:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:44:11 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 07:44:12 INFO - Return code: 0 07:44:12 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')]} 07:44:12 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:13 INFO - Downloaded 11132039 bytes. 07:44:13 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 07:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:13 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 07:44:13 INFO - Return code: 0 07:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:13 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:44:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:44:14 INFO - Downloaded 53017186 bytes. 07:44:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:14 INFO - mkdir: /builds/slave/test/properties 07:44:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:14 INFO - Contents: 07:44:14 INFO - build_url:https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:44:14 INFO - Running post-action listener: _resource_record_post_action 07:44:14 INFO - Running post-action listener: set_extra_try_arguments 07:44:14 INFO - ##### 07:44:14 INFO - ##### Running populate-webroot step. 07:44:14 INFO - ##### 07:44:14 INFO - Running pre-action listener: _resource_record_pre_action 07:44:14 INFO - Running main action method: populate_webroot 07:44:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:14 INFO - '--tppagecycles', 07:44:14 INFO - '7'], 07:44:14 INFO - 'tests': ['tsvgm']}}, 07:44:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:44:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:44:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:44:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'tests': ['damp', 'tps']}, 07:44:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['damp', 'tps']}, 07:44:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:44:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:14 INFO - 'other': {'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'other_l64': {'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'other_nol64': {'tests': ['a11yr', 07:44:14 INFO - 'ts_paint', 07:44:14 INFO - 'tpaint', 07:44:14 INFO - 'sessionrestore', 07:44:14 INFO - 'sessionrestore_no_auto_restore']}, 07:44:14 INFO - 'svgr': {'tests': ['tsvgx', 07:44:14 INFO - 'tsvgr_opacity', 07:44:14 INFO - 'tart', 07:44:14 INFO - 'tscrollx', 07:44:14 INFO - 'cart']}, 07:44:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['tsvgx', 07:44:14 INFO - 'tsvgr_opacity', 07:44:14 INFO - 'tart', 07:44:14 INFO - 'tscrollx', 07:44:14 INFO - 'cart']}, 07:44:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'tests': ['tp5o']}, 07:44:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'talos_options': ['--e10s'], 07:44:14 INFO - 'tests': ['tp5o']}, 07:44:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'talos_options': ['--xperf_path', 07:44:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:14 INFO - 'tests': ['tp5n']}, 07:44:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:14 INFO - 'talos_options': ['--e10s', 07:44:14 INFO - '--xperf_path', 07:44:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:14 INFO - 'tests': ['tp5n']}}, 07:44:14 INFO - 'talos.zip': {'path': '', 07:44:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:14 INFO - Running post-action listener: _resource_record_post_action 07:44:14 INFO - ##### 07:44:14 INFO - ##### Running create-virtualenv step. 07:44:14 INFO - ##### 07:44:14 INFO - Running pre-action listener: _resource_record_pre_action 07:44:14 INFO - Running main action method: create_virtualenv 07:44:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:14 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 07:44:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:14 INFO - Using real prefix '/usr' 07:44:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:17 INFO - Installing pip.................done. 07:44:17 INFO - Return code: 0 07:44:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:17 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 07:44:17 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 07:44:17 INFO - Using env: {'DISPLAY': ':0', 07:44:17 INFO - 'HOME': '/home/cltbld', 07:44:17 INFO - 'LANG': 'en_US.UTF-8', 07:44:17 INFO - 'LANGUAGE': 'en_US:en', 07:44:17 INFO - 'LOGNAME': 'cltbld', 07:44:17 INFO - 'MAIL': '/var/mail/cltbld', 07:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:17 INFO - 'MOZ_NO_REMOTE': '1', 07:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:17 INFO - 'NO_EM_RESTART': '1', 07:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:17 INFO - 'PWD': '/builds/slave/test', 07:44:17 INFO - 'SHELL': '/bin/bash', 07:44:17 INFO - 'SHLVL': '1', 07:44:17 INFO - 'TERM': 'linux', 07:44:17 INFO - 'TMOUT': '86400', 07:44:17 INFO - 'USER': 'cltbld', 07:44:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:17 INFO - '_': '/tools/buildbot/bin/python'} 07:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:17 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 07:44:17 INFO - Cleaning up... 07:44:17 INFO - Return code: 0 07:44:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:17 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 07:44:17 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 07:44:17 INFO - Using env: {'DISPLAY': ':0', 07:44:17 INFO - 'HOME': '/home/cltbld', 07:44:17 INFO - 'LANG': 'en_US.UTF-8', 07:44:17 INFO - 'LANGUAGE': 'en_US:en', 07:44:17 INFO - 'LOGNAME': 'cltbld', 07:44:17 INFO - 'MAIL': '/var/mail/cltbld', 07:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:17 INFO - 'MOZ_NO_REMOTE': '1', 07:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:17 INFO - 'NO_EM_RESTART': '1', 07:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:17 INFO - 'PWD': '/builds/slave/test', 07:44:17 INFO - 'SHELL': '/bin/bash', 07:44:17 INFO - 'SHLVL': '1', 07:44:17 INFO - 'TERM': 'linux', 07:44:17 INFO - 'TMOUT': '86400', 07:44:17 INFO - 'USER': 'cltbld', 07:44:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:17 INFO - '_': '/tools/buildbot/bin/python'} 07:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:17 INFO - Downloading/unpacking psutil>=0.7.1 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:44:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:19 INFO - Installing collected packages: psutil 07:44:19 INFO - Running setup.py install for psutil 07:44:19 INFO - building 'psutil._psutil_linux' extension 07:44:19 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 07:44:19 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 07:44:19 INFO - building 'psutil._psutil_posix' extension 07:44:19 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 07:44:19 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 07:44:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:20 INFO - Successfully installed psutil 07:44:20 INFO - Cleaning up... 07:44:20 INFO - Return code: 0 07:44:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:20 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 07:44:20 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 07:44:20 INFO - Using env: {'DISPLAY': ':0', 07:44:20 INFO - 'HOME': '/home/cltbld', 07:44:20 INFO - 'LANG': 'en_US.UTF-8', 07:44:20 INFO - 'LANGUAGE': 'en_US:en', 07:44:20 INFO - 'LOGNAME': 'cltbld', 07:44:20 INFO - 'MAIL': '/var/mail/cltbld', 07:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:20 INFO - 'MOZ_NO_REMOTE': '1', 07:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:20 INFO - 'NO_EM_RESTART': '1', 07:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:20 INFO - 'PWD': '/builds/slave/test', 07:44:20 INFO - 'SHELL': '/bin/bash', 07:44:20 INFO - 'SHLVL': '1', 07:44:20 INFO - 'TERM': 'linux', 07:44:20 INFO - 'TMOUT': '86400', 07:44:20 INFO - 'USER': 'cltbld', 07:44:20 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:20 INFO - '_': '/tools/buildbot/bin/python'} 07:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:44:20 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 07:44:20 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 07:44:20 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 07:44:20 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 07:44:20 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 07:44:20 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 07:44:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:44:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:44:22 INFO - Installing collected packages: mozsystemmonitor 07:44:22 INFO - Running setup.py install for mozsystemmonitor 07:44:22 INFO - Successfully installed mozsystemmonitor 07:44:22 INFO - Cleaning up... 07:44:22 INFO - Return code: 0 07:44:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:22 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:22 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 07:44:22 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 07:44:22 INFO - Using env: {'DISPLAY': ':0', 07:44:22 INFO - 'HOME': '/home/cltbld', 07:44:22 INFO - 'LANG': 'en_US.UTF-8', 07:44:22 INFO - 'LANGUAGE': 'en_US:en', 07:44:22 INFO - 'LOGNAME': 'cltbld', 07:44:22 INFO - 'MAIL': '/var/mail/cltbld', 07:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:22 INFO - 'MOZ_NO_REMOTE': '1', 07:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:22 INFO - 'NO_EM_RESTART': '1', 07:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:22 INFO - 'PWD': '/builds/slave/test', 07:44:22 INFO - 'SHELL': '/bin/bash', 07:44:22 INFO - 'SHLVL': '1', 07:44:22 INFO - 'TERM': 'linux', 07:44:22 INFO - 'TMOUT': '86400', 07:44:22 INFO - 'USER': 'cltbld', 07:44:22 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:22 INFO - '_': '/tools/buildbot/bin/python'} 07:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:22 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 07:44:22 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 07:44:22 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 07:44:22 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 07:44:22 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 07:44:22 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 07:44:24 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 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 07:44:24 INFO - Downloading docopt-0.6.1.tar.gz 07:44:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:24 INFO - Running setup.py install for blobuploader 07:44:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:24 INFO - Running setup.py install for requests 07:44:25 INFO - Running setup.py install for docopt 07:44:25 INFO - Successfully installed blobuploader requests docopt 07:44:25 INFO - Cleaning up... 07:44:25 INFO - Return code: 0 07:44:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:25 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')]} 07:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:25 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')]} 07:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:25 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:25 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 07:44:25 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 07:44:25 INFO - Using env: {'DISPLAY': ':0', 07:44:25 INFO - 'HOME': '/home/cltbld', 07:44:25 INFO - 'LANG': 'en_US.UTF-8', 07:44:25 INFO - 'LANGUAGE': 'en_US:en', 07:44:25 INFO - 'LOGNAME': 'cltbld', 07:44:25 INFO - 'MAIL': '/var/mail/cltbld', 07:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:25 INFO - 'MOZ_NO_REMOTE': '1', 07:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:25 INFO - 'NO_EM_RESTART': '1', 07:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:25 INFO - 'PWD': '/builds/slave/test', 07:44:25 INFO - 'SHELL': '/bin/bash', 07:44:25 INFO - 'SHLVL': '1', 07:44:25 INFO - 'TERM': 'linux', 07:44:25 INFO - 'TMOUT': '86400', 07:44:25 INFO - 'USER': 'cltbld', 07:44:25 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:25 INFO - '_': '/tools/buildbot/bin/python'} 07:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:25 INFO - Running setup.py (path:/tmp/pip-QunOoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:25 INFO - Running setup.py (path:/tmp/pip-kAhceS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:25 INFO - Running setup.py (path:/tmp/pip-vUn_IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:25 INFO - Running setup.py (path:/tmp/pip-APqgiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:25 INFO - Running setup.py (path:/tmp/pip-Un6rVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:25 INFO - Running setup.py (path:/tmp/pip-r7TvEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:26 INFO - Running setup.py (path:/tmp/pip-nFcfxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:26 INFO - Running setup.py (path:/tmp/pip-yCaPKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:26 INFO - Running setup.py (path:/tmp/pip-H9lQWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:26 INFO - Running setup.py (path:/tmp/pip-lLKbtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:26 INFO - Running setup.py (path:/tmp/pip-H4eQ4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:26 INFO - Running setup.py (path:/tmp/pip-5lelJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:26 INFO - Running setup.py (path:/tmp/pip-fgNfoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:26 INFO - Running setup.py (path:/tmp/pip-Lpl9k9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:26 INFO - Running setup.py (path:/tmp/pip-cuYLYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:26 INFO - Running setup.py (path:/tmp/pip-5_8EdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:26 INFO - Running setup.py (path:/tmp/pip-mdGsXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:26 INFO - Running setup.py install for manifestparser 07:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:26 INFO - Running setup.py install for mozcrash 07:44:27 INFO - Running setup.py install for mozdebug 07:44:27 INFO - Running setup.py install for mozdevice 07:44:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for mozfile 07:44:27 INFO - Running setup.py install for mozhttpd 07:44:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for mozinfo 07:44:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for mozInstall 07:44:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for mozleak 07:44:27 INFO - Running setup.py install for mozlog 07:44:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for moznetwork 07:44:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:27 INFO - Running setup.py install for mozprocess 07:44:28 INFO - Running setup.py install for mozprofile 07:44:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:28 INFO - Running setup.py install for mozrunner 07:44:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:28 INFO - Running setup.py install for mozscreenshot 07:44:28 INFO - Running setup.py install for moztest 07:44:28 INFO - Running setup.py install for mozversion 07:44:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:28 INFO - Cleaning up... 07:44:28 INFO - Return code: 0 07:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:28 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 07:44:28 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 07:44:28 INFO - Using env: {'DISPLAY': ':0', 07:44:28 INFO - 'HOME': '/home/cltbld', 07:44:28 INFO - 'LANG': 'en_US.UTF-8', 07:44:28 INFO - 'LANGUAGE': 'en_US:en', 07:44:28 INFO - 'LOGNAME': 'cltbld', 07:44:28 INFO - 'MAIL': '/var/mail/cltbld', 07:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:28 INFO - 'MOZ_NO_REMOTE': '1', 07:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:28 INFO - 'NO_EM_RESTART': '1', 07:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:28 INFO - 'PWD': '/builds/slave/test', 07:44:28 INFO - 'SHELL': '/bin/bash', 07:44:28 INFO - 'SHLVL': '1', 07:44:28 INFO - 'TERM': 'linux', 07:44:28 INFO - 'TMOUT': '86400', 07:44:28 INFO - 'USER': 'cltbld', 07:44:28 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:28 INFO - '_': '/tools/buildbot/bin/python'} 07:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:28 INFO - Running setup.py (path:/tmp/pip-rxAdym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:28 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)) 07:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:28 INFO - Running setup.py (path:/tmp/pip-RsT9ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:28 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)) 07:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:28 INFO - Running setup.py (path:/tmp/pip-f0LULp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:29 INFO - Running setup.py (path:/tmp/pip-iuze4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:29 INFO - Running setup.py (path:/tmp/pip-qDizKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:29 INFO - Running setup.py (path:/tmp/pip-c2IjJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:29 INFO - Running setup.py (path:/tmp/pip-6LSP1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:29 INFO - Running setup.py (path:/tmp/pip-aXbIah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:29 INFO - Running setup.py (path:/tmp/pip-t5zsXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:29 INFO - Running setup.py (path:/tmp/pip-9GUOiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:29 INFO - Running setup.py (path:/tmp/pip-KH1GDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:29 INFO - Running setup.py (path:/tmp/pip-lkzzBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:29 INFO - Running setup.py (path:/tmp/pip-bu1BPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:29 INFO - Running setup.py (path:/tmp/pip-brgP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:29 INFO - Running setup.py (path:/tmp/pip-Vjq0OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:29 INFO - Running setup.py (path:/tmp/pip-dVs1uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:29 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)) 07:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:29 INFO - Running setup.py (path:/tmp/pip-Il8bn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:30 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)) 07:44:30 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)) 07:44:30 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)) 07:44:30 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)) 07:44:30 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)) 07:44:30 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)) 07:44:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:31 INFO - Downloading blessings-1.5.1.tar.gz 07:44:31 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 07:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:31 INFO - Installing collected packages: blessings 07:44:31 INFO - Running setup.py install for blessings 07:44:31 INFO - Successfully installed blessings 07:44:31 INFO - Cleaning up... 07:44:31 INFO - Return code: 0 07:44:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:32 INFO - Reading from file tmpfile_stdout 07:44:32 INFO - Current package versions: 07:44:32 INFO - argparse == 1.2.1 07:44:32 INFO - blessings == 1.5.1 07:44:32 INFO - blobuploader == 1.2.4 07:44:32 INFO - docopt == 0.6.1 07:44:32 INFO - manifestparser == 1.1 07:44:32 INFO - mozInstall == 1.12 07:44:32 INFO - mozcrash == 0.16 07:44:32 INFO - mozdebug == 0.1 07:44:32 INFO - mozdevice == 0.47 07:44:32 INFO - mozfile == 1.2 07:44:32 INFO - mozhttpd == 0.7 07:44:32 INFO - mozinfo == 0.9 07:44:32 INFO - mozleak == 0.1 07:44:32 INFO - mozlog == 3.1 07:44:32 INFO - moznetwork == 0.27 07:44:32 INFO - mozprocess == 0.22 07:44:32 INFO - mozprofile == 0.27 07:44:32 INFO - mozrunner == 6.11 07:44:32 INFO - mozscreenshot == 0.1 07:44:32 INFO - mozsystemmonitor == 0.0 07:44:32 INFO - moztest == 0.7 07:44:32 INFO - mozversion == 1.4 07:44:32 INFO - psutil == 3.1.1 07:44:32 INFO - requests == 1.2.3 07:44:32 INFO - wsgiref == 0.1.2 07:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:32 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 07:44:32 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 07:44:32 INFO - Using env: {'DISPLAY': ':0', 07:44:32 INFO - 'HOME': '/home/cltbld', 07:44:32 INFO - 'LANG': 'en_US.UTF-8', 07:44:32 INFO - 'LANGUAGE': 'en_US:en', 07:44:32 INFO - 'LOGNAME': 'cltbld', 07:44:32 INFO - 'MAIL': '/var/mail/cltbld', 07:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:32 INFO - 'MOZ_NO_REMOTE': '1', 07:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:32 INFO - 'NO_EM_RESTART': '1', 07:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:32 INFO - 'PWD': '/builds/slave/test', 07:44:32 INFO - 'SHELL': '/bin/bash', 07:44:32 INFO - 'SHLVL': '1', 07:44:32 INFO - 'TERM': 'linux', 07:44:32 INFO - 'TMOUT': '86400', 07:44:32 INFO - 'USER': 'cltbld', 07:44:32 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:32 INFO - '_': '/tools/buildbot/bin/python'} 07:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 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)) 07:44:32 INFO - Cleaning up... 07:44:32 INFO - Return code: 0 07:44:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:44:32 INFO - Using env: {'DISPLAY': ':0', 07:44:32 INFO - 'HOME': '/home/cltbld', 07:44:32 INFO - 'LANG': 'en_US.UTF-8', 07:44:32 INFO - 'LANGUAGE': 'en_US:en', 07:44:32 INFO - 'LOGNAME': 'cltbld', 07:44:32 INFO - 'MAIL': '/var/mail/cltbld', 07:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:32 INFO - 'MOZ_NO_REMOTE': '1', 07:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:32 INFO - 'NO_EM_RESTART': '1', 07:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:32 INFO - 'PWD': '/builds/slave/test', 07:44:32 INFO - 'SHELL': '/bin/bash', 07:44:32 INFO - 'SHLVL': '1', 07:44:32 INFO - 'TERM': 'linux', 07:44:32 INFO - 'TMOUT': '86400', 07:44:32 INFO - 'USER': 'cltbld', 07:44:32 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:32 INFO - '_': '/tools/buildbot/bin/python'} 07:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:32 INFO - Downloading/unpacking jsonschema 07:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:34 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 07:44:34 INFO - Downloading/unpacking functools32 (from jsonschema) 07:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:34 INFO - warning: no files found matching '*.txt' 07:44:34 INFO - no previously-included directories found matching 'build' 07:44:34 INFO - no previously-included directories found matching 'dist' 07:44:34 INFO - no previously-included directories found matching '.git*' 07:44:34 INFO - Installing collected packages: jsonschema, functools32 07:44:34 INFO - Running setup.py install for functools32 07:44:34 INFO - warning: no files found matching '*.txt' 07:44:34 INFO - no previously-included directories found matching 'build' 07:44:34 INFO - no previously-included directories found matching 'dist' 07:44:34 INFO - no previously-included directories found matching '.git*' 07:44:34 INFO - Successfully installed jsonschema functools32 07:44:34 INFO - Cleaning up... 07:44:34 INFO - Return code: 0 07:44:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:34 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 0x7f69d3c7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b44240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', '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 07:44:34 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 07:44:34 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 07:44:34 INFO - Using env: {'DISPLAY': ':0', 07:44:34 INFO - 'HOME': '/home/cltbld', 07:44:34 INFO - 'LANG': 'en_US.UTF-8', 07:44:34 INFO - 'LANGUAGE': 'en_US:en', 07:44:34 INFO - 'LOGNAME': 'cltbld', 07:44:34 INFO - 'MAIL': '/var/mail/cltbld', 07:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:34 INFO - 'MOZ_NO_REMOTE': '1', 07:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:34 INFO - 'NO_EM_RESTART': '1', 07:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:34 INFO - 'PWD': '/builds/slave/test', 07:44:34 INFO - 'SHELL': '/bin/bash', 07:44:34 INFO - 'SHLVL': '1', 07:44:34 INFO - 'TERM': 'linux', 07:44:34 INFO - 'TMOUT': '86400', 07:44:34 INFO - 'USER': 'cltbld', 07:44:34 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:34 INFO - '_': '/tools/buildbot/bin/python'} 07:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:34 INFO - Downloading/unpacking flake8 07:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:36 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 07:44:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44:36 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 07:44:36 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 07:44:36 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 07:44:36 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 07:44:36 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 07:44:36 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 07:44:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:36 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 07:44:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:37 INFO - no previously-included directories found matching 'docs/_build' 07:44:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:37 INFO - Running setup.py install for pep8 07:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:37 INFO - no previously-included directories found matching 'docs/_build' 07:44:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:37 INFO - Cleaning up... 07:44:38 INFO - Return code: 0 07:44:38 INFO - Running post-action listener: _resource_record_post_action 07:44:38 INFO - Running post-action listener: _start_resource_monitoring 07:44:38 INFO - Starting resource monitoring. 07:44:38 INFO - ##### 07:44:38 INFO - ##### Running install step. 07:44:38 INFO - ##### 07:44:38 INFO - Running pre-action listener: _resource_record_pre_action 07:44:38 INFO - Running main action method: install 07:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:38 INFO - Reading from file tmpfile_stdout 07:44:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:38 INFO - Reading from file tmpfile_stdout 07:44:38 INFO - Output received: 07:44:38 INFO - Usage: mozinstall [options] installer 07:44:38 INFO - Options: 07:44:38 INFO - -h, --help show this help message and exit 07:44:38 INFO - -d DEST, --destination=DEST 07:44:38 INFO - Directory to install application into. [default: 07:44:38 INFO - "/builds/slave/test"] 07:44:38 INFO - --app=APP Application being installed. [default: firefox] 07:44:38 INFO - mkdir: /builds/slave/test/build/application 07:44:38 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'] 07:44:38 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 07:44:53 INFO - Reading from file tmpfile_stdout 07:44:53 INFO - Output received: 07:44:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:53 INFO - Running post-action listener: _resource_record_post_action 07:44:53 INFO - ##### 07:44:53 INFO - ##### Running run-tests step. 07:44:53 INFO - ##### 07:44:53 INFO - Running pre-action listener: _resource_record_pre_action 07:44:53 INFO - Running main action method: run_tests 07:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:53 INFO - Python 2.7.3 07:44:53 INFO - Return code: 0 07:44:53 INFO - grabbing minidump binary from tooltool 07:44:53 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')]} 07:44:53 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 0x2bd30b0>, '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 0x2bd3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:53 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 07:44:53 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 07:44:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:53 INFO - Return code: 0 07:44:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:44:54 INFO - Return code: 0 07:44:54 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/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 07:44:54 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/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 07:44:54 INFO - Using env: {'DISPLAY': ':0', 07:44:54 INFO - 'HOME': '/home/cltbld', 07:44:54 INFO - 'LANG': 'en_US.UTF-8', 07:44:54 INFO - 'LANGUAGE': 'en_US:en', 07:44:54 INFO - 'LOGNAME': 'cltbld', 07:44:54 INFO - 'MAIL': '/var/mail/cltbld', 07:44:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:54 INFO - 'MOZ_NO_REMOTE': '1', 07:44:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:54 INFO - 'NO_EM_RESTART': '1', 07:44:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:54 INFO - 'PWD': '/builds/slave/test', 07:44:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:54 INFO - 'SHELL': '/bin/bash', 07:44:54 INFO - 'SHLVL': '1', 07:44:54 INFO - 'TERM': 'linux', 07:44:54 INFO - 'TMOUT': '86400', 07:44:54 INFO - 'USER': 'cltbld', 07:44:54 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743', 07:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:54 INFO - '_': '/tools/buildbot/bin/python'} 07:44:54 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/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 07:44:54 INFO - mozversion INFO | application_buildid: 20151218062559 07:44:54 INFO - mozversion INFO | application_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 07:44:54 INFO - mozversion INFO | application_display_name: Nightly 07:44:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:54 INFO - mozversion INFO | application_name: Firefox 07:44:54 INFO - mozversion INFO | application_remotingname: firefox 07:44:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:44:54 INFO - mozversion INFO | application_vendor: Mozilla 07:44:54 INFO - mozversion INFO | application_version: 46.0a1 07:44:54 INFO - mozversion INFO | platform_buildid: 20151218062559 07:44:54 INFO - mozversion INFO | platform_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 07:44:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:44:54 INFO - mozversion INFO | platform_version: 46.0a1 07:44:54 INFO - 2015-12-18 07:44:54,948 DEBUG : using testdate: 1450453494 07:44:54 INFO - 2015-12-18 07:44:54,948 DEBUG : actual date: 1450453494 07:44:54 INFO - 2015-12-18 07:44:54,957 INFO : starting webserver on 'localhost:39654' 07:44:54 INFO - 2015-12-18 07:44:54,958 INFO : Starting test suite talos-linux64-ix-036.e 07:44:54 INFO - 2015-12-18 07:44:54,958 INFO : Starting test dromaeo_css 07:44:54 INFO - 2015-12-18 07:44:54,958 DEBUG : operating with platform_type : linux_ 07:44:54 INFO - 2015-12-18 07:44:54,959 INFO : Initialising browser for dromaeo_css test... 07:44:54 INFO - 2015-12-18 07:44:54,973 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYMFESC/profile http://localhost:39654/getInfo.html 07:45:00 INFO - 2015-12-18 07:45:00,546 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:45:00 INFO - 2015-12-18 07:45:00,546 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:45:00 INFO - 2015-12-18 07:45:00,546 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:45:00 INFO - 2015-12-18 07:45:00,546 DEBUG : BROWSER_OUTPUT: __metrics 07:45:00 INFO - 2015-12-18 07:45:00,695 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] 07:45:01 INFO - 2015-12-18 07:45:01,655 INFO : Browser initialized. 07:45:01 INFO - 2015-12-18 07:45:01,655 INFO : Running cycle 1/1 for dromaeo_css test... 07:45:01 INFO - 2015-12-18 07:45:01,656 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYMFESC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:45:13 INFO - 2015-12-18 07:45:13,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 151060480 07:45:13 INFO - 2015-12-18 07:45:13,685 DEBUG : BROWSER_OUTPUT: 07:46:03 INFO - 2015-12-18 07:46:03,330 DEBUG : BROWSER_OUTPUT: 1450453563327 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] 07:48:15 INFO - 2015-12-18 07:48:15,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39654/tests/dromaeo/cssquery-ext.html) 07:48:16 INFO - 2015-12-18 07:48:16,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 154624000 07:48:16 INFO - 2015-12-18 07:48:16,621 DEBUG : BROWSER_OUTPUT: 07:51:18 INFO - 2015-12-18 07:51:18,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-ext.html (next: http://localhost:39654/tests/dromaeo/cssquery-jquery.html) 07:51:19 INFO - 2015-12-18 07:51:19,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 151965696 07:51:19 INFO - 2015-12-18 07:51:19,267 DEBUG : BROWSER_OUTPUT: 07:54:21 INFO - 2015-12-18 07:54:21,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39654/tests/dromaeo/cssquery-mootools.html) 07:54:21 INFO - 2015-12-18 07:54:21,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 152547328 07:54:21 INFO - 2015-12-18 07:54:21,677 DEBUG : BROWSER_OUTPUT: 07:57:23 INFO - 2015-12-18 07:57:23,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39654/tests/dromaeo/cssquery-prototype.html) 07:57:24 INFO - 2015-12-18 07:57:24,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 152248320 07:57:24 INFO - 2015-12-18 07:57:24,072 DEBUG : BROWSER_OUTPUT: 08:00:26 INFO - 2015-12-18 08:00:26,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39654/tests/dromaeo/cssquery-yui.html) 08:00:27 INFO - 2015-12-18 08:00:27,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 151515136 08:00:27 INFO - 2015-12-18 08:00:27,337 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/dromaeo/cssquery-yui.html (next: http://localhost:39654/tests/dromaeo/cssquery-dojo.html) 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 155705344 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:03:29 INFO - 2015-12-18 08:03:29,854 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2676.90630827921;2716.7011628720825;2748.6976432592423;2762.6961034286214;2772.6950035496097;4620.353150558924;4716.976415117928;4795.68828026178;4806.375171227744;4871.537203965627;4678.134545109148;4773.474917759052;4806.567408933195;4878.365812444386;4905.3132561441425;4407.9779601101945;4428.269335559637;4551.795169217393;4566.634669226454;4609.1473077480605;4298.742075475466;4470.664700147486;4482.350059241408;4511.233090374644;4609.516000819916;4261.531231564525;4280.293751530994;4356.6514678825615;4380.561943805626;4399.5160532341415;4455.131249406367;4483.618892394151;4485.327200919855;4511.052678937427;4545.863624091249;4178.289690752579;4298.398224248608;4454.48773391061;4476.731396116244;4501.639868810487;4620.145273124449;4714.363560919266;4749.240121580565;4773.284007398918;4795.232762757942;5159.045576568347;5164.096283150434;5167.0957582422925;5181.948180518184;5245.291885595434;4918.434380046305;5042.117629414838;5127;5129.431934850417;5202.141646628302;4810.182269014276;4828.734419606955;4828.975855120737;4830.396200474941;4860.125177468019;5311.442298558673;5312.335958005249;5314.7874085036165;5319.148936170194;5334.333208348957;4756.571908528249;4905.386826646669;4986.975065124651;5092.770825312796;5139.7687104080405;5198.896022079537;5213.322268105122;5224.7126408047925;5230.084735171406;5233.450487698813;5139.254808052811;5141.665791723526;5154.510321519525;5170.534651881274;5182.222666600041;4851.878703032382;4954.925676114861;5020.196768517093;5109.38687357512;5127.07712611726;4244.193603215379;4299.204647140289;4320.395144679747;4320.740755554677;4356.150550642595;3593.7664051836546;3811.4092315691114;3816.637419445148;3842.500474938296;3850.6919446444217;4294.377315289328;4327.069680018811;4429.579189976947;4436.800343984464;4473.2842745160615;5134.05020071288;5135.178371460548;5146.176611742103;5152.149895267314;5171.3535808024;4190.958090419057;4290.528041915387;4422.314541246112;4424.690271680952;4458.821647134143;4499.707519011254;4574.839880604163;4586.610138138229;4607.470140933769;4616.0767846430845;4804.039192161582;4930.20433941529;4936.975315123402;4959.231319145538;4963.8262660806695;4929.852104436873;5049.141645920129;5130.51260130287;5243.397009343974;5256.78972841082;4899.191633380595;4899.510048995072;4899.730514821719;4925.802967881388;4928.19680941061;5118.00198961199;5125.92311115341;5132.999065182254;5136.589072874236;5172.275881376686;4935.481774413634;5053.292539044463;5163.638545301793;5187.144121220107;5283.920741188962;5099.847004589868;5100.897982040413;5103.515166059218;5115.667481613683;5115.718635475085;5073.492650734897;5086.64393492452;5092.108880945746;5122;5139.717315547681;4636.235021221461;4725.031368569504;4756.643251756202;4823.6382271329085;4835.468098509091;5005.149124648746;5068.49315068505;5071;5079.949200507947;5110.747866772665;4715.056988602362;4941.160002799461;4959.975200123977;4968.677035992649;5032.949670503394 08:03:29 INFO - 2015-12-18 08:03:29,856 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.9663420194788;570.6034306157221;578.8683124491617;579.8347470970772;584.4827327814883;34811;35575.4663680045;35629.10927226821;35795.463068054;35820;40820.79589602048;40834.183316333656;41023.794881025555;41155.794221028926;41428.17143657125;7701.3453856422275;7836;7884.684612615517;7887.96056019722;7928.960355198216;7768.766936991871;7881.369490440751;7884.684612615489;7884.684612615489;7930.167332430098;7876.133625301212;7940.166282540336;7940.245676660708;7944.880826787603;7990.560519171443;7834.882476762853;7838.490498117632;7875;7879.842403151905;7896.447248692594;7880.448368614199;7974.60126993648;7980.162082981262;7980.321672657773;7989.161138080534;36634.63365366365;37138;37354.626453735385;37497.25005499902;37675.24649507022;2348.2076446538886;2777.388974425623;2887.4946884295164;3024.8638811253327;3550.378683730363;26740.46519069608;26804.19587412381;27073.593896091377;27105.45789084227;27464.588031179348;3257.299680568689;3261.445554255782;3275.7870738401925;3306.6528014558367;3390.0677313738674;174004;175421.12289438598;175557.12221438938;176325;176400;51413.7429312851;51904.22143667848;53324.46675533272;55280.44719552834;55758.44241557614;54189.1871621926;54241.45758542364;54422;54597;54598.18102728462;13502.662433439242;13539.526116585872;13657.863421365857;13663.726725465634;13686.726265474636;10230.59077636901;10241.692749217535;10246.795064098676;10275.691729248134;10291.588336466457;18874.716879246822;19181.904090479456;19273.22907083701;19304.420867374;19335.903320483307;7184.712611495586;7432.067662407813;7484.625768711543;7514.173440921494;7558.735444259424;921.1525396635112;989.618996686281;1007.4660429972126;1016.187050359724;1054.7046826888484;25921.740782591933;26068.34829129287;26170.476590468083;26403.339916502242;26544.469110618065;988.0564061321421;994.3238597753452;1009.9293049486465;1070.5343175718588;1084.6203828660064;13892.305384730724;13932.860671393359;14097.436102555988;14394.784078238834;14482.420703171965;192353;192841;193811;194631;196743;42234.57765422307;42318.15363692709;42677.35983960243;42696.78651606722;42700;1219.4878151176526;1223.8592561855323;1235.123062625528;1239.4980033086433;1239.7706424311532;26225.606615901157;26508.734912650627;26614.733852661226;26676.19971400861;26786.732132678422;40847.79576102101;41178.38232426576;41183.58816411797;41226.38160427656;41331.380029300184;248712;251278;251414;252986;253543;28064.158075257776;29024.854875725487;29265.85367073151;29377.853110734308;29379.118626441243;33299.83350083234;33389.49915751217;33482.162945926546;33843.492347614316;33962.490562641084;29187.562186566793;29395.7060429393;29692.25769355697;29849.70150298469;29970.550441742955;30951.226219344695;30983;31375;31785;31813.5227971576;35803;36106.63893361033;36396;36425;36742.08144796402;27340.589891151252;27417.58873616937;29001.274968125123;29722;30069.3986120272;23128;25044;25620.487590247718;25724.09965651193;25843.741562584135 08:03:29 INFO - 2015-12-18 08:03:29,857 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.2764405688944;319.1367351314694;324.1862924060607;326.6488524835802;336.2400973799213;15072.773908391382;15464.226788660564;15720.135392553419;15970.361185552563;16609;14664.706705865876;14734.18961957092;14803.037802542854;14813.777793333109;15089.92455037726;4432.844850430236;5020.297158397827;5026.271190677349;5028.8239911603105;5032.798688052473;4987.451380348177;5028.698278103326;5030.7987680492915;5036.697798132123;5040;4609.36367589506;4960.900781984358;6083.665398403086;6303.275123360826;6311.747530098791;5989.251343582052;6205.255369355661;6249.468795152417;6260.342664020281;6264.592801467936;5664.26364572603;5943.851403714899;5960.850978725523;5974.193483879708;5987.461128498412;20831.37505874826;21116.260930867345;21300.25449109274;21326.893365533073;21420.82185479798;1825.4249911277905;1852.6665200263947;1911.4743445552585;1913.0721600023978;2028.0974966140075;13400.396982135828;13479.528216512474;13530.86469135306;13573.660658483519;13807.309634518233;1838.6506563752978;1862.32956135791;1889.7921228664836;1910.8949007804704;1919.3378284491966;48188.518114818755;57013;60299.397006029816;64849.3515064848;65109;14256.643583910485;14510.201938893462;14695.501764699813;15227.847721522865;15477.5356739298;23012.539749205258;23037.654435183485;23091.307260782203;23228.883855580614;23296.068157273858;8799.560021998874;8865.423747456394;8896.510691911877;8993.190612844875;9026.729198124067;7561.432892533082;7619.961900190464;7620.771376858703;7659.310662040443;7671.194524574951;7504.249575042452;7552.697892084365;7604.505707129019;7644.426667999922;7647.502912310682;1737.296394960018;1781.8841775284566;3018.920700885085;3156.6843315668248;3195.952060719091;833.3999520345342;839.5340585974842;904.7104926423482;925.8796356473615;946.9394278408089;13703.931480342535;14040.087394319336;15288;15492.225388730518;16037.919810400874;864.8616221404545;868.9087645797226;901.9323550733722;909.0909090909091;933.2906990687127;5600.131979543177;5667.4332566743;5709.514691251207;5740;5809.128630705428;484159;486107;489143;491237;495871;71808.64095679489;74073.25926740664;74702;74900;75784.62107689427;438.82885674586936;443.0585006860486;444.2048732768373;445.08757048051365;445.16531503431065;9996.650117245861;10080.495975201356;13765;14363.56909292723;14705.117692938458;33782.8310858454;34177.31645367129;34233.82883085569;34410.65589344175;35092.473612895315;40206.19587608173;41245.587544125374;42783.7860810694;43522.78238608786;43542.34686479642;8508.27679647237;8649.524276164871;8720.91279087201;8763.518006509703;8795.956020219857;13458.327083645583;14815.111093334435;15752.291146898187;16073.91963040224;16097.436589719304;13442.596722098353;13660.248686322348;14357.643653783694;14416.279186040865;14509.129452232899;13604.93197534006;13952.232627205602;14045;14113.29433528299;14321.57035288943;13270.867291326964;13603.93198034043;13962.511312104027;14051.156930584199;14475.493357732428;8668.783280417787;9135.680251191176;9240.537973101453;9313.674021409219;9370.906290937277;9549.47477888695;9580.473073980718;9604.66383676568;13100.934495327463;14582.125072495684 08:03:29 INFO - 2015-12-18 08:03:29,860 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.2841835918766;1612.2664187794555;1623.9756403653948;1647.31636370906;1682.4363838114232;5927.703614819253;6178.19683441152;6918.411934985526;7399.075115610549;7436.070491188595;6874.82812929677;7111.928880711192;7115;7132.215456299816;7214.134303883528;2059.3718915730697;2082.073477302601;2087.728595282611;2091.5398612305266;2100.516881117336;2059.4233614587865;2087.1338394566237;2098.6012657595006;2100.1389430333566;2108.378028481594;2034.7151398804178;2048.3650068478746;2073.2018173003426;2074.0770357191054;2087.6972838938345;2052.0663098290242;2055.825254853339;2069.730934978458;2072.533679922013;2078.9480262993548;2023.5244717491526;2046.3451695457459;2047.8156965873143;2051.05651400356;2055.8663686860305;7262.673179706873;7285.089363829521;7312.451566132561;7327.74352897646;7329.926700732978;4241.724287921275;4315.029118448356;4317.15815415994;4324.783760811947;4329.177456283328;2741.931451713703;2773.4314465534517;2808.5365914624062;2809.9157025289273;2810.873510692024;866.8353012927587;880.5157163560017;883.3419102768479;887.0597167002998;897.2328658996529;9892.752681182956;9943.850842237372;9950.402975821475;9966.103050725396;9999.550020249106;3868.2263547290654;3885.9611403886165;3933.1543718100174;3937.2125574885135;3960.346542820402;8543.786405339792;8605.569721513899;8622.956885215533;8633.827323453621;8655.09121542229;4258.212230737324;4264.87205383839;4269.658427325807;4270.274053410928;4299.720518166309;3306.8015919044933;3415.2315728960784;3803;3843.3466310726685;3893.357595996629;3343.648916863743;3346.481295399217;3353.094664440587;3354.714849237842;3404.9659503405146;1111.155521803419;1129.4804389980536;1131.8132508136066;1135.3074624479061;1141.0757286597882;1181.7282025134268;1187.8871507206802;1199.9680274963525;1208.667616405478;1212.89690376319;6552.213734351908;6606.570572912745;6631.1379520662;6655.43428808547;6661.966690166518;419.66217195157583;420.88846455689264;422.53099060043326;422.83509431321806;423.0650262918922;5402.729863506809;5431;5433.320834895638;5446.945530544644;5468.91796623051;8561.82876342482;8572.357073219533;8722.433041852259;8797.252233560219;8808.25129863956;8571.185737354941;8650;8661.480311181349;8670.609822558;8688.870446841996;6672.5329226953645;6855.868781650972;6868.862622747517;6976.337247961435;6986.790396288119;6961.269066747918;6976.686049127903;6988.895166572607;7001.859962800613;7002.509824312249;7818.804529886798;7863.488873223222;7952.6421311042295;8004.399670024888;8125.593720314079;7752.0697516298405;7960.522368657899;7965.92034079675;8002.399820013638;8112.918870811216;5500.532454741232;5526.226328313959;6332.778352757631;6333.96833015832;6386.16979792624;6887.070245516791;6893.414059804973;6903.102596662603;6903.275156108536;6910.654467276717;6449.193850768654;6580.177477815273;6611.239707433707;6696.19645642526;6735.932640673531;6071.453569178619;6527.184101987252;6539.6076235424125;6656.966715166393;6672.966635166793;6613.338666133348;6624.304448032887;6633.60198388079;6695.296993815774;6721.428678562182;5946.494547963472;5991.67045812467;5993.0710739835395;5998.190244317136;6009.90985135232;6101.786437474667;6112;6150.846228844314;6155.384461553809;6161.568690191643 08:03:29 INFO - 2015-12-18 08:03:29,862 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.71167899618877;302.4118090314338;303.9255382431304;304.2910019654206;304.894811290105;5520.14437762147;5550.111982082867;5597.2723545939025;5608.551315894729;5721.628094173876;5549.611527193088;5561.749721262543;5589;5597.468240517154;5616.297962754656;4099.754014759109;4271.722338048033;4272.935905961397;4277.657787377002;4282.507511636163;4224.683148763855;4262.46719160105;4279.443672322609;4281.44341235639;4293.592108749664;4222.408862759216;4224.915501689964;4232;4233;4240.830366785325;4202.159568086379;4214.494260688737;4227.725197862144;4230.936535951963;4243.618074373321;3683.060819491013;3684.207895302496;3684.9447258291148;3695.5195824542907;3699.9445008324897;5224.947750522484;5289.206619007141;5389.8113566025;5407.756650950677;5416.431274716177;4845.491223421561;4849.781759820817;4851.8301859435105;4865.70805751656;4866.537678920497;5863.9706801466145;5864.413558644102;5867.677277749722;5869.383714709979;5871.6183448075735;3852.8073596320073;3974.8608798691907;3976.920461590781;3984.4222587724907;3996.580359062286;6110.6944652767625;6182.69086545671;6195.535334849859;6202.62784232943;6204.720787564571;4075.3275709508193;4078.6737061035046;4095;4101.52832424269;4109.3425051991535;4151.626353628188;4155.58444155582;4158.189153115174;4163.146554956287;4174.645155161846;4733.834315798999;4819.759012049383;4821.276808478686;4821.614270858323;4833.3958255218095;5824.708764561755;5838.153467747153;5856.619319744203;5864.648121112747;5876.764929402776;1450.4343306110625;1466.486729644637;1476.402057166849;1476.6234610174552;1478.2756449339747;948.4546385828177;971.820213260549;975.7463059604554;992.5384696116196;1003.5383723487278;5064.924026139537;5092.668976516515;5096.031753966735;5106.872328191825;5114.258432527263;6085.2393450818645;6095.6952152392205;6099.8475038123515;6101.115338275925;6130.540209484307;5102.413222479462;5110.412302585176;5110.48895110486;5112.412072611697;5117.948820511747;3213.662565430643;3260.413125637408;3286;3309.851056702454;3316.6683331667123;5576.637518561281;5622.690752008597;5666.858328541819;5684.317881854204;5720.742566584514;6250.656213908188;6323.114763933053;6339.144215530844;6365;6376.171097757262;5710.428957104339;5733.31200255972;5747.712614369265;5750.7987220447085;5760.913586296125;6091.786787462417;6117.510599151969;6155.415235552616;6160.414760597736;6168.321484636776;5844.503217226414;6027.457528822427;6028.909566356596;6032.245969253843;6037.577369584087;5750.309962804323;5760.539156867357;5770.769169233184;5773.422657734193;5775.537956963517;4222.619964203236;4274.081072569413;4274.422952901318;4277.230098582285;4282.550332215073;5891.23413956183;6054.788082417094;6069.241344831896;6072.05883088122;6084.939150608614;5818.156367326798;5834.474897259097;5836.066229403275;5838.241028666416;5852.473277405054;5814.069748840166;5819.79630712923;5847.532197424281;5852.590318677822;5853.590248682552;5578.721063946868;5705.286839145107;5718.656880587178;5736.741846616829;5750.769969201185;5868.618539794899;5876.794312199053;5896.587238893237;5902.852428689145;5914.970425147847;5758.683272420057;5762.625429347079;5766.682832444256;5769.134629805562;5780.335261444988 08:03:29 INFO - 2015-12-18 08:03:29,865 DEBUG : BROWSER_OUTPUT: |5;yui.html;623.4202191961475;725.2711025419453;729.9963500182497;732.7508647059996;747.9925200747991;9592.664256751006;9818.705438836829;9839.262055345851;9865.506724663765;9886.950565247182;10875.945620271888;12729.93635031826;13025.60923172304;13078.869211307883;13131;621.0497938154631;624.3662682377368;767.7696690992694;774.8798936164903;789.889415481833;774.8837674348837;775.255754475704;776.6311002273903;783.6747749683902;784.6861255497818;823.4071468542639;831.2394159344193;831.5883637599396;834.1158372125566;835.761807884753;815.7634286057037;817.2032268538187;818.8730746734266;819.2422009641087;820.216693058128;610.2493932463095;613.1844646619985;613.3130893399376;614.6527212125135;614.8155553334027;11032.779344413148;11042.33745975244;11146.498407571678;11253.54985800567;11295.830562541569;10069.949650251776;10402.167826573856;10506.422146781924;10871.347719136877;11229.10167186623;9471.715848524555;9607.13535781783;9609.951950240204;9644.03559644037;9692.660756873476;3134.1067795678123;3170.4291739022574;3192.952105718416;3199.568058312145;3208.0536241808722;39230.41154382686;39513;39612;39659.8017009916;39706.20587588261;7390.076240469942;7408.703651853865;7459.552426854406;7538;7574.545527268271;15738.134402607737;15750.9212453937;15774.842251577338;15777.053376797428;15779.368825247091;6264.968675156595;6429.935700643027;6437.485001199892;6460.773872914426;6541.738330466728;3476.913077173091;3504.9474257886154;3530.470429435605;3549.716022718176;3551.6093229744706;2427.6965379327585;2430.4652976345174;2444.9511009780063;2449.1428000200144;2450.742672019448;454.7771591919935;455.42388878069266;455.8905862592954;459.69660024383745;463.1385622741698;499.086671391353;547.8958997790407;566.7194738604417;571.0577547047322;584.1529781816383;7370.484066115428;7385.7045718170675;7390.445716571278;7438.776836694908;7502.512336698097;478.909007288614;481.5016457966058;514.9407818100891;518.4090137243545;552.7871769368822;3306.8511916963794;3410.3179364127272;3476.3742526344995;3494.580650321978;3523.524324216249;48964.75517622389;49362.75318623384;49556.25665615019;49606.75196624066;51840.22239666408;41414.37878431826;42112;42337.57662423398;42455.57544424578;42632.78683606562;38852;39645.60354396419;39796.99999999942;39941.40087898684;40247.39628905569;7575.659095340833;7616.8476630465975;7652.579108149105;7742.806429839299;7986.720464783704;30584;31779.36441271208;32353.51469727909;32740.34519309648;32932.50601241031;37640.81179594085;37710.43434348432;38683.80658096691;38738.6126138735;38801;9311;9494.28792840526;9499.572519236513;9752.9024709752;10069.647562335284;10838.132949363875;10922.563097476012;10963.506642201279;11052.613158539734;11293.322400655987;9738.843599258942;9830.311878168459;10072.446015469219;10223.028812262823;10510.737231568966;10206.183505319408;10314.319437418875;10399.428031458343;10512.842307365549;10846.67459976202;9398.389104708445;9990.600375984879;10049;10068.194544436281;10282.845757313797;8304.833903321778;8536.871946920925;8651.991095721;9000.324975626985;9156.954215228881;8619.913800862161;8675.783105422415;8735.781605459915;8821.558922053744;8925.375223734276 08:03:29 INFO - 2015-12-18 08:03:29,865 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:03:29 INFO - 2015-12-18 08:03:29,865 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,330 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454609853__endTimestamp 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:03:29 INFO - 2015-12-18 08:03:29,866 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4750.19 Median:4878.37 stddev:504.34 (10.3%) stddev-sans-first:478.95 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: Values: 2676.9 2716.7 2748.7 2762.7 2772.7 4620.4 4717.0 4795.7 4806.4 4871.5 4678.1 4773.5 4806.6 4878.4 4905.3 4408.0 4428.3 4551.8 4566.6 4609.1 4298.7 4470.7 4482.4 4511.2 4609.5 4261.5 4280.3 4356.7 4380.6 4399.5 4455.1 4483.6 4485.3 4511.1 4545.9 4178.3 4298.4 4454.5 4476.7 4501.6 4620.1 4714.4 4749.2 4773.3 4795.2 5159.0 5164.1 5167.1 5181.9 5245.3 4918.4 5042.1 5127.0 5129.4 5202.1 4810.2 4828.7 4829.0 4830.4 4860.1 5311.4 5312.3 5314.8 5319.1 5334.3 4756.6 4905.4 4987.0 5092.8 5139.8 5198.9 5213.3 5224.7 5230.1 5233.5 5139.3 5141.7 5154.5 5170.5 5182.2 4851.9 4954.9 5020.2 5109.4 5127.1 4244.2 4299.2 4320.4 4320.7 4356.2 3593.8 3811.4 3816.6 3842.5 3850.7 4294.4 4327.1 4429.6 4436.8 4473.3 5134.1 5135.2 5146.2 5152.1 5171.4 4191.0 4290.5 4422.3 4424.7 4458.8 4499.7 4574.8 4586.6 4607.5 4616.1 4804.0 4930.2 4937.0 4959.2 4963.8 4929.9 5049.1 5130.5 5243.4 5256.8 4899.2 4899.5 4899.7 4925.8 4928.2 5118.0 5125.9 5133.0 5136.6 5172.3 4935.5 5053.3 5163.6 5187.1 5283.9 5099.8 5100.9 5103.5 5115.7 5115.7 5073.5 5086.6 5092.1 5122.0 5139.7 4636.2 4725.0 4756.6 4823.6 4835.5 5005.1 5068.5 5071.0 5079.9 5110.7 4715.1 4941.2 4960.0 4968.7 5032.9 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37065.90 Median:3259.37 stddev:54406.53 (1669.2%) stddev-sans-first:54490.11 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: Values: 561.0 570.6 578.9 579.8 584.5 34811.0 35575.5 35629.1 35795.5 35820.0 40820.8 40834.2 41023.8 41155.8 41428.2 7701.3 7836.0 7884.7 7888.0 7929.0 7768.8 7881.4 7884.7 7884.7 7930.2 7876.1 7940.2 7940.2 7944.9 7990.6 7834.9 7838.5 7875.0 7879.8 7896.4 7880.4 7974.6 7980.2 7980.3 7989.2 36634.6 37138.0 37354.6 37497.3 37675.2 2348.2 2777.4 2887.5 3024.9 3550.4 26740.5 26804.2 27073.6 27105.5 27464.6 3257.3 3261.4 3275.8 3306.7 3390.1 174004.0 175421.1 175557.1 176325.0 176400.0 51413.7 51904.2 53324.5 55280.4 55758.4 54189.2 54241.5 54422.0 54597.0 54598.2 13502.7 13539.5 13657.9 13663.7 13686.7 10230.6 10241.7 10246.8 10275.7 10291.6 18874.7 19181.9 19273.2 19304.4 19335.9 7184.7 7432.1 7484.6 7514.2 7558.7 921.2 989.6 1007.5 1016.2 1054.7 25921.7 26068.3 26170.5 26403.3 26544.5 988.1 994.3 1009.9 1070.5 1084.6 13892.3 13932.9 14097.4 14394.8 14482.4 192353.0 192841.0 193811.0 194631.0 196743.0 42234.6 42318.2 42677.4 42696.8 42700.0 1219.5 1223.9 1235.1 1239.5 1239.8 26225.6 26508.7 26614.7 26676.2 26786.7 40847.8 41178.4 41183.6 41226.4 41331.4 248712.0 251278.0 251414.0 252986.0 253543.0 28064.2 29024.9 29265.9 29377.9 29379.1 33299.8 33389.5 33482.2 33843.5 33962.5 29187.6 29395.7 29692.3 29849.7 29970.6 30951.2 30983.0 31375.0 31785.0 31813.5 35803.0 36106.6 36396.0 36425.0 36742.1 27340.6 27417.6 29001.3 29722.0 30069.4 23128.0 25044.0 25620.5 25724.1 25843.7 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,867 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27300.47 Median:21990.59 stddev:79868.99 (363.2%) stddev-sans-first:80067.34 08:03:29 INFO - 2015-12-18 08:03:29,868 DEBUG : BROWSER_OUTPUT: Values: 315.3 319.1 324.2 326.6 336.2 15072.8 15464.2 15720.1 15970.4 16609.0 14664.7 14734.2 14803.0 14813.8 15089.9 4432.8 5020.3 5026.3 5028.8 5032.8 4987.5 5028.7 5030.8 5036.7 5040.0 4609.4 4960.9 6083.7 6303.3 6311.7 5989.3 6205.3 6249.5 6260.3 6264.6 5664.3 5943.9 5960.9 5974.2 5987.5 20831.4 21116.3 21300.3 21326.9 21420.8 1825.4 1852.7 1911.5 1913.1 2028.1 13400.4 13479.5 13530.9 13573.7 13807.3 1838.7 1862.3 1889.8 1910.9 1919.3 48188.5 57013.0 60299.4 64849.4 65109.0 14256.6 14510.2 14695.5 15227.8 15477.5 23012.5 23037.7 23091.3 23228.9 23296.1 8799.6 8865.4 8896.5 8993.2 9026.7 7561.4 7620.0 7620.8 7659.3 7671.2 7504.2 7552.7 7604.5 7644.4 7647.5 1737.3 1781.9 3018.9 3156.7 3196.0 833.4 839.5 904.7 925.9 946.9 13703.9 14040.1 15288.0 15492.2 16037.9 864.9 868.9 901.9 909.1 933.3 5600.1 5667.4 5709.5 5740.0 5809.1 484159.0 486107.0 489143.0 491237.0 495871.0 71808.6 74073.3 74702.0 74900.0 75784.6 438.8 443.1 444.2 445.1 445.2 9996.7 10080.5 13765.0 14363.6 14705.1 33782.8 34177.3 34233.8 34410.7 35092.5 40206.2 41245.6 42783.8 43522.8 43542.3 8508.3 8649.5 8720.9 8763.5 8796.0 13458.3 14815.1 15752.3 16073.9 16097.4 13442.6 13660.2 14357.6 14416.3 14509.1 13604.9 13952.2 14045.0 14113.3 14321.6 13270.9 13603.9 13962.5 14051.2 14475.5 8668.8 9135.7 9240.5 9313.7 9370.9 9549.5 9580.5 9604.7 13100.9 14582.1 08:03:29 INFO - 2015-12-18 08:03:29,868 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5044.24 Median:6131.42 stddev:2661.34 (43.4%) stddev-sans-first:2655.41 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: Values: 1491.3 1612.3 1624.0 1647.3 1682.4 5927.7 6178.2 6918.4 7399.1 7436.1 6874.8 7111.9 7115.0 7132.2 7214.1 2059.4 2082.1 2087.7 2091.5 2100.5 2059.4 2087.1 2098.6 2100.1 2108.4 2034.7 2048.4 2073.2 2074.1 2087.7 2052.1 2055.8 2069.7 2072.5 2078.9 2023.5 2046.3 2047.8 2051.1 2055.9 7262.7 7285.1 7312.5 7327.7 7329.9 4241.7 4315.0 4317.2 4324.8 4329.2 2741.9 2773.4 2808.5 2809.9 2810.9 866.8 880.5 883.3 887.1 897.2 9892.8 9943.9 9950.4 9966.1 9999.6 3868.2 3886.0 3933.2 3937.2 3960.3 8543.8 8605.6 8623.0 8633.8 8655.1 4258.2 4264.9 4269.7 4270.3 4299.7 3306.8 3415.2 3803.0 3843.3 3893.4 3343.6 3346.5 3353.1 3354.7 3405.0 1111.2 1129.5 1131.8 1135.3 1141.1 1181.7 1187.9 1200.0 1208.7 1212.9 6552.2 6606.6 6631.1 6655.4 6662.0 419.7 420.9 422.5 422.8 423.1 5402.7 5431.0 5433.3 5446.9 5468.9 8561.8 8572.4 8722.4 8797.3 8808.3 8571.2 8650.0 8661.5 8670.6 8688.9 6672.5 6855.9 6868.9 6976.3 6986.8 6961.3 6976.7 6988.9 7001.9 7002.5 7818.8 7863.5 7952.6 8004.4 8125.6 7752.1 7960.5 7965.9 8002.4 8112.9 5500.5 5526.2 6332.8 6334.0 6386.2 6887.1 6893.4 6903.1 6903.3 6910.7 6449.2 6580.2 6611.2 6696.2 6735.9 6071.5 6527.2 6539.6 6657.0 6673.0 6613.3 6624.3 6633.6 6695.3 6721.4 5946.5 5991.7 5993.1 5998.2 6009.9 6101.8 6112.0 6150.8 6155.4 6161.6 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4840.08 Median:5577.68 stddev:1446.71 (25.9%) stddev-sans-first:1409.93 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: Values: 292.7 302.4 303.9 304.3 304.9 5520.1 5550.1 5597.3 5608.6 5721.6 5549.6 5561.7 5589.0 5597.5 5616.3 4099.8 4271.7 4272.9 4277.7 4282.5 4224.7 4262.5 4279.4 4281.4 4293.6 4222.4 4224.9 4232.0 4233.0 4240.8 4202.2 4214.5 4227.7 4230.9 4243.6 3683.1 3684.2 3684.9 3695.5 3699.9 5224.9 5289.2 5389.8 5407.8 5416.4 4845.5 4849.8 4851.8 4865.7 4866.5 5864.0 5864.4 5867.7 5869.4 5871.6 3852.8 3974.9 3976.9 3984.4 3996.6 6110.7 6182.7 6195.5 6202.6 6204.7 4075.3 4078.7 4095.0 4101.5 4109.3 4151.6 4155.6 4158.2 4163.1 4174.6 4733.8 4819.8 4821.3 4821.6 4833.4 5824.7 5838.2 5856.6 5864.6 5876.8 1450.4 1466.5 1476.4 1476.6 1478.3 948.5 971.8 975.7 992.5 1003.5 5064.9 5092.7 5096.0 5106.9 5114.3 6085.2 6095.7 6099.8 6101.1 6130.5 5102.4 5110.4 5110.5 5112.4 5117.9 3213.7 3260.4 3286.0 3309.9 3316.7 5576.6 5622.7 5666.9 5684.3 5720.7 6250.7 6323.1 6339.1 6365.0 6376.2 5710.4 5733.3 5747.7 5750.8 5760.9 6091.8 6117.5 6155.4 6160.4 6168.3 5844.5 6027.5 6028.9 6032.2 6037.6 5750.3 5760.5 5770.8 5773.4 5775.5 4222.6 4274.1 4274.4 4277.2 4282.6 5891.2 6054.8 6069.2 6072.1 6084.9 5818.2 5834.5 5836.1 5838.2 5852.5 5814.1 5819.8 5847.5 5852.6 5853.6 5578.7 5705.3 5718.7 5736.7 5750.8 5868.6 5876.8 5896.6 5902.9 5915.0 5758.7 5762.6 5766.7 5769.1 5780.3 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: 08:03:29 INFO - 2015-12-18 08:03:29,869 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11872.86 Median:49459.50 stddev:13575.02 (27.4%) stddev-sans-first:13586.81 08:03:29 INFO - 2015-12-18 08:03:29,870 DEBUG : BROWSER_OUTPUT: Values: 623.4 725.3 730.0 732.8 748.0 9592.7 9818.7 9839.3 9865.5 9887.0 10875.9 12729.9 13025.6 13078.9 13131.0 621.0 624.4 767.8 774.9 789.9 774.9 775.3 776.6 783.7 784.7 823.4 831.2 831.6 834.1 835.8 815.8 817.2 818.9 819.2 820.2 610.2 613.2 613.3 614.7 614.8 11032.8 11042.3 11146.5 11253.5 11295.8 10069.9 10402.2 10506.4 10871.3 11229.1 9471.7 9607.1 9610.0 9644.0 9692.7 3134.1 3170.4 3193.0 3199.6 3208.1 39230.4 39513.0 39612.0 39659.8 39706.2 7390.1 7408.7 7459.6 7538.0 7574.5 15738.1 15750.9 15774.8 15777.1 15779.4 6265.0 6429.9 6437.5 6460.8 6541.7 3476.9 3504.9 3530.5 3549.7 3551.6 2427.7 2430.5 2445.0 2449.1 2450.7 454.8 455.4 455.9 459.7 463.1 499.1 547.9 566.7 571.1 584.2 7370.5 7385.7 7390.4 7438.8 7502.5 478.9 481.5 514.9 518.4 552.8 3306.9 3410.3 3476.4 3494.6 3523.5 48964.8 49362.8 49556.3 49606.8 51840.2 41414.4 42112.0 42337.6 42455.6 42632.8 38852.0 39645.6 39797.0 39941.4 40247.4 7575.7 7616.8 7652.6 7742.8 7986.7 30584.0 31779.4 32353.5 32740.3 32932.5 37640.8 37710.4 38683.8 38738.6 38801.0 9311.0 9494.3 9499.6 9752.9 10069.6 10838.1 10922.6 10963.5 11052.6 11293.3 9738.8 9830.3 10072.4 10223.0 10510.7 10206.2 10314.3 10399.4 10512.8 10846.7 9398.4 9990.6 10049.0 10068.2 10282.8 8304.8 8536.9 8652.0 9000.3 9157.0 8619.9 8675.8 8735.8 8821.6 8925.4 08:03:29 INFO - 2015-12-18 08:03:29,870 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:03:29 INFO - 2015-12-18 08:03:29,870 DEBUG : BROWSER_OUTPUT: 08:03:30 INFO - 2015-12-18 08:03:30,651 INFO : Browser exited with error code: 0 08:03:30 INFO - 2015-12-18 08:03:30,677 INFO : Completed test dromaeo_css (00:18:35) 08:03:30 INFO - 2015-12-18 08:03:30,677 INFO : Starting test kraken 08:03:30 INFO - 2015-12-18 08:03:30,677 DEBUG : operating with platform_type : linux_ 08:03:30 INFO - 2015-12-18 08:03:30,677 INFO : Initialising browser for kraken test... 08:03:30 INFO - 2015-12-18 08:03:30,684 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuj2Rto/profile http://localhost:39654/getInfo.html 08:03:35 INFO - 2015-12-18 08:03:35,988 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:03:35 INFO - 2015-12-18 08:03:35,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:03:35 INFO - 2015-12-18 08:03:35,989 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:03:35 INFO - 2015-12-18 08:03:35,989 DEBUG : BROWSER_OUTPUT: __metrics 08:03:36 INFO - 2015-12-18 08:03:36,091 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] 08:03:37 INFO - 2015-12-18 08:03:37,107 INFO : Browser initialized. 08:03:37 INFO - 2015-12-18 08:03:37,107 INFO : Running cycle 1/1 for kraken test... 08:03:37 INFO - 2015-12-18 08:03:37,108 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuj2Rto/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:03:49 INFO - 2015-12-18 08:03:49,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 151252992 08:03:49 INFO - 2015-12-18 08:03:49,085 DEBUG : BROWSER_OUTPUT: 08:03:51 INFO - 2015-12-18 08:03:51,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39654/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:52 INFO - 2015-12-18 08:03:52,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 152350720 08:03:52 INFO - 2015-12-18 08:03:52,282 DEBUG : BROWSER_OUTPUT: 08:03:55 INFO - 2015-12-18 08:03:55,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39654/tests/kraken/driver.html?testName=audio-dft) 08:03:55 INFO - 2015-12-18 08:03:55,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 151842816 08:03:55 INFO - 2015-12-18 08:03:55,648 DEBUG : BROWSER_OUTPUT: 08:03:58 INFO - 2015-12-18 08:03:58,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39654/tests/kraken/driver.html?testName=audio-fft) 08:03:59 INFO - 2015-12-18 08:03:59,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 145354752 08:03:59 INFO - 2015-12-18 08:03:59,139 DEBUG : BROWSER_OUTPUT: 08:04:01 INFO - 2015-12-18 08:04:01,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39654/tests/kraken/driver.html?testName=audio-oscillator) 08:04:01 INFO - 2015-12-18 08:04:01,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 146427904 08:04:01 INFO - 2015-12-18 08:04:01,805 DEBUG : BROWSER_OUTPUT: 08:04:04 INFO - 2015-12-18 08:04:04,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:04 INFO - 2015-12-18 08:04:04,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 146075648 08:04:04 INFO - 2015-12-18 08:04:04,614 DEBUG : BROWSER_OUTPUT: 08:04:07 INFO - 2015-12-18 08:04:07,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39654/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:08 INFO - 2015-12-18 08:04:08,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 147447808 08:04:08 INFO - 2015-12-18 08:04:08,288 DEBUG : BROWSER_OUTPUT: 08:04:11 INFO - 2015-12-18 08:04:11,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39654/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:12 INFO - 2015-12-18 08:04:12,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 146161664 08:04:12 INFO - 2015-12-18 08:04:12,397 DEBUG : BROWSER_OUTPUT: 08:04:15 INFO - 2015-12-18 08:04:15,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39654/tests/kraken/driver.html?testName=json-parse-financial) 08:04:15 INFO - 2015-12-18 08:04:15,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 146927616 08:04:15 INFO - 2015-12-18 08:04:15,903 DEBUG : BROWSER_OUTPUT: 08:04:17 INFO - 2015-12-18 08:04:17,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:18 INFO - 2015-12-18 08:04:18,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 148197376 08:04:18 INFO - 2015-12-18 08:04:18,261 DEBUG : BROWSER_OUTPUT: 08:04:20 INFO - 2015-12-18 08:04:20,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:20 INFO - 2015-12-18 08:04:20,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 147443712 08:04:20 INFO - 2015-12-18 08:04:20,770 DEBUG : BROWSER_OUTPUT: 08:04:22 INFO - 2015-12-18 08:04:22,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:23 INFO - 2015-12-18 08:04:23,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 148676608 08:04:23 INFO - 2015-12-18 08:04:23,509 DEBUG : BROWSER_OUTPUT: 08:04:26 INFO - 2015-12-18 08:04:26,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:26 INFO - 2015-12-18 08:04:26,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 148373504 08:04:26 INFO - 2015-12-18 08:04:26,670 DEBUG : BROWSER_OUTPUT: 08:04:29 INFO - 2015-12-18 08:04:29,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:29 INFO - 2015-12-18 08:04:29,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 147783680 08:04:29 INFO - 2015-12-18 08:04:29,846 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39654/tests/kraken/driver.html?testName=ai-astar) 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 148516864 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:04:31 INFO - 2015-12-18 08:04:31,850 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:04:31 INFO - 2015-12-18 08:04:31,851 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;112;112;113;123;113;114;111;112 08:04:31 INFO - 2015-12-18 08:04:31,851 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;129;152;172;140;155;155;135;185;136 08:04:31 INFO - 2015-12-18 08:04:31,851 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;164;161;162;166;170;163;173;164 08:04:31 INFO - 2015-12-18 08:04:31,851 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;72;75;72;74;130;73;74;74 08:04:31 INFO - 2015-12-18 08:04:31,852 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;93;94;94;132;93;95;128 08:04:31 INFO - 2015-12-18 08:04:31,852 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;110;109;110;110;109;110;109;110;109 08:04:31 INFO - 2015-12-18 08:04:31,852 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;147;148;147;147;150;148;147;149 08:04:31 INFO - 2015-12-18 08:04:31,852 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;96;96;97;96;96;97;96;96;96 08:04:31 INFO - 2015-12-18 08:04:31,853 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;75;74;76;75;76;73;74;72 08:04:31 INFO - 2015-12-18 08:04:31,853 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;67;72;68;74;67;68;68;68;68 08:04:31 INFO - 2015-12-18 08:04:31,853 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;83;89;83;84;84;84;86;85 08:04:31 INFO - 2015-12-18 08:04:31,853 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;121;129;123;119;145;127;138;120 08:04:31 INFO - 2015-12-18 08:04:31,853 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;145;149;144;148;137;152;148;137;134 08:04:31 INFO - 2015-12-18 08:04:31,854 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;70;69;71;70;70;69;69;69 08:04:31 INFO - 2015-12-18 08:04:31,854 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:04:31 INFO - 2015-12-18 08:04:31,854 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:04:31 INFO - 2015-12-18 08:04:31,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,784 08:04:31 INFO - 2015-12-18 08:04:31,855 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:04:31 INFO - 2015-12-18 08:04:31,855 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454671849__endTimestamp 08:04:31 INFO - 2015-12-18 08:04:31,855 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,858 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:3.71 (3.3%) stddev-sans-first:3.93 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 112.0 112.0 113.0 123.0 113.0 114.0 111.0 112.0 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.00 stddev:17.51 (11.3%) stddev-sans-first:18.43 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: Values: 158.0 129.0 152.0 172.0 140.0 155.0 155.0 135.0 185.0 136.0 08:04:31 INFO - 2015-12-18 08:04:31,859 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.80 (2.3%) stddev-sans-first:4.03 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 164.0 161.0 162.0 166.0 170.0 163.0 173.0 164.0 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:74.00 stddev:17.87 (24.2%) stddev-sans-first:18.86 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 72.0 75.0 72.0 74.0 130.0 73.0 74.0 74.0 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:17.59 (18.7%) stddev-sans-first:18.21 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 93.0 94.0 94.0 132.0 93.0 95.0 128.0 08:04:31 INFO - 2015-12-18 08:04:31,860 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: Values: 112.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 148.0 147.0 147.0 150.0 148.0 147.0 149.0 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,861 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:0.44 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: Values: 101.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.50 Median:75.00 stddev:1.27 (1.7%) stddev-sans-first:1.33 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 75.0 74.0 76.0 75.0 76.0 73.0 74.0 72.0 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:2.28 (3.4%) stddev-sans-first:2.42 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 72.0 68.0 74.0 67.0 68.0 68.0 68.0 68.0 08:04:31 INFO - 2015-12-18 08:04:31,862 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.96 (2.3%) stddev-sans-first:1.86 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 83.0 89.0 83.0 84.0 84.0 84.0 86.0 85.0 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.00 stddev:8.87 (7.1%) stddev-sans-first:9.01 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 121.0 129.0 123.0 119.0 145.0 127.0 138.0 120.0 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:146.50 stddev:6.57 (4.5%) stddev-sans-first:6.32 08:04:31 INFO - 2015-12-18 08:04:31,863 DEBUG : BROWSER_OUTPUT: Values: 135.0 145.0 149.0 144.0 148.0 137.0 152.0 148.0 137.0 134.0 08:04:31 INFO - 2015-12-18 08:04:31,864 DEBUG : BROWSER_OUTPUT: 08:04:31 INFO - 2015-12-18 08:04:31,864 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.20 (1.7%) stddev-sans-first:1.05 08:04:31 INFO - 2015-12-18 08:04:31,865 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 70.0 69.0 71.0 70.0 70.0 69.0 69.0 69.0 08:04:31 INFO - 2015-12-18 08:04:31,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:04:31 INFO - 2015-12-18 08:04:31,865 DEBUG : BROWSER_OUTPUT: 08:04:32 INFO - 2015-12-18 08:04:32,763 INFO : Browser exited with error code: 0 08:04:32 INFO - 2015-12-18 08:04:32,812 INFO : Completed test kraken (00:01:02) 08:04:32 INFO - 2015-12-18 08:04:32,812 INFO : Starting test v8_7 08:04:32 INFO - 2015-12-18 08:04:32,812 DEBUG : operating with platform_type : linux_ 08:04:32 INFO - 2015-12-18 08:04:32,812 INFO : Initialising browser for v8_7 test... 08:04:32 INFO - 2015-12-18 08:04:32,818 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZtb0aT/profile http://localhost:39654/getInfo.html 08:04:38 INFO - 2015-12-18 08:04:38,206 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:04:38 INFO - 2015-12-18 08:04:38,207 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:04:38 INFO - 2015-12-18 08:04:38,207 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:04:38 INFO - 2015-12-18 08:04:38,207 DEBUG : BROWSER_OUTPUT: __metrics 08:04:38 INFO - 2015-12-18 08:04:38,384 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] 08:04:39 INFO - 2015-12-18 08:04:39,343 INFO : Browser initialized. 08:04:39 INFO - 2015-12-18 08:04:39,343 INFO : Running cycle 1/1 for v8_7 test... 08:04:39 INFO - 2015-12-18 08:04:39,343 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZtb0aT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:04:51 INFO - 2015-12-18 08:04:51,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 151244800 08:04:51 INFO - 2015-12-18 08:04:51,323 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39654/tests/v8_7/run.html (next: http://localhost:39654/tests/v8_7/run.html) 08:05:12 INFO - 2015-12-18 08:05:12,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 145977344 08:05:12 INFO - 2015-12-18 08:05:12,983 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,983 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:05:12 INFO - 2015-12-18 08:05:12,983 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:05:12 INFO - 2015-12-18 08:05:12,984 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:05:12 INFO - 2015-12-18 08:05:12,984 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:05:12 INFO - 2015-12-18 08:05:12,984 DEBUG : BROWSER_OUTPUT: |0;Richards;164.58196181698486 08:05:12 INFO - 2015-12-18 08:05:12,984 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.32391713747646 08:05:12 INFO - 2015-12-18 08:05:12,984 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.2592592592594 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |5;Earley;720.662347012239 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |7;RegExp;26307.69230769231 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |8;Splay;595.1393005334915 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:05:12 INFO - 2015-12-18 08:05:12,985 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454712976__endTimestamp 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.58 Median:164.58 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: Values: 164.6 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,986 DEBUG : BROWSER_OUTPUT: Values: 188.3 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: Values: 277.7 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: Values: 5229.2 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.26 Median:1059.26 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: Values: 1059.3 08:05:12 INFO - 2015-12-18 08:05:12,987 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.66 Median:720.66 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: Values: 720.7 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: Values: 12268.3 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26307.69 Median:26307.69 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: Values: 26307.7 08:05:12 INFO - 2015-12-18 08:05:12,988 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.14 Median:595.14 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: Values: 595.1 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: Values: 4845.4 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:05:12 INFO - 2015-12-18 08:05:12,989 DEBUG : BROWSER_OUTPUT: 08:05:13 INFO - 2015-12-18 08:05:13,887 INFO : Browser exited with error code: 0 08:05:13 INFO - 2015-12-18 08:05:13,899 INFO : Completed test v8_7 (00:00:41) 08:05:14 INFO - 2015-12-18 08:05:14,021 INFO : Completed test suite (00:20:19) 08:05:14 INFO - 2015-12-18 08:05:14,021 DEBUG : Working with test: dromaeo_css 08:05:14 INFO - 2015-12-18 08:05:14,021 DEBUG : Generating results file: dromaeo_css 08:05:14 INFO - 2015-12-18 08:05:14,023 DEBUG : Working with test: kraken 08:05:14 INFO - 2015-12-18 08:05:14,023 DEBUG : Generating results file: kraken 08:05:14 INFO - 2015-12-18 08:05:14,023 INFO : javascript benchmark 08:05:14 INFO - 2015-12-18 08:05:14,023 DEBUG : Working with test: v8_7 08:05:14 INFO - 2015-12-18 08:05:14,023 DEBUG : Generating results file: v8_7 08:05:14 INFO - 2015-12-18 08:05:14,024 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:14 INFO - 2015-12-18 08:05:14,184 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 08:05:14 INFO - 2015-12-18 08:05:14,185 DEBUG : process_Request line: dromaeo_css 6361.50 graph.html#tests=[[72,94,43]] 08:05:14 INFO - 2015-12-18 08:05:14,185 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:14 INFO - 2015-12-18 08:05:14,234 DEBUG : process_Request line: kraken 1535.50 graph.html#tests=[[232,94,43]] 08:05:14 INFO - 2015-12-18 08:05:14,234 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:05:14 INFO - 2015-12-18 08:05:14,269 DEBUG : process_Request line: v8_7 21331.71 graph.html#tests=[[230,94,43]] 08:05:14 INFO - 2015-12-18 08:05:14,270 INFO : javascript benchmark 08:05:14 INFO - 2015-12-18 08:05:14,274 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2676.90630827921, 2716.7011628720825, 2748.6976432592423, 2762.6961034286214, 2772.6950035496097, 4620.353150558924, 4716.976415117928, 4795.68828026178, 4806.375171227744, 4871.537203965627, 4678.134545109148, 4773.474917759052, 4806.567408933195, 4878.365812444386, 4905.3132561441425, 4407.9779601101945, 4428.269335559637, 4551.795169217393, 4566.634669226454, 4609.1473077480605, 4298.742075475466, 4470.664700147486, 4482.350059241408, 4511.233090374644, 4609.516000819916, 4261.531231564525, 4280.293751530994, 4356.6514678825615, 4380.561943805626, 4399.5160532341415, 4455.131249406367, 4483.618892394151, 4485.327200919855, 4511.052678937427, 4545.863624091249, 4178.289690752579, 4298.398224248608, 4454.48773391061, 4476.731396116244, 4501.639868810487, 4620.145273124449, 4714.363560919266, 4749.240121580565, 4773.284007398918, 4795.232762757942, 5159.045576568347, 5164.096283150434, 5167.0957582422925, 5181.948180518184, 5245.291885595434, 4918.434380046305, 5042.117629414838, 5127.0, 5129.431934850417, 5202.141646628302, 4810.182269014276, 4828.734419606955, 4828.975855120737, 4830.396200474941, 4860.125177468019, 5311.442298558673, 5312.335958005249, 5314.7874085036165, 5319.148936170194, 5334.333208348957, 4756.571908528249, 4905.386826646669, 4986.975065124651, 5092.770825312796, 5139.7687104080405, 5198.896022079537, 5213.322268105122, 5224.7126408047925, 5230.084735171406, 5233.450487698813, 5139.254808052811, 5141.665791723526, 5154.510321519525, 5170.534651881274, 5182.222666600041, 4851.878703032382, 4954.925676114861, 5020.196768517093, 5109.38687357512, 5127.07712611726, 4244.193603215379, 4299.204647140289, 4320.395144679747, 4320.740755554677, 4356.150550642595, 3593.7664051836546, 3811.4092315691114, 3816.637419445148, 3842.500474938296, 3850.6919446444217, 4294.377315289328, 4327.069680018811, 4429.579189976947, 4436.800343984464, 4473.2842745160615, 5134.05020071288, 5135.178371460548, 5146.176611742103, 5152.149895267314, 5171.3535808024, 4190.958090419057, 4290.528041915387, 4422.314541246112, 4424.690271680952, 4458.821647134143, 4499.707519011254, 4574.839880604163, 4586.610138138229, 4607.470140933769, 4616.0767846430845, 4804.039192161582, 4930.20433941529, 4936.975315123402, 4959.231319145538, 4963.8262660806695, 4929.852104436873, 5049.141645920129, 5130.51260130287, 5243.397009343974, 5256.78972841082, 4899.191633380595, 4899.510048995072, 4899.730514821719, 4925.802967881388, 4928.19680941061, 5118.00198961199, 5125.92311115341, 5132.999065182254, 5136.589072874236, 5172.275881376686, 4935.481774413634, 5053.292539044463, 5163.638545301793, 5187.144121220107, 5283.920741188962, 5099.847004589868, 5100.897982040413, 5103.515166059218, 5115.667481613683, 5115.718635475085, 5073.492650734897, 5086.64393492452, 5092.108880945746, 5122.0, 5139.717315547681, 4636.235021221461, 4725.031368569504, 4756.643251756202, 4823.6382271329085, 4835.468098509091, 5005.149124648746, 5068.49315068505, 5071.0, 5079.949200507947, 5110.747866772665, 4715.056988602362, 4941.160002799461, 4959.975200123977, 4968.677035992649, 5032.949670503394], "unit": "score", "name": "dojo.html", "value": 4718.5207302735325}, {"lowerIsBetter": false, "replicates": [560.9663420194788, 570.6034306157221, 578.8683124491617, 579.8347470970772, 584.4827327814883, 34811.0, 35575.4663680045, 35629.10927226821, 35795.463068054, 35820.0, 40820.79589602048, 40834.183316333656, 41023.794881025555, 41155.794221028926, 41428.17143657125, 7701.3453856422275, 7836.0, 7884.684612615517, 7887.96056019722, 7928.960355198216, 7768.766936991871, 7881.369490440751, 7884.684612615489, 7884.684612615489, 7930.167332430098, 7876.133625301212, 7940.166282540336, 7940.245676660708, 7944.880826787603, 7990.560519171443, 7834.882476762853, 7838.490498117632, 7875.0, 7879.842403151905, 7896.447248692594, 7880.448368614199, 7974.60126993648, 7980.162082981262, 7980.321672657773, 7989.161138080534, 36634.63365366365, 37138.0, 37354.626453735385, 37497.25005499902, 37675.24649507022, 2348.2076446538886, 2777.388974425623, 2887.4946884295164, 3024.8638811253327, 3550.378683730363, 26740.46519069608, 26804.19587412381, 27073.593896091377, 27105.45789084227, 27464.588031179348, 3257.299680568689, 3261.445554255782, 3275.7870738401925, 3306.6528014558367, 3390.0677313738674, 174004.0, 175421.12289438598, 175557.12221438938, 176325.0, 176400.0, 51413.7429312851, 51904.22143667848, 53324.46675533272, 55280.44719552834, 55758.44241557614, 54189.1871621926, 54241.45758542364, 54422.0, 54597.0, 54598.18102728462, 13502.662433439242, 13539.526116585872, 13657.863421365857, 13663.726725465634, 13686.726265474636, 10230.59077636901, 10241.692749217535, 10246.795064098676, 10275.691729248134, 10291.588336466457, 18874.716879246822, 19181.904090479456, 19273.22907083701, 19304.420867374, 19335.903320483307, 7184.712611495586, 7432.067662407813, 7484.625768711543, 7514.173440921494, 7558.735444259424, 921.1525396635112, 989.618996686281, 1007.4660429972126, 1016.187050359724, 1054.7046826888484, 25921.740782591933, 26068.34829129287, 26170.476590468083, 26403.339916502242, 26544.469110618065, 988.0564061321421, 994.3238597753452, 1009.9293049486465, 1070.5343175718588, 1084.6203828660064, 13892.305384730724, 13932.860671393359, 14097.436102555988, 14394.784078238834, 14482.420703171965, 192353.0, 192841.0, 193811.0, 194631.0, 196743.0, 42234.57765422307, 42318.15363692709, 42677.35983960243, 42696.78651606722, 42700.0, 1219.4878151176526, 1223.8592561855323, 1235.123062625528, 1239.4980033086433, 1239.7706424311532, 26225.606615901157, 26508.734912650627, 26614.733852661226, 26676.19971400861, 26786.732132678422, 40847.79576102101, 41178.38232426576, 41183.58816411797, 41226.38160427656, 41331.380029300184, 248712.0, 251278.0, 251414.0, 252986.0, 253543.0, 28064.158075257776, 29024.854875725487, 29265.85367073151, 29377.853110734308, 29379.118626441243, 33299.83350083234, 33389.49915751217, 33482.162945926546, 33843.492347614316, 33962.490562641084, 29187.562186566793, 29395.7060429393, 29692.25769355697, 29849.70150298469, 29970.550441742955, 30951.226219344695, 30983.0, 31375.0, 31785.0, 31813.5227971576, 35803.0, 36106.63893361033, 36396.0, 36425.0, 36742.08144796402, 27340.589891151252, 27417.58873616937, 29001.274968125123, 29722.0, 30069.3986120272, 23128.0, 25044.0, 25620.487590247718, 25724.09965651193, 25843.741562584135], "unit": "score", "name": "ext.html", "value": 16478.82219456173}, {"lowerIsBetter": false, "replicates": [315.2764405688944, 319.1367351314694, 324.1862924060607, 326.6488524835802, 336.2400973799213, 15072.773908391382, 15464.226788660564, 15720.135392553419, 15970.361185552563, 16609.0, 14664.706705865876, 14734.18961957092, 14803.037802542854, 14813.777793333109, 15089.92455037726, 4432.844850430236, 5020.297158397827, 5026.271190677349, 5028.8239911603105, 5032.798688052473, 4987.451380348177, 5028.698278103326, 5030.7987680492915, 5036.697798132123, 5040.0, 4609.36367589506, 4960.900781984358, 6083.665398403086, 6303.275123360826, 6311.747530098791, 5989.251343582052, 6205.255369355661, 6249.468795152417, 6260.342664020281, 6264.592801467936, 5664.26364572603, 5943.851403714899, 5960.850978725523, 5974.193483879708, 5987.461128498412, 20831.37505874826, 21116.260930867345, 21300.25449109274, 21326.893365533073, 21420.82185479798, 1825.4249911277905, 1852.6665200263947, 1911.4743445552585, 1913.0721600023978, 2028.0974966140075, 13400.396982135828, 13479.528216512474, 13530.86469135306, 13573.660658483519, 13807.309634518233, 1838.6506563752978, 1862.32956135791, 1889.7921228664836, 1910.8949007804704, 1919.3378284491966, 48188.518114818755, 57013.0, 60299.397006029816, 64849.3515064848, 65109.0, 14256.643583910485, 14510.201938893462, 14695.501764699813, 15227.847721522865, 15477.5356739298, 23012.539749205258, 23037.654435183485, 23091.307260782203, 23228.883855580614, 23296.068157273858, 8799.560021998874, 8865.423747456394, 8896.510691911877, 8993.190612844875, 9026.729198124067, 7561.432892533082, 7619.961900190464, 7620.771376858703, 7659.310662040443, 7671.194524574951, 7504.249575042452, 7552.697892084365, 7604.505707129019, 7644.426667999922, 7647.502912310682, 1737.296394960018, 1781.8841775284566, 3018.920700885085, 3156.6843315668248, 3195.952060719091, 833.3999520345342, 839.5340585974842, 904.7104926423482, 925.8796356473615, 946.9394278408089, 13703.931480342535, 14040.087394319336, 15288.0, 15492.225388730518, 16037.919810400874, 864.8616221404545, 868.9087645797226, 901.9323550733722, 909.0909090909091, 933.2906990687127, 5600.131979543177, 5667.4332566743, 5709.514691251207, 5740.0, 5809.128630705428, 484159.0, 486107.0, 489143.0, 491237.0, 495871.0, 71808.64095679489, 74073.25926740664, 74702.0, 74900.0, 75784.62107689427, 438.82885674586936, 443.0585006860486, 444.2048732768373, 445.08757048051365, 445.16531503431065, 9996.650117245861, 10080.495975201356, 13765.0, 14363.56909292723, 14705.117692938458, 33782.8310858454, 34177.31645367129, 34233.82883085569, 34410.65589344175, 35092.473612895315, 40206.19587608173, 41245.587544125374, 42783.7860810694, 43522.78238608786, 43542.34686479642, 8508.27679647237, 8649.524276164871, 8720.91279087201, 8763.518006509703, 8795.956020219857, 13458.327083645583, 14815.111093334435, 15752.291146898187, 16073.91963040224, 16097.436589719304, 13442.596722098353, 13660.248686322348, 14357.643653783694, 14416.279186040865, 14509.129452232899, 13604.93197534006, 13952.232627205602, 14045.0, 14113.29433528299, 14321.57035288943, 13270.867291326964, 13603.93198034043, 13962.511312104027, 14051.156930584199, 14475.493357732428, 8668.783280417787, 9135.680251191176, 9240.537973101453, 9313.674021409219, 9370.906290937277, 9549.47477888695, 9580.473073980718, 9604.66383676568, 13100.934495327463, 14582.125072495684], "unit": "score", "name": "jquery.html", "value": 8747.49547660559}, {"lowerIsBetter": false, "replicates": [1491.2841835918766, 1612.2664187794555, 1623.9756403653948, 1647.31636370906, 1682.4363838114232, 5927.703614819253, 6178.19683441152, 6918.411934985526, 7399.075115610549, 7436.070491188595, 6874.82812929677, 7111.928880711192, 7115.0, 7132.215456299816, 7214.134303883528, 2059.3718915730697, 2082.073477302601, 2087.728595282611, 2091.5398612305266, 2100.516881117336, 2059.4233614587865, 2087.1338394566237, 2098.6012657595006, 2100.1389430333566, 2108.378028481594, 2034.7151398804178, 2048.3650068478746, 2073.2018173003426, 2074.0770357191054, 2087.6972838938345, 2052.0663098290242, 2055.825254853339, 2069.730934978458, 2072.533679922013, 2078.9480262993548, 2023.5244717491526, 2046.3451695457459, 2047.8156965873143, 2051.05651400356, 2055.8663686860305, 7262.673179706873, 7285.089363829521, 7312.451566132561, 7327.74352897646, 7329.926700732978, 4241.724287921275, 4315.029118448356, 4317.15815415994, 4324.783760811947, 4329.177456283328, 2741.931451713703, 2773.4314465534517, 2808.5365914624062, 2809.9157025289273, 2810.873510692024, 866.8353012927587, 880.5157163560017, 883.3419102768479, 887.0597167002998, 897.2328658996529, 9892.752681182956, 9943.850842237372, 9950.402975821475, 9966.103050725396, 9999.550020249106, 3868.2263547290654, 3885.9611403886165, 3933.1543718100174, 3937.2125574885135, 3960.346542820402, 8543.786405339792, 8605.569721513899, 8622.956885215533, 8633.827323453621, 8655.09121542229, 4258.212230737324, 4264.87205383839, 4269.658427325807, 4270.274053410928, 4299.720518166309, 3306.8015919044933, 3415.2315728960784, 3803.0, 3843.3466310726685, 3893.357595996629, 3343.648916863743, 3346.481295399217, 3353.094664440587, 3354.714849237842, 3404.9659503405146, 1111.155521803419, 1129.4804389980536, 1131.8132508136066, 1135.3074624479061, 1141.0757286597882, 1181.7282025134268, 1187.8871507206802, 1199.9680274963525, 1208.667616405478, 1212.89690376319, 6552.213734351908, 6606.570572912745, 6631.1379520662, 6655.43428808547, 6661.966690166518, 419.66217195157583, 420.88846455689264, 422.53099060043326, 422.83509431321806, 423.0650262918922, 5402.729863506809, 5431.0, 5433.320834895638, 5446.945530544644, 5468.91796623051, 8561.82876342482, 8572.357073219533, 8722.433041852259, 8797.252233560219, 8808.25129863956, 8571.185737354941, 8650.0, 8661.480311181349, 8670.609822558, 8688.870446841996, 6672.5329226953645, 6855.868781650972, 6868.862622747517, 6976.337247961435, 6986.790396288119, 6961.269066747918, 6976.686049127903, 6988.895166572607, 7001.859962800613, 7002.509824312249, 7818.804529886798, 7863.488873223222, 7952.6421311042295, 8004.399670024888, 8125.593720314079, 7752.0697516298405, 7960.522368657899, 7965.92034079675, 8002.399820013638, 8112.918870811216, 5500.532454741232, 5526.226328313959, 6332.778352757631, 6333.96833015832, 6386.16979792624, 6887.070245516791, 6893.414059804973, 6903.102596662603, 6903.275156108536, 6910.654467276717, 6449.193850768654, 6580.177477815273, 6611.239707433707, 6696.19645642526, 6735.932640673531, 6071.453569178619, 6527.184101987252, 6539.6076235424125, 6656.966715166393, 6672.966635166793, 6613.338666133348, 6624.304448032887, 6633.60198388079, 6695.296993815774, 6721.428678562182, 5946.494547963472, 5991.67045812467, 5993.0710739835395, 5998.190244317136, 6009.90985135232, 6101.786437474667, 6112.0, 6150.846228844314, 6155.384461553809, 6161.568690191643], "unit": "score", "name": "mootools.html", "value": 4062.2870405434146}, {"lowerIsBetter": false, "replicates": [292.71167899618877, 302.4118090314338, 303.9255382431304, 304.2910019654206, 304.894811290105, 5520.14437762147, 5550.111982082867, 5597.2723545939025, 5608.551315894729, 5721.628094173876, 5549.611527193088, 5561.749721262543, 5589.0, 5597.468240517154, 5616.297962754656, 4099.754014759109, 4271.722338048033, 4272.935905961397, 4277.657787377002, 4282.507511636163, 4224.683148763855, 4262.46719160105, 4279.443672322609, 4281.44341235639, 4293.592108749664, 4222.408862759216, 4224.915501689964, 4232.0, 4233.0, 4240.830366785325, 4202.159568086379, 4214.494260688737, 4227.725197862144, 4230.936535951963, 4243.618074373321, 3683.060819491013, 3684.207895302496, 3684.9447258291148, 3695.5195824542907, 3699.9445008324897, 5224.947750522484, 5289.206619007141, 5389.8113566025, 5407.756650950677, 5416.431274716177, 4845.491223421561, 4849.781759820817, 4851.8301859435105, 4865.70805751656, 4866.537678920497, 5863.9706801466145, 5864.413558644102, 5867.677277749722, 5869.383714709979, 5871.6183448075735, 3852.8073596320073, 3974.8608798691907, 3976.920461590781, 3984.4222587724907, 3996.580359062286, 6110.6944652767625, 6182.69086545671, 6195.535334849859, 6202.62784232943, 6204.720787564571, 4075.3275709508193, 4078.6737061035046, 4095.0, 4101.52832424269, 4109.3425051991535, 4151.626353628188, 4155.58444155582, 4158.189153115174, 4163.146554956287, 4174.645155161846, 4733.834315798999, 4819.759012049383, 4821.276808478686, 4821.614270858323, 4833.3958255218095, 5824.708764561755, 5838.153467747153, 5856.619319744203, 5864.648121112747, 5876.764929402776, 1450.4343306110625, 1466.486729644637, 1476.402057166849, 1476.6234610174552, 1478.2756449339747, 948.4546385828177, 971.820213260549, 975.7463059604554, 992.5384696116196, 1003.5383723487278, 5064.924026139537, 5092.668976516515, 5096.031753966735, 5106.872328191825, 5114.258432527263, 6085.2393450818645, 6095.6952152392205, 6099.8475038123515, 6101.115338275925, 6130.540209484307, 5102.413222479462, 5110.412302585176, 5110.48895110486, 5112.412072611697, 5117.948820511747, 3213.662565430643, 3260.413125637408, 3286.0, 3309.851056702454, 3316.6683331667123, 5576.637518561281, 5622.690752008597, 5666.858328541819, 5684.317881854204, 5720.742566584514, 6250.656213908188, 6323.114763933053, 6339.144215530844, 6365.0, 6376.171097757262, 5710.428957104339, 5733.31200255972, 5747.712614369265, 5750.7987220447085, 5760.913586296125, 6091.786787462417, 6117.510599151969, 6155.415235552616, 6160.414760597736, 6168.321484636776, 5844.503217226414, 6027.457528822427, 6028.909566356596, 6032.245969253843, 6037.577369584087, 5750.309962804323, 5760.539156867357, 5770.769169233184, 5773.422657734193, 5775.537956963517, 4222.619964203236, 4274.081072569413, 4274.422952901318, 4277.230098582285, 4282.550332215073, 5891.23413956183, 6054.788082417094, 6069.241344831896, 6072.05883088122, 6084.939150608614, 5818.156367326798, 5834.474897259097, 5836.066229403275, 5838.241028666416, 5852.473277405054, 5814.069748840166, 5819.79630712923, 5847.532197424281, 5852.590318677822, 5853.590248682552, 5578.721063946868, 5705.286839145107, 5718.656880587178, 5736.741846616829, 5750.769969201185, 5868.618539794899, 5876.794312199053, 5896.587238893237, 5902.852428689145, 5914.970425147847, 5758.683272420057, 5762.625429347079, 5766.682832444256, 5769.134629805562, 5780.335261444988], "unit": "score", "name": "prototype.html", "value": 4367.340113234064}, {"lowerIsBetter": false, "replicates": [623.4202191961475, 725.2711025419453, 729.9963500182497, 732.7508647059996, 747.9925200747991, 9592.664256751006, 9818.705438836829, 9839.262055345851, 9865.506724663765, 9886.950565247182, 10875.945620271888, 12729.93635031826, 13025.60923172304, 13078.869211307883, 13131.0, 621.0497938154631, 624.3662682377368, 767.7696690992694, 774.8798936164903, 789.889415481833, 774.8837674348837, 775.255754475704, 776.6311002273903, 783.6747749683902, 784.6861255497818, 823.4071468542639, 831.2394159344193, 831.5883637599396, 834.1158372125566, 835.761807884753, 815.7634286057037, 817.2032268538187, 818.8730746734266, 819.2422009641087, 820.216693058128, 610.2493932463095, 613.1844646619985, 613.3130893399376, 614.6527212125135, 614.8155553334027, 11032.779344413148, 11042.33745975244, 11146.498407571678, 11253.54985800567, 11295.830562541569, 10069.949650251776, 10402.167826573856, 10506.422146781924, 10871.347719136877, 11229.10167186623, 9471.715848524555, 9607.13535781783, 9609.951950240204, 9644.03559644037, 9692.660756873476, 3134.1067795678123, 3170.4291739022574, 3192.952105718416, 3199.568058312145, 3208.0536241808722, 39230.41154382686, 39513.0, 39612.0, 39659.8017009916, 39706.20587588261, 7390.076240469942, 7408.703651853865, 7459.552426854406, 7538.0, 7574.545527268271, 15738.134402607737, 15750.9212453937, 15774.842251577338, 15777.053376797428, 15779.368825247091, 6264.968675156595, 6429.935700643027, 6437.485001199892, 6460.773872914426, 6541.738330466728, 3476.913077173091, 3504.9474257886154, 3530.470429435605, 3549.716022718176, 3551.6093229744706, 2427.6965379327585, 2430.4652976345174, 2444.9511009780063, 2449.1428000200144, 2450.742672019448, 454.7771591919935, 455.42388878069266, 455.8905862592954, 459.69660024383745, 463.1385622741698, 499.086671391353, 547.8958997790407, 566.7194738604417, 571.0577547047322, 584.1529781816383, 7370.484066115428, 7385.7045718170675, 7390.445716571278, 7438.776836694908, 7502.512336698097, 478.909007288614, 481.5016457966058, 514.9407818100891, 518.4090137243545, 552.7871769368822, 3306.8511916963794, 3410.3179364127272, 3476.3742526344995, 3494.580650321978, 3523.524324216249, 48964.75517622389, 49362.75318623384, 49556.25665615019, 49606.75196624066, 51840.22239666408, 41414.37878431826, 42112.0, 42337.57662423398, 42455.57544424578, 42632.78683606562, 38852.0, 39645.60354396419, 39796.99999999942, 39941.40087898684, 40247.39628905569, 7575.659095340833, 7616.8476630465975, 7652.579108149105, 7742.806429839299, 7986.720464783704, 30584.0, 31779.36441271208, 32353.51469727909, 32740.34519309648, 32932.50601241031, 37640.81179594085, 37710.43434348432, 38683.80658096691, 38738.6126138735, 38801.0, 9311.0, 9494.28792840526, 9499.572519236513, 9752.9024709752, 10069.647562335284, 10838.132949363875, 10922.563097476012, 10963.506642201279, 11052.613158539734, 11293.322400655987, 9738.843599258942, 9830.311878168459, 10072.446015469219, 10223.028812262823, 10510.737231568966, 10206.183505319408, 10314.319437418875, 10399.428031458343, 10512.842307365549, 10846.67459976202, 9398.389104708445, 9990.600375984879, 10049.0, 10068.194544436281, 10282.845757313797, 8304.833903321778, 8536.871946920925, 8651.991095721, 9000.324975626985, 9156.954215228881, 8619.913800862161, 8675.783105422415, 8735.781605459915, 8821.558922053744, 8925.375223734276], "unit": "score", "name": "yui.html", "value": 5491.709847870327}], "name": "dromaeo_css", "value": 6361.494200811239}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 112.0, 113.0, 123.0, 113.0, 114.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [158.0, 129.0, 152.0, 172.0, 140.0, 155.0, 155.0, 135.0, 185.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 164.0, 161.0, 162.0, 166.0, 170.0, 163.0, 173.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 72.0, 75.0, 72.0, 74.0, 130.0, 73.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 93.0, 94.0, 94.0, 132.0, 93.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 150.0, 148.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 74.0, 76.0, 75.0, 76.0, 73.0, 74.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 72.0, 68.0, 74.0, 67.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 83.0, 89.0, 83.0, 84.0, 84.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 121.0, 129.0, 123.0, 119.0, 145.0, 127.0, 138.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 149.0, 144.0, 148.0, 137.0, 152.0, 148.0, 137.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 70.0, 69.0, 71.0, 70.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1535.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.58196181698486], "unit": "score", "name": "Richards", "value": 214.4949520000001}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1059.2592592592594], "unit": "score", "name": "RayTrace", "value": 698.5910139860142}, {"lowerIsBetter": false, "replicates": [720.662347012239], "unit": "score", "name": "Earley", "value": 924.7923146853145}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26307.69230769231], "unit": "score", "name": "RegExp", "value": 34.62808479532162}, {"lowerIsBetter": false, "replicates": [595.1393005334915], "unit": "score", "name": "Splay", "value": 136.9276065737051}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21331.706159762205}]} 08:05:14 INFO - RETURN: dromaeo_css: 6361.50 08:05:14 INFO - RETURN: kraken: 1535.50 08:05:14 INFO - RETURN: v8_7: 21331.71 08:05:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21331.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1535.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6361.50"}}} 08:05:14 INFO - Return code: 0 08:05:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:05:14 INFO - # TBPL SUCCESS # 08:05:14 INFO - Running post-action listener: _resource_record_post_action 08:05:14 INFO - Running post-run listener: _resource_record_post_run 08:05:15 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541659136; Read time: 16; Write time: 883760 08:05:15 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 226729984; Read time: 0; Write time: 424152 08:05:15 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314929152; Read time: 16; Write time: 458764 08:05:15 INFO - Running post-run listener: _upload_blobber_files 08:05:15 INFO - Blob upload gear active. 08:05:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:05:15 INFO - Copying logs to upload dir... 08:05:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.384814 ========= master_lag: 49.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-12-18 08:06:04.426913) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:06:04.430609) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.34 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:06:04.775982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:06:04.776323) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450453443.837944-2059787743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 08:06:04.801652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:06:04.802024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:06:04.802319) ========= ========= Total master_lag: 49.68 =========