builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1465217799.19 results: success (0) buildid: 20160606004039 builduid: 0849ed91b1dc4aa49f169953467d6a85 revision: 7f8d31a531ca31d5206f0a37528c36d1695ad767 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.189175) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.190243) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.190571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.215923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.216212) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:56:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-06-06 05:56:41 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.357931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.358256) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021741 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.408164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:39.408473) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f8d31a531ca31d5206f0a37528c36d1695ad767 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f8d31a531ca31d5206f0a37528c36d1695ad767 --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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:56:41,158 truncating revision to first 12 chars 2016-06-06 05:56:41,158 Setting DEBUG logging. 2016-06-06 05:56:41,158 attempt 1/10 2016-06-06 05:56:41,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7f8d31a531ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:56:41,468 unpacking tar archive at: mozilla-aurora-7f8d31a531ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:40.060701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:40.061189) ========= script_repo_revision: 7f8d31a531ca31d5206f0a37528c36d1695ad767 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:40.061827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:40.062237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:56:40.074436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-06 05:56:40.074987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:41 INFO - MultiFileLogger online at 20160606 05:56:41 in /builds/slave/test 05:56:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:56:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:41 INFO - {'append_to_log': False, 05:56:41 INFO - 'base_work_dir': '/builds/slave/test', 05:56:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:56:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:41 INFO - 'branch': 'Mozilla-Aurora', 05:56:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:41 INFO - 'config_files': ('talos/linux_config.py',), 05:56:41 INFO - 'default_actions': ('clobber', 05:56:41 INFO - 'read-buildbot-config', 05:56:41 INFO - 'download-and-extract', 05:56:41 INFO - 'populate-webroot', 05:56:41 INFO - 'create-virtualenv', 05:56:41 INFO - 'install', 05:56:41 INFO - 'run-tests'), 05:56:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:41 INFO - 'download_minidump_stackwalk': True, 05:56:41 INFO - 'download_symbols': 'ondemand', 05:56:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:41 INFO - 'installer_path': 'installer.exe', 05:56:41 INFO - 'log_level': 'info', 05:56:41 INFO - 'log_name': 'talos', 05:56:41 INFO - 'log_to_console': True, 05:56:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:41 INFO - 'opt_config_files': (), 05:56:41 INFO - 'pip_index': False, 05:56:41 INFO - 'sps_profile': False, 05:56:41 INFO - 'sps_profile_interval': 0, 05:56:41 INFO - 'suite': 'dromaeojs-e10s', 05:56:41 INFO - 'system_bits': '32', 05:56:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:41 INFO - 'title': 'talos-linux64-ix-067', 05:56:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:41 INFO - 'use_talos_json': True, 05:56:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:41 INFO - 'work_dir': 'build'} 05:56:41 INFO - ##### 05:56:41 INFO - ##### Running clobber step. 05:56:41 INFO - ##### 05:56:41 INFO - Running pre-action listener: _resource_record_pre_action 05:56:41 INFO - Running main action method: clobber 05:56:41 INFO - rmtree: /builds/slave/test/build 05:56:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:42 INFO - Running post-action listener: _resource_record_post_action 05:56:42 INFO - ##### 05:56:42 INFO - ##### Running read-buildbot-config step. 05:56:42 INFO - ##### 05:56:42 INFO - Running pre-action listener: _resource_record_pre_action 05:56:42 INFO - Running main action method: read_buildbot_config 05:56:42 INFO - Using buildbot properties: 05:56:42 INFO - { 05:56:42 INFO - "project": "", 05:56:42 INFO - "product": "firefox", 05:56:42 INFO - "script_repo_revision": "production", 05:56:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:56:42 INFO - "repository": "", 05:56:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:56:42 INFO - "buildid": "20160606004039", 05:56:42 INFO - "stage_platform": "linux64-pgo", 05:56:42 INFO - "basedir": "/builds/slave/test", 05:56:42 INFO - "nightly_build": "True", 05:56:42 INFO - "buildnumber": 388, 05:56:42 INFO - "slavename": "talos-linux64-ix-067", 05:56:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:56:42 INFO - "platform": "ubuntu64_hw", 05:56:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:56:42 INFO - "branch": "mozilla-aurora", 05:56:42 INFO - "repo_path": "releases/mozilla-aurora", 05:56:42 INFO - "revision": "7f8d31a531ca31d5206f0a37528c36d1695ad767", 05:56:42 INFO - "pgo_build": "True", 05:56:42 INFO - "builduid": "0849ed91b1dc4aa49f169953467d6a85", 05:56:42 INFO - "slavebuilddir": "test" 05:56:42 INFO - } 05:56:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:56:42 INFO - Running post-action listener: _resource_record_post_action 05:56:42 INFO - ##### 05:56:42 INFO - ##### Running download-and-extract step. 05:56:42 INFO - ##### 05:56:42 INFO - Running pre-action listener: _resource_record_pre_action 05:56:42 INFO - Running main action method: download_and_extract 05:56:42 INFO - mkdir: /builds/slave/test/build/tests 05:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:42 INFO - https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:56:43 INFO - Downloaded 1361 bytes. 05:56:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:56:43 INFO - Using the following test package requirements: 05:56:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:56:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:56:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'jsshell-linux-x86_64.zip'], 05:56:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:56:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:56:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:56:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:43 INFO - https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:44 INFO - Downloaded 24177788 bytes. 05:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:45 INFO - Return code: 0 05:56:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:45 INFO - https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:48 INFO - Downloaded 24177788 bytes. 05:56:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:50 INFO - Return code: 0 05:56:50 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')]} 05:56:50 INFO - https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:51 INFO - Downloaded 10840145 bytes. 05:56:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:56:52 INFO - Return code: 0 05:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:52 INFO - https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:56:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:56:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:56:53 INFO - Downloaded 62818760 bytes. 05:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:56:53 INFO - mkdir: /builds/slave/test/properties 05:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:53 INFO - Contents: 05:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:56:54 INFO - Running post-action listener: _resource_record_post_action 05:56:54 INFO - Running post-action listener: set_extra_try_arguments 05:56:54 INFO - ##### 05:56:54 INFO - ##### Running populate-webroot step. 05:56:54 INFO - ##### 05:56:54 INFO - Running pre-action listener: _resource_record_pre_action 05:56:54 INFO - Running main action method: populate_webroot 05:56:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:54 INFO - '--tppagecycles', 05:56:54 INFO - '7'], 05:56:54 INFO - 'tests': ['tsvgm']}}, 05:56:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['damp', 'tps']}, 05:56:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'tests': ['damp', 'tps']}, 05:56:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['dromaeo_dom']}, 05:56:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['a11yr', 05:56:54 INFO - 'ts_paint', 05:56:54 INFO - 'tpaint', 05:56:54 INFO - 'sessionrestore', 05:56:54 INFO - 'sessionrestore_no_auto_restore', 05:56:54 INFO - 'tabpaint']}, 05:56:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['tsvgx', 05:56:54 INFO - 'tsvgr_opacity', 05:56:54 INFO - 'tart', 05:56:54 INFO - 'tscrollx', 05:56:54 INFO - 'cart']}, 05:56:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:54 INFO - 'tsvgr_opacity', 05:56:54 INFO - 'tart', 05:56:54 INFO - 'tscrollx', 05:56:54 INFO - 'cart']}, 05:56:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'talos_options': ['--disable-e10s'], 05:56:54 INFO - 'tests': ['tp5o']}, 05:56:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'tests': ['tp5o']}, 05:56:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'talos_options': ['--disable-e10s', 05:56:54 INFO - '--xperf_path', 05:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:54 INFO - 'tests': ['tp5n']}, 05:56:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:54 INFO - 'talos_options': ['--xperf_path', 05:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:54 INFO - 'tests': ['tp5n']}}, 05:56:54 INFO - 'talos.zip': {'path': '', 05:56:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:54 INFO - Running post-action listener: _resource_record_post_action 05:56:54 INFO - ##### 05:56:54 INFO - ##### Running create-virtualenv step. 05:56:54 INFO - ##### 05:56:54 INFO - Running pre-action listener: _resource_record_pre_action 05:56:54 INFO - Running main action method: create_virtualenv 05:56:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:54 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 05:56:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:54 INFO - Using real prefix '/usr' 05:56:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:57 INFO - Installing pip.................done. 05:56:57 INFO - Return code: 0 05:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:57 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')]} 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 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')]} 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:56:57 INFO - Using env: {'DISPLAY': ':0', 05:56:57 INFO - 'HOME': '/home/cltbld', 05:56:57 INFO - 'LANG': 'en_US.UTF-8', 05:56:57 INFO - 'LANGUAGE': 'en_US:en', 05:56:57 INFO - 'LOGNAME': 'cltbld', 05:56:57 INFO - 'MAIL': '/var/mail/cltbld', 05:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:57 INFO - 'MOZ_NO_REMOTE': '1', 05:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:57 INFO - 'NO_EM_RESTART': '1', 05:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:57 INFO - 'PWD': '/builds/slave/test', 05:56:57 INFO - 'SHELL': '/bin/bash', 05:56:57 INFO - 'SHLVL': '1', 05:56:57 INFO - 'TERM': 'linux', 05:56:57 INFO - 'TMOUT': '86400', 05:56:57 INFO - 'USER': 'cltbld', 05:56:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:57 INFO - '_': '/tools/buildbot/bin/python'} 05:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:57 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 05:56:57 INFO - Cleaning up... 05:56:57 INFO - Return code: 0 05:56:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:56:57 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')]} 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 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')]} 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:56:57 INFO - Using env: {'DISPLAY': ':0', 05:56:57 INFO - 'HOME': '/home/cltbld', 05:56:57 INFO - 'LANG': 'en_US.UTF-8', 05:56:57 INFO - 'LANGUAGE': 'en_US:en', 05:56:57 INFO - 'LOGNAME': 'cltbld', 05:56:57 INFO - 'MAIL': '/var/mail/cltbld', 05:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:57 INFO - 'MOZ_NO_REMOTE': '1', 05:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:57 INFO - 'NO_EM_RESTART': '1', 05:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:57 INFO - 'PWD': '/builds/slave/test', 05:56:57 INFO - 'SHELL': '/bin/bash', 05:56:57 INFO - 'SHLVL': '1', 05:56:57 INFO - 'TERM': 'linux', 05:56:57 INFO - 'TMOUT': '86400', 05:56:57 INFO - 'USER': 'cltbld', 05:56:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:57 INFO - '_': '/tools/buildbot/bin/python'} 05:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:57 INFO - Downloading/unpacking psutil>=0.7.1 05:56:57 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 05:56:57 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 05:56:57 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 05:56:57 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 05:56:57 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 05:56:57 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 05:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:59 INFO - Installing collected packages: psutil 05:56:59 INFO - Running setup.py install for psutil 05:56:59 INFO - building 'psutil._psutil_linux' extension 05:56:59 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 05:56:59 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 05:56:59 INFO - building 'psutil._psutil_posix' extension 05:56:59 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 05:57:00 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 05:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:00 INFO - Successfully installed psutil 05:57:00 INFO - Cleaning up... 05:57:00 INFO - Return code: 0 05:57:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57:00 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')]} 05:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:00 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')]} 05:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:00 INFO - Using env: {'DISPLAY': ':0', 05:57:00 INFO - 'HOME': '/home/cltbld', 05:57:00 INFO - 'LANG': 'en_US.UTF-8', 05:57:00 INFO - 'LANGUAGE': 'en_US:en', 05:57:00 INFO - 'LOGNAME': 'cltbld', 05:57:00 INFO - 'MAIL': '/var/mail/cltbld', 05:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:00 INFO - 'MOZ_NO_REMOTE': '1', 05:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:00 INFO - 'NO_EM_RESTART': '1', 05:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:00 INFO - 'PWD': '/builds/slave/test', 05:57:00 INFO - 'SHELL': '/bin/bash', 05:57:00 INFO - 'SHLVL': '1', 05:57:00 INFO - 'TERM': 'linux', 05:57:00 INFO - 'TMOUT': '86400', 05:57:00 INFO - 'USER': 'cltbld', 05:57:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:00 INFO - '_': '/tools/buildbot/bin/python'} 05:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:02 INFO - Installing collected packages: mozsystemmonitor 05:57:02 INFO - Running setup.py install for mozsystemmonitor 05:57:02 INFO - Successfully installed mozsystemmonitor 05:57:02 INFO - Cleaning up... 05:57:02 INFO - Return code: 0 05:57:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:02 INFO - Using env: {'DISPLAY': ':0', 05:57:02 INFO - 'HOME': '/home/cltbld', 05:57:02 INFO - 'LANG': 'en_US.UTF-8', 05:57:02 INFO - 'LANGUAGE': 'en_US:en', 05:57:02 INFO - 'LOGNAME': 'cltbld', 05:57:02 INFO - 'MAIL': '/var/mail/cltbld', 05:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:02 INFO - 'MOZ_NO_REMOTE': '1', 05:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:02 INFO - 'NO_EM_RESTART': '1', 05:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:02 INFO - 'PWD': '/builds/slave/test', 05:57:02 INFO - 'SHELL': '/bin/bash', 05:57:02 INFO - 'SHLVL': '1', 05:57:02 INFO - 'TERM': 'linux', 05:57:02 INFO - 'TMOUT': '86400', 05:57:02 INFO - 'USER': 'cltbld', 05:57:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:02 INFO - '_': '/tools/buildbot/bin/python'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:02 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 05:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:05 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 05:57:05 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 05:57:05 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 05:57:05 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 05:57:05 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 05:57:05 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 05:57:05 INFO - Downloading docopt-0.6.1.tar.gz 05:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:05 INFO - Running setup.py install for blobuploader 05:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:05 INFO - Running setup.py install for requests 05:57:05 INFO - Running setup.py install for docopt 05:57:06 INFO - Successfully installed blobuploader requests docopt 05:57:06 INFO - Cleaning up... 05:57:06 INFO - Return code: 0 05:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:06 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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:06 INFO - Running setup.py (path:/tmp/pip-dFCAs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:06 INFO - Running setup.py (path:/tmp/pip-bgThZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:06 INFO - Running setup.py (path:/tmp/pip-oV0ZCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:06 INFO - Running setup.py (path:/tmp/pip-x8NOWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:06 INFO - Running setup.py (path:/tmp/pip-IjUYz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:06 INFO - Running setup.py (path:/tmp/pip-Tiic6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:06 INFO - Running setup.py (path:/tmp/pip-Ioor3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:06 INFO - Running setup.py (path:/tmp/pip-PuhpET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:06 INFO - Running setup.py (path:/tmp/pip-reSotc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:07 INFO - Running setup.py (path:/tmp/pip-g4HQA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:07 INFO - Running setup.py (path:/tmp/pip-0jD0og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:07 INFO - Running setup.py (path:/tmp/pip-Dafx1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:07 INFO - Running setup.py (path:/tmp/pip-gvFDOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:07 INFO - Running setup.py (path:/tmp/pip-PIIZGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:07 INFO - Running setup.py (path:/tmp/pip-YLmKqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:07 INFO - Running setup.py (path:/tmp/pip-oie6WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:07 INFO - Running setup.py (path:/tmp/pip-PETcNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:07 INFO - Running setup.py install for manifestparser 05:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:07 INFO - Running setup.py install for mozcrash 05:57:07 INFO - Running setup.py install for mozdebug 05:57:07 INFO - Running setup.py install for mozdevice 05:57:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozfile 05:57:08 INFO - Running setup.py install for mozhttpd 05:57:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozinfo 05:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozInstall 05:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozleak 05:57:08 INFO - Running setup.py install for mozlog 05:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for moznetwork 05:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozprocess 05:57:08 INFO - Running setup.py install for mozprofile 05:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:08 INFO - Running setup.py install for mozrunner 05:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:09 INFO - Running setup.py install for mozscreenshot 05:57:09 INFO - Running setup.py install for moztest 05:57:09 INFO - Running setup.py install for mozversion 05:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:09 INFO - Cleaning up... 05:57:09 INFO - Return code: 0 05:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:09 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')]} 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 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')]} 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:09 INFO - Using env: {'DISPLAY': ':0', 05:57:09 INFO - 'HOME': '/home/cltbld', 05:57:09 INFO - 'LANG': 'en_US.UTF-8', 05:57:09 INFO - 'LANGUAGE': 'en_US:en', 05:57:09 INFO - 'LOGNAME': 'cltbld', 05:57:09 INFO - 'MAIL': '/var/mail/cltbld', 05:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:09 INFO - 'MOZ_NO_REMOTE': '1', 05:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:09 INFO - 'NO_EM_RESTART': '1', 05:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:09 INFO - 'PWD': '/builds/slave/test', 05:57:09 INFO - 'SHELL': '/bin/bash', 05:57:09 INFO - 'SHLVL': '1', 05:57:09 INFO - 'TERM': 'linux', 05:57:09 INFO - 'TMOUT': '86400', 05:57:09 INFO - 'USER': 'cltbld', 05:57:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:09 INFO - '_': '/tools/buildbot/bin/python'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:09 INFO - Running setup.py (path:/tmp/pip-vTyy_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:09 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)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:09 INFO - Running setup.py (path:/tmp/pip-W2bwYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:09 INFO - Running setup.py (path:/tmp/pip-y0ay0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:09 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)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:09 INFO - Running setup.py (path:/tmp/pip-MRS7cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:09 INFO - Running setup.py (path:/tmp/pip-f35dxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:09 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)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:09 INFO - Running setup.py (path:/tmp/pip-5C0JmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 INFO - Running setup.py (path:/tmp/pip-VM5ZaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:10 INFO - Running setup.py (path:/tmp/pip-eYPCQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:10 INFO - Running setup.py (path:/tmp/pip-aFBHLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:10 INFO - Running setup.py (path:/tmp/pip-eYomd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:10 INFO - Running setup.py (path:/tmp/pip-UTYn30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:10 INFO - Running setup.py (path:/tmp/pip-Hzyi_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:10 INFO - Running setup.py (path:/tmp/pip-nKKR3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:10 INFO - Running setup.py (path:/tmp/pip-vqLxgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:10 INFO - Running setup.py (path:/tmp/pip-6ttYwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:10 INFO - Running setup.py (path:/tmp/pip-hqeFwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:10 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)) 05:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:10 INFO - Running setup.py (path:/tmp/pip-mVIunP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:10 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)) 05:57:10 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:10 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:10 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)) 05:57:10 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:10 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:10 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 05:57:10 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 05:57:10 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 05:57:10 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 05:57:10 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 05:57:10 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 05:57:12 INFO - Downloading blessings-1.6.tar.gz 05:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:12 INFO - Installing collected packages: blessings 05:57:12 INFO - Running setup.py install for blessings 05:57:12 INFO - Successfully installed blessings 05:57:12 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:13 INFO - Reading from file tmpfile_stdout 05:57:13 INFO - Current package versions: 05:57:13 INFO - argparse == 1.2.1 05:57:13 INFO - blessings == 1.6 05:57:13 INFO - blobuploader == 1.2.4 05:57:13 INFO - docopt == 0.6.1 05:57:13 INFO - manifestparser == 1.1 05:57:13 INFO - mozInstall == 1.12 05:57:13 INFO - mozcrash == 0.17 05:57:13 INFO - mozdebug == 0.1 05:57:13 INFO - mozdevice == 0.48 05:57:13 INFO - mozfile == 1.2 05:57:13 INFO - mozhttpd == 0.7 05:57:13 INFO - mozinfo == 0.9 05:57:13 INFO - mozleak == 0.1 05:57:13 INFO - mozlog == 3.1 05:57:13 INFO - moznetwork == 0.27 05:57:13 INFO - mozprocess == 0.22 05:57:13 INFO - mozprofile == 0.28 05:57:13 INFO - mozrunner == 6.11 05:57:13 INFO - mozscreenshot == 0.1 05:57:13 INFO - mozsystemmonitor == 0.0 05:57:13 INFO - moztest == 0.7 05:57:13 INFO - mozversion == 1.4 05:57:13 INFO - psutil == 3.1.1 05:57:13 INFO - requests == 1.2.3 05:57:13 INFO - wsgiref == 0.1.2 05:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:13 INFO - Using env: {'DISPLAY': ':0', 05:57:13 INFO - 'HOME': '/home/cltbld', 05:57:13 INFO - 'LANG': 'en_US.UTF-8', 05:57:13 INFO - 'LANGUAGE': 'en_US:en', 05:57:13 INFO - 'LOGNAME': 'cltbld', 05:57:13 INFO - 'MAIL': '/var/mail/cltbld', 05:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:13 INFO - 'MOZ_NO_REMOTE': '1', 05:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:13 INFO - 'NO_EM_RESTART': '1', 05:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:13 INFO - 'PWD': '/builds/slave/test', 05:57:13 INFO - 'SHELL': '/bin/bash', 05:57:13 INFO - 'SHLVL': '1', 05:57:13 INFO - 'TERM': 'linux', 05:57:13 INFO - 'TMOUT': '86400', 05:57:13 INFO - 'USER': 'cltbld', 05:57:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:13 INFO - '_': '/tools/buildbot/bin/python'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:13 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 2)) 05:57:13 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 3)) 05:57:13 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 4)) 05:57:13 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 5)) 05:57:13 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 6)) 05:57:13 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 7)) 05:57:13 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 8)) 05:57:13 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 9)) 05:57:13 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:13 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 4)) 05:57:13 INFO - Cleaning up... 05:57:13 INFO - Return code: 0 05:57:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:13 INFO - Using env: {'DISPLAY': ':0', 05:57:13 INFO - 'HOME': '/home/cltbld', 05:57:13 INFO - 'LANG': 'en_US.UTF-8', 05:57:13 INFO - 'LANGUAGE': 'en_US:en', 05:57:13 INFO - 'LOGNAME': 'cltbld', 05:57:13 INFO - 'MAIL': '/var/mail/cltbld', 05:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:13 INFO - 'MOZ_NO_REMOTE': '1', 05:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:13 INFO - 'NO_EM_RESTART': '1', 05:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:13 INFO - 'PWD': '/builds/slave/test', 05:57:13 INFO - 'SHELL': '/bin/bash', 05:57:13 INFO - 'SHLVL': '1', 05:57:13 INFO - 'TERM': 'linux', 05:57:13 INFO - 'TMOUT': '86400', 05:57:13 INFO - 'USER': 'cltbld', 05:57:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:13 INFO - '_': '/tools/buildbot/bin/python'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Downloading/unpacking jsonschema 05:57:13 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 05:57:13 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 05:57:13 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 05:57:13 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 05:57:13 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 05:57:13 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 05:57:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57:15 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 05:57:15 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 05:57:15 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 05:57:15 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 05:57:15 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 05:57:15 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 05:57:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:15 INFO - warning: no files found matching '*.txt' 05:57:15 INFO - no previously-included directories found matching 'build' 05:57:15 INFO - no previously-included directories found matching 'dist' 05:57:15 INFO - no previously-included directories found matching '.git*' 05:57:15 INFO - Installing collected packages: jsonschema, functools32 05:57:15 INFO - Running setup.py install for functools32 05:57:15 INFO - warning: no files found matching '*.txt' 05:57:15 INFO - no previously-included directories found matching 'build' 05:57:15 INFO - no previously-included directories found matching 'dist' 05:57:15 INFO - no previously-included directories found matching '.git*' 05:57:15 INFO - Successfully installed jsonschema functools32 05:57:15 INFO - Cleaning up... 05:57:16 INFO - Return code: 0 05:57:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fc10cb7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', '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 05:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:57:16 INFO - Using env: {'DISPLAY': ':0', 05:57:16 INFO - 'HOME': '/home/cltbld', 05:57:16 INFO - 'LANG': 'en_US.UTF-8', 05:57:16 INFO - 'LANGUAGE': 'en_US:en', 05:57:16 INFO - 'LOGNAME': 'cltbld', 05:57:16 INFO - 'MAIL': '/var/mail/cltbld', 05:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:16 INFO - 'MOZ_NO_REMOTE': '1', 05:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:16 INFO - 'NO_EM_RESTART': '1', 05:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:16 INFO - 'PWD': '/builds/slave/test', 05:57:16 INFO - 'SHELL': '/bin/bash', 05:57:16 INFO - 'SHLVL': '1', 05:57:16 INFO - 'TERM': 'linux', 05:57:16 INFO - 'TMOUT': '86400', 05:57:16 INFO - 'USER': 'cltbld', 05:57:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:16 INFO - '_': '/tools/buildbot/bin/python'} 05:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:16 INFO - Downloading/unpacking flake8 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:18 INFO - no previously-included directories found matching 'docs/_build' 05:57:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:18 INFO - Running setup.py install for pep8 05:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:19 INFO - no previously-included directories found matching 'docs/_build' 05:57:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Running post-action listener: _resource_record_post_action 05:57:19 INFO - Running post-action listener: _start_resource_monitoring 05:57:19 INFO - Starting resource monitoring. 05:57:19 INFO - ##### 05:57:19 INFO - ##### Running install step. 05:57:19 INFO - ##### 05:57:19 INFO - Running pre-action listener: _resource_record_pre_action 05:57:19 INFO - Running main action method: install 05:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:19 INFO - Reading from file tmpfile_stdout 05:57:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:19 INFO - Reading from file tmpfile_stdout 05:57:19 INFO - Output received: 05:57:19 INFO - Usage: mozinstall [options] installer 05:57:19 INFO - Options: 05:57:19 INFO - -h, --help show this help message and exit 05:57:19 INFO - -d DEST, --destination=DEST 05:57:19 INFO - Directory to install application into. [default: 05:57:19 INFO - "/builds/slave/test"] 05:57:19 INFO - --app=APP Application being installed. [default: firefox] 05:57:19 INFO - mkdir: /builds/slave/test/build/application 05:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:57:35 INFO - Reading from file tmpfile_stdout 05:57:35 INFO - Output received: 05:57:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:35 INFO - Running post-action listener: _resource_record_post_action 05:57:35 INFO - ##### 05:57:35 INFO - ##### Running run-tests step. 05:57:35 INFO - ##### 05:57:35 INFO - Running pre-action listener: _resource_record_pre_action 05:57:35 INFO - Running main action method: run_tests 05:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:35 INFO - Python 2.7.3 05:57:35 INFO - Return code: 0 05:57:35 INFO - grabbing minidump binary from tooltool 05:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:35 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 0x21d5410>, '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 0x21d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:35 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 05:57:35 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 05:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:35 INFO - Return code: 0 05:57:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:36 INFO - Return code: 0 05:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:57:36 INFO - Using env: {'DISPLAY': ':0', 05:57:36 INFO - 'HOME': '/home/cltbld', 05:57:36 INFO - 'LANG': 'en_US.UTF-8', 05:57:36 INFO - 'LANGUAGE': 'en_US:en', 05:57:36 INFO - 'LOGNAME': 'cltbld', 05:57:36 INFO - 'MAIL': '/var/mail/cltbld', 05:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:36 INFO - 'MOZ_NO_REMOTE': '1', 05:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:36 INFO - 'NO_EM_RESTART': '1', 05:57:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:36 INFO - 'PWD': '/builds/slave/test', 05:57:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:36 INFO - 'SHELL': '/bin/bash', 05:57:36 INFO - 'SHLVL': '1', 05:57:36 INFO - 'TERM': 'linux', 05:57:36 INFO - 'TMOUT': '86400', 05:57:36 INFO - 'USER': 'cltbld', 05:57:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643', 05:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:36 INFO - '_': '/tools/buildbot/bin/python'} 05:57:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:57:36 INFO - mozversion application_buildid: 20160606004039 05:57:36 INFO - mozversion application_changeset: 7f8d31a531ca31d5206f0a37528c36d1695ad767 05:57:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:36 INFO - mozversion application_name: Firefox 05:57:36 INFO - mozversion application_remotingname: firefox-dev 05:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:57:36 INFO - mozversion application_vendor: Mozilla 05:57:36 INFO - mozversion application_version: 48.0a2 05:57:36 INFO - mozversion platform_buildid: 20160606004039 05:57:36 INFO - mozversion platform_changeset: 7f8d31a531ca31d5206f0a37528c36d1695ad767 05:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:57:36 INFO - mozversion platform_version: 48.0a2 05:57:36 INFO - using testdate: 1465217856 05:57:36 INFO - actual date: 1465217856 05:57:36 INFO - starting webserver on 'localhost:44857' 05:57:36 INFO - SUITE-START | Running 2 tests 05:57:36 INFO - TEST-START | dromaeo_css 05:57:36 INFO - operating with platform_type : linux_ 05:57:36 INFO - Initialising browser for dromaeo_css test... 05:57:36 INFO - TEST-INFO | started process 15215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjfLnL/profile http://localhost:44857/getInfo.html) 05:57:39 INFO - PROCESS | 15215 | 05:57:39 INFO - PROCESS | 15215 | (process:15294): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:57:40 INFO - PROCESS | 15215 | __metrics Screen width/height:1600/1200 05:57:40 INFO - PROCESS | 15215 | colorDepth:24 05:57:40 INFO - PROCESS | 15215 | Browser inner width/height: 1024/697 05:57:40 INFO - PROCESS | 15215 | __metrics 05:57:40 ERROR - PROCESS | 15215 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 05:57:41 INFO - TEST-INFO | 15215: exit 0 05:57:41 INFO - Browser initialized. 05:57:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:41 INFO - TEST-INFO | started process 15345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQjfLnL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:43 INFO - PROCESS | 15345 | 05:57:43 INFO - PROCESS | 15345 | (process:15415): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:57:53 INFO - PROCESS | 15345 | RSS: Main: 152039424 05:57:53 INFO - PROCESS | 15345 | 05:58:42 INFO - PROCESS | 15345 | 1465217922862 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] 06:00:50 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44857/tests/dromaeo/cssquery-ext.html) 06:00:51 INFO - PROCESS | 15345 | RSS: Main: 155471872 06:00:51 INFO - PROCESS | 15345 | 06:03:53 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-ext.html (next: http://localhost:44857/tests/dromaeo/cssquery-jquery.html) 06:03:53 INFO - PROCESS | 15345 | RSS: Main: 154128384 06:03:53 INFO - PROCESS | 15345 | 06:06:55 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44857/tests/dromaeo/cssquery-mootools.html) 06:06:56 INFO - PROCESS | 15345 | RSS: Main: 153292800 06:06:56 INFO - PROCESS | 15345 | 06:09:57 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44857/tests/dromaeo/cssquery-prototype.html) 06:09:58 INFO - PROCESS | 15345 | RSS: Main: 152686592 06:09:58 INFO - PROCESS | 15345 | 06:13:00 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44857/tests/dromaeo/cssquery-yui.html) 06:13:01 INFO - PROCESS | 15345 | RSS: Main: 154296320 06:13:01 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | Cycle 1(1): loaded http://localhost:44857/tests/dromaeo/cssquery-yui.html (next: http://localhost:44857/tests/dromaeo/cssquery-dojo.html) 06:16:03 INFO - PROCESS | 15345 | RSS: Main: 155553792 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | __start_tp_report 06:16:03 INFO - PROCESS | 15345 | _x_x_mozilla_page_load 06:16:03 INFO - PROCESS | 15345 | _x_x_mozilla_page_load_details 06:16:03 INFO - PROCESS | 15345 | |i|pagename|runs| 06:16:03 INFO - PROCESS | 15345 | |0;dojo.html;3306.7354611631067;3369.578802649668;3404.7616666833333;3434.6908778209954;3440.707539859112;5623.887522249553;5641.266635337401;5662.858428539289;5672.9221447924865;5683.630564013341;5580.218769372291;5636.041872881609;5665.5467562594995;5678.914816277749;5716.428357164282;5095.210242412422;5138.409082955452;5163.3545806774155;5197.246399272103;5214.895702085956;5038.622103342245;5161.587073034167;5218.425973142951;5293.814716484924;5299.973500132494;5055.266986286986;5084.694918304914;5106.183010718286;5106.821261255856;5224.085784987612;5195.584353251749;5207.453217412174;5208.635395522315;5212.53087222148;5248.448912864133;4966.726830024347;5017.297578338999;5059.241113832918;5091;5105.974470127663;5481.75332110052;5488.231647569343;5525.613207075507;5527.419620939824;5542.11326187808;6000.069989151689;6001.1898393717165;6004.219451471325;6005.6396616203165;6028.3971602839365;5826.41735826414;6026.728797204137;6070.2412198475195;6116.031445915052;6141.140240366352;5725.083986562172;5727.455891690324;5735.254416925814;5735.77056917727;5737.225474560964;6205.348438413992;6206.565540412218;6221.2845522764555;6225.875482490324;6239.344868788802;5708.686022268732;5939.821805345847;5988.251468566429;6013.909791353133;6022;6046.879062418727;6112.602680825732;6113.32753397126;6121.265448146251;6135.60118592299;5748.367679555246;6028.638281703112;6066.666333351708;6082.908756368658;6087.117367981707;5943.405659434022;5970.104484327386;6027.638341699512;6047.213862197974;6065.150878876961;4544.341070544752;4554.95445045552;4575.908481830411;4582.198115329804;4607.76961151941;4003.919921601552;4086.836526538905;4107.199096176277;4121.319982202903;4126.690498212646;5661;5684.033714268584;5769.538436925036;5805.593608447368;5824.708764561755;6117.124563098031;6125.907024958145;6130.444112847226;6130.776598292009;6142.293636231891;5727.799527016535;5859.824205273763;5865.618734782225;5882.23530940975;5912.822615321547;5192.143296356135;5237.319148510669;5263.815766448232;5268.157094864803;5297.947020529822;6038.486728628028;6063.9090413643835;6064.787732429432;6066.029435290332;6096.451319381277;5837.94162058391;5862.970685146547;5911.438413350725;5920.5559583031445;5980.850478738066;6274.717637706223;6284.874302514016;6295.874082518416;6317.557770955989;6323.146375239284;5941.910871336847;5975.34271230173;5986.341502434641;5995.850103747442;6025.909611355921;5823.970880145572;6026.578139530191;6038.12447195163;6089.634621922699;6115.816525504242;5834.94165058361;5893.557983151195;5895.322037965689;5895.764169433174;5896.557758168069;5868.119782032729;5869.06095024794;5869.119632055055;5869.882602348014;5908.468237858613;5459.535939445192;5665.943340566707;5722.084466485342;5736.770529178786;5752.309722833287;5957;5960.8807823844145;6004.8799024020145;6010.579259451796;6020.578559500968;5837.970810145922;5869.413058694096;5882.147088672033;5891.086881533369;5898.1152827076285 06:16:03 INFO - PROCESS | 15345 | |1;ext.html;672.3713328038282;677.0825531404946;686.3136863136863;734.9448791340654;752.578556008635;40045.79977100118;40303.395449068215;40498.39252411216;40663.39004914921;40839.79580102099;43644.78177609116;44139.67580972568;44222.77888610552;44645.33032004523;44649.7767511162;8767.430117042404;8934.329925255599;8948.507832069234;8965.686200982967;8976.326775491832;8744.606492707844;8824.735257942271;8852.468851868909;9048.049954754755;9080.455172689659;9074.319426043041;9103.317251206154;9121.087891210858;9121.17909388155;9128.224100951395;9046.185843274105;9090.86363704545;9098.408603440788;9110.635574577009;9127.269818414577;8920.8661870072;9075.727728168165;9086.318526110503;9099.317551183687;9120.498372589505;44348;45167;45247.773761130986;45275.320870186646;45308.546914530765;1805.5034865411985;3855.8264878080554;3871.7483363581277;4253.02180498484;4392.450943632046;33634;33642.1589460263;33850.322993540234;34080.82959585211;34411.4838277426;4513.661475389326;4547.840825571089;4553.408056952608;4554.43069616298;4663;318522;318703;320345;320367;320385.9999999977;63290.36709632937;63469;63542;63699.36300637027;63707;72625.63687181531;73502.63248683722;74181.62909185527;74209.6289518549;74299.62850185715;17596.03221822812;17637;17685.823141768677;17701.46895593134;17796.3771268005;15530.611734706497;15688.137152456724;15702.450414235447;15719;15770;21157.365279041653;21574;21633.242836500645;21803.67294490584;21929.561408771737;7784.922150778533;7807.492512986638;7839.764807055683;7992.80017999543;8224.465409748347;1179.9469023893946;1195.9282443053444;1234.0312854409246;1235.7034311765112;1259.4521383198337;33340.66659333376;33682.8315858424;33712.831435842665;34072.659273407444;34235.31529369399;1219.5548624751902;1226.699458632623;1231.2858542045592;1264.386772415378;1284.441268048402;16179.595510112342;18073.980034614688;18425.447236582924;18541.81458185428;18639;521271;570631;582098;583874;591352;65076;65740.67129664321;65795.67102164458;66370.33629663738;66493;1555.642202293479;1560.7736878152605;1569.0507243117977;1577.345401658299;1641.9343226270814;34030.48954265638;34095.82952085224;34556.481652774724;35091.82454087815;35393.469097964065;55391;56117.71941140268;56191.438085620255;56242.718786407444;56301.71849140728;449598;456692;457035;457564;459559;31333;31423.528647069856;31646;31658.525122122726;31791.682083178872;52465.475345247585;52516.47483525269;52966;52988.470115298354;53256.73371633117;43027.784861075495;44608.553914461736;44998.77500612476;45247.321290180014;46055.53944460512;42856.5714342865;43756.78121609372;43939.78030109829;44072;44672;41042.17915641611;41616.375754364315;41657.58342416537;42126.578734212264;42165.78917105395;35821.82089089642;36599.45100823436;37095.66311991718;37358.25283494261;38272;28786.28034299159;29664.851675741484;29886.25284367908;29964.400711986073;30108.69891301059 06:16:03 INFO - PROCESS | 15345 | |2;jquery.html;419.40235164890026;427.7903827124708;428.42163079842237;432.08182611949604;433.78744415236525;18677.81322186778;19522.41432757016;19523.70714439283;20008.799912000875;20783.16867325305;19344.903275483604;19465.70801437976;19509.902450487763;19774.901125494387;19780.703289450634;5150.639455238125;5400.29796126503;5456;6112.510999120082;6113.021916493362;5924;6000.879982400349;6006.369331220225;6019.969900150493;6043.75824967003;5326.2543243945875;5363.839084827442;5366.248725178478;5997.940020599804;6007.948608993431;5323.1749078892835;5359.705216213126;5369.62412631116;5372.274742909696;5407.188921661763;5144.794208231666;5167.3282473278605;5169.405518365398;5478.068728316196;5485.533729632986;23456.882715586482;23575.88212058946;23959.640605390934;24167.15414960468;24426.267211983668;2446.3028037009367;2447.3025187821386;2481.466484705797;2483.2301986384277;2529.3423709835392;9324.25405967521;9883.258755593359;9965.850512242323;10035.29752917296;10245.385276883411;1917.3289348727974;1958.5103724068983;2022.8179463848323;2029.289748587997;2042.3056160905214;62069;70849;71900.6404967977;73000;82204.58897705533;11345;11478.655640330804;11559.133065020158;11594.536218551331;11701.180917335874;16278.348866045462;16566.917165414096;16568.088755118344;16580.502584922473;16589.087600181865;8599.484030958163;8649.394542381973;8662.480251184948;8838.337124715543;8855.158759917798;8431.15688431152;8475.788105297417;8485.830283394422;8535.402521823537;8695.826083478294;4997.950020499821;5029.446760856303;5051.595872330205;5063.93657331957;5118.10433174193;1946.912388942501;2046.5088378788982;2068.844836637258;2112.186808078901;2134.914603415877;990.5790039233441;1142.9428528573537;1208.9637310880687;1216.015027827445;1216.4100411300512;18914.81085189158;18950.81049189518;19190.904045479685;19578.21687132499;19722.802771972096;1031.783325501653;1081.259337353915;1095.1293721491434;1110.7611863449397;1116.9497372618252;10656.360618362924;10963.397013164353;10981.890181098086;11028.28316159447;11169.441527923735;494523;496565;503346;528168;557897;89345.55327223323;94748.52625736827;98933.50533247288;99854.50072749589;101423.49288253511;1045.8954104589632;1081.3944191252924;1104.0339702760245;1115.2583531951161;1122.6239209864787;17781.377651782124;18285;18368.357107501175;18406.447806565826;18734.25062997465;40964.38553421642;41113.1777364457;42607.1478570433;43045.3543196846;44098.338524922794;63679.68160159169;63700.68149659407;63797.362026381;63954;64103.35896641161;7758.146603873456;7829.804254893673;7872.685092596461;8065.556394398364;8367.95816020916;12747.681307967376;13527.797083043566;13794.310284485937;13903.235322056978;13928.442862285801;11416.82874756896;11819.11356648272;11864.406779661154;12074.939625301817;12743.10798244114;8051.83896322082;11615;11745.530178792753;11747.706307342385;11765.294082355085;12283.631491055283;12385.071119666241;12431;12498.187617804813;12537.059720520814;8451.535165565707;8610.311175105851;8724.69463568772;8743.213110819803;8819.470831750115;11410.771784564427;11990.880091198977;11993.580224692094;12227.69430764238;12277.877221227673 06:16:03 INFO - PROCESS | 15345 | |3;mootools.html;1630.5597488678056;1642.2773979449037;1849.8427633651138;1910.3218357483101;1947.5423275530238;7696.96151519243;8713.433626814252;8915.777105572364;9111.58997845097;9181.678641247567;7404.2225566315565;8319.168083191678;8518.105598912118;8817;8940.59767310471;2389.378761522004;2405.5790236708594;2415.5651982643117;2431.7081950166007;2434.294054724128;2406.711194656644;2444.2422848916804;2497.862617556034;2503.161440917295;2507.849529028255;2405.56699794037;2441.5361081394476;2462.212092130519;2470.258922323296;2473.5423946569854;2373.608354621494;2409.0363854458183;2409.77107174819;2444.4133407982135;2463.5442443148077;2422.7940625046717;2493.1772515069983;2499.600063989753;2516;2516.1822407717564;9125.589348479334;9152.908470915272;9189.218916392114;9203.40177888435;9222.953885230598;5475.7262136893;5627.54979601635;5652.74562644682;5658.773649054033;5680.0627896397045;3481.617022127564;3576.159602493412;3582.874599389009;3594.245208506217;3606.963930360689;1047.0419566097012;1051.9211059170516;1062.219268837404;1070.7376692710259;1092.4756117063853;12969.286689232089;13119.934400328033;13147.868521314856;13163.86836131636;13179.472821087145;4797.376341075707;4816.903661926812;4862;4878.243872199815;4924.482929292372;11105.278156919774;11287.20989530725;11289.774204515863;11302.039326657326;11321.490532926038;5665.206871038058;5679.659220446786;5703.914441283384;5707.715763953077;5710.65736055838;4336.349547567827;4966.6771659842;5041;5107.361579802525;5198.350206224222;4270.145970805851;4318.978405107954;4346.913061738811;4385.6710746694125;4389.209942210433;1337.5452346202337;1370.9862901371057;1387.1607677355257;1399.5451478269604;1421.9075760075561;1014.7868947521104;1028.717102796737;1029.6447725534679;1046.9214808889212;1047.6438011076118;6010.909836352458;6044.576879618385;6053.818385448443;6141.868080927878;6258.249010118815;436.3912342282498;448.76439869069;1039.194624166262;1044.7597052677775;1057.127869507644;4000.7799571023293;4058.6955978301153;4125.278076336629;4141.171765646883;4150.066235097079;10890.074343680717;11197.49611267495;11239.04468120219;11241.775164496828;11273.098152147808;11107.611233606947;11109.500072496758;11151.498182581803;11152.386618735885;11197.16021298406;8387.370947178864;8627.611757470804;8675.479471231747;8765.824683506295;8771.122887711177;5893.116032594973;5894.793682221273;5944.256967879015;5978.3722709116655;6174.44430001302;9722.125008749246;9746.220302375934;9819.852702209615;9891.35706179096;9993.650222242186;9925.255605829736;10000.749981250527;10035.548400321857;10055.798884022424;10129;7047.083879095685;7614.771556853303;7859.567723775019;7979.002624671916;8075.313598344206;8622.353323500887;8634.266087382643;8641;8659.307255419426;8701.390902636755;7582;7801.9609901950125;7880.763577092696;7887.802804929693;7970.4819186752675;7646.502977306457;7867.9606601966625;7872.37021038327;7904.091029531677;7935.682572697027;7284.817879553054;7297.160826504807;7368.778936631909;7493.737719179802;7499.8500029998;5189.325387699726;5200.271961925409;5315.601329900195;5328.60035497347;5333.839984800462;5202.869928251824;5420.4850539198715;5455.918161227664;5487.75305111279;5592.02139625572 06:16:03 INFO - PROCESS | 15345 | |4;prototype.html;335.73546429334147;341.6600482519892;343.38779430573453;343.79715967579125;345.4524578543009;6547.312532184112;6621.6689165541775;6642.43539299159;6711.362420570044;6719.092922455461;6653.866922661544;6704.932950670492;6707.899381509281;6708.26209116998;6720.260771315151;4958.826441074554;4973.179425394824;4981.626378021645;4986.725730084844;4994.450610432849;4989.600831933455;4996.900061998758;4996.925046124311;5001.1248031594505;5002.199648056312;4933.481984391641;4940;4941.937483441059;4945.7774400152075;4948.505149485059;4715.3634259374885;4861.975690121562;4897.363342765453;4906.215005599105;4941.160002799515;4146.108586653884;4167.083241686854;4170.52039015511;4171.165766846643;4173.707840451139;6298.68506574674;6317.526185536103;6343.777967771106;6347.746090156388;6354.046892966046;5695.658260504383;5711.7144142792695;5713.200151978726;5727.455891690282;5727.627704199255;6945.201301850301;6994.370506654425;7020.052292940439;7033;7042.859142817115;4533.184026875161;4656.068786242731;4660.231061874787;4677.064587082597;4678.929816052762;7268.200497945222;7295.817604559876;7339.88990165148;7351.963240183765;7365.2634736525915;4713.622910167179;4715.269133284278;4716.528347165325;4720.952790472052;4725.669203155815;4759.904801904012;4784.114938736345;4784.904301913943;4787.01866117452;4788.664793464424;5649.576281778801;5650.63270887391;5655.066913959151;5660.462256085665;5664.830055098354;6945.7221711132;7042.6126563039525;7062.081929349254;7068.611226382495;7074.610896400644;1684.1915880377242;1690.518202312335;1697.949061528156;1709.376077731619;1709.487153853839;1017.3590637898077;1070.0369667299337;1079.838024296346;1082.7509672775147;1088.586337191862;6753.527253092335;6957.095577574883;6964.303569643096;6964.4080253179045;6976.232614412411;7376.631168441664;7383.6677349519405;7392.926070739224;7403.2226616204525;7412.073490813648;6923.584584924921;6931.965340173267;6934.16789985205;6934.583924964519;6940.236573976858;3918.941215881764;3926.312895243321;3961.088949541622;3988.521377434726;3989.5810939851476;7665.156832748505;7668.53988760665;7669.348105411103;7677.424193185533;7684.231576842383;7463.619230442386;7489.812754681067;7499.737509187262;7528.397728181732;7535.095788505305;7628.504147230412;7642.5032372894475;7643.617819109022;7648.158702542716;7655.425843061793;7210.53437149757;7262.96368518154;7334.449916256409;7335.449841262033;7359.227281135403;7125.251848555827;7175.964120179575;7224;7224.241454647186;7224.74713385029;7603.467757256939;7610.505317154367;7611.771646850603;7632.122305934889;7637.809054773675;4751.216049351819;4757.500462451393;4761.214399624023;4762.571368576845;4766.952330476651;7078.86738121898;7319.890201647086;7325.7802265932105;7330.560166390033;7339.045924029842;7026.402755765817;7038.859222815618;7040.577565346096;7064.399526040139;7069.399101076466;6963.025176475398;7003;7068.71725130989;7070;7080.468964827555;6804.387605115563;6810.455163587;6831.248562658005;6849.520533562602;6852.109225800614;6931.792046238621;7128.108986376703;7139.07192065049;7151.964240178766;7162.391196748335;6808.9659551701925;6938.895916561357;6982.162140543167;6990.720371185095;7002.719891204295 06:16:03 INFO - PROCESS | 15345 | |5;yui.html;893.3210759822533;902.6163880350849;923.4551614547415;929.6049179098882;929.6839074714595;15201.771973420407;15462.536123916272;15558.45545405911;15578.610534736637;15639.218039098043;14235.145891246533;14370.640733981656;14629.268536573181;14709.11745295283;14721.558353249393;775.9650815713306;898.8067565473422;907.8093600343935;916.9083091690844;928.067292371166;901.7700486375965;901.8196360727848;906.0622255965078;906.4561263242068;909.4497828813571;967.6564819489085;967.9884520675876;968.3076600230834;970.0638883477443;971.0435221307007;955.5222388805597;960.6685693435753;961.9947155222809;963.9373440726365;964.1852634523816;701.0115736811123;704.1514974455769;710.6766421278306;711.6904146696152;714.0538786108375;15303.923480382527;15335.463258785889;15399;15423.768643470357;15551.922240388838;15110.848891511165;15127.621809454742;15193.924030379889;15328.23358832054;15390.230488475643;12371.381430928508;12458.688532786662;12506.686797886274;12557.372131393393;12704.618861434172;4095.5904409559103;4101.425800387948;4106.7946602669745;4110.979445102756;4134.751914885086;57307.713461432846;57447.42552574504;61898;62337;62398.68800655968;12016.519339226334;12089.335086570323;12255.325957072268;12270.631881043404;12397;22255.666165007537;22406.215782447864;22434.21480248216;22471.66292505614;22496.32511024672;8883.57862741971;8886.333524985652;9093.090690930987;9247.352685312098;9259.444433334022;5026;5093.567046801063;5109.514596113363;5126.077306084941;5157.845264641992;3522.172289511963;3591.174029973121;3614.331348700499;3614.331348700499;3615.132368231658;622.2657264427928;626.5989766549412;638.4828289085856;646.8188907106017;654.6497623771355;826.6734639817358;840.8192238668715;843.8185790055045;859.1751918158637;867.0679020053468;10090.243231757648;10204;10309.94845025785;10382.844257336146;10420;826.9793255168548;828.6105530400702;829.4401279136558;834.1200033964104;846.9788255293544;4545.2954792007295;4719.244920812722;4815.181419158752;4834.395700537433;4837.177679794443;64769.35230647633;66400.33599664038;66696;66802;67242;58818;60546.69726651427;61678.383216168164;61728.69135654383;61830;52471.73764131231;53003.469965300625;55417;55793;57369.13946290725;9418.152366287068;9437.622495100119;9610.423374597547;9619.422834629944;9730.562124704547;39404.60595394124;40367;40894.591054089076;41099.7945010273;41477;47986.52013479821;52484;52849;53396;53517.46482535125;12140.817887731515;12244.938775306067;12293.93853030729;12463.813042804184;12557.434915428645;13094.410751516396;13724.176549407068;13783.379747911167;13787.310634468437;13812.309384530934;12283.570075047688;12306;12358.382080895739;12546.874531254936;12588.87411125877;11430.599929002445;11683.415829208336;11696.88303116958;11785.233959792586;12269;12138.150329477205;12243.326617035793;12281.93859030699;12302.753944920873;12431.005519558234;10449.9477502612;10533.578656853946;10630.8405373921;10672.733181670521;10721.249512534048;10297.3821570706;10679.252452328263;10777.89222107769;10790.67627971162;10824.729381765204 06:16:03 INFO - PROCESS | 15345 | __end_tp_report 06:16:03 INFO - PROCESS | 15345 | __start_cc_report 06:16:03 INFO - PROCESS | 15345 | _x_x_mozilla_cycle_collect,344 06:16:03 INFO - PROCESS | 15345 | __end_cc_report 06:16:03 INFO - PROCESS | 15345 | __startTimestamp1465218963806__endTimestamp 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | ------- Summary: start ------- 06:16:03 INFO - PROCESS | 15345 | Number of tests: 6 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#0] dojo.html Cycles:165 Average:5612.62 Median:5837.97 stddev:625.32 (10.7%) stddev-sans-first:600.51 06:16:03 INFO - PROCESS | 15345 | Values: 3306.7 3369.6 3404.8 3434.7 3440.7 5623.9 5641.3 5662.9 5672.9 5683.6 5580.2 5636.0 5665.5 5678.9 5716.4 5095.2 5138.4 5163.4 5197.2 5214.9 5038.6 5161.6 5218.4 5293.8 5300.0 5055.3 5084.7 5106.2 5106.8 5224.1 5195.6 5207.5 5208.6 5212.5 5248.4 4966.7 5017.3 5059.2 5091.0 5106.0 5481.8 5488.2 5525.6 5527.4 5542.1 6000.1 6001.2 6004.2 6005.6 6028.4 5826.4 6026.7 6070.2 6116.0 6141.1 5725.1 5727.5 5735.3 5735.8 5737.2 6205.3 6206.6 6221.3 6225.9 6239.3 5708.7 5939.8 5988.3 6013.9 6022.0 6046.9 6112.6 6113.3 6121.3 6135.6 5748.4 6028.6 6066.7 6082.9 6087.1 5943.4 5970.1 6027.6 6047.2 6065.2 4544.3 4555.0 4575.9 4582.2 4607.8 4003.9 4086.8 4107.2 4121.3 4126.7 5661.0 5684.0 5769.5 5805.6 5824.7 6117.1 6125.9 6130.4 6130.8 6142.3 5727.8 5859.8 5865.6 5882.2 5912.8 5192.1 5237.3 5263.8 5268.2 5297.9 6038.5 6063.9 6064.8 6066.0 6096.5 5837.9 5863.0 5911.4 5920.6 5980.9 6274.7 6284.9 6295.9 6317.6 6323.1 5941.9 5975.3 5986.3 5995.9 6025.9 5824.0 6026.6 6038.1 6089.6 6115.8 5834.9 5893.6 5895.3 5895.8 5896.6 5868.1 5869.1 5869.1 5869.9 5908.5 5459.5 5665.9 5722.1 5736.8 5752.3 5957.0 5960.9 6004.9 6010.6 6020.6 5838.0 5869.4 5882.1 5891.1 5898.1 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#1] ext.html Cycles:180 Average:62706.63 Median:44105.84 stddev:122094.85 (276.8%) stddev-sans-first:122348.52 06:16:03 INFO - PROCESS | 15345 | Values: 672.4 677.1 686.3 734.9 752.6 40045.8 40303.4 40498.4 40663.4 40839.8 43644.8 44139.7 44222.8 44645.3 44649.8 8767.4 8934.3 8948.5 8965.7 8976.3 8744.6 8824.7 8852.5 9048.0 9080.5 9074.3 9103.3 9121.1 9121.2 9128.2 9046.2 9090.9 9098.4 9110.6 9127.3 8920.9 9075.7 9086.3 9099.3 9120.5 44348.0 45167.0 45247.8 45275.3 45308.5 1805.5 3855.8 3871.7 4253.0 4392.5 33634.0 33642.2 33850.3 34080.8 34411.5 4513.7 4547.8 4553.4 4554.4 4663.0 318522.0 318703.0 320345.0 320367.0 320386.0 63290.4 63469.0 63542.0 63699.4 63707.0 72625.6 73502.6 74181.6 74209.6 74299.6 17596.0 17637.0 17685.8 17701.5 17796.4 15530.6 15688.1 15702.5 15719.0 15770.0 21157.4 21574.0 21633.2 21803.7 21929.6 7784.9 7807.5 7839.8 7992.8 8224.5 1179.9 1195.9 1234.0 1235.7 1259.5 33340.7 33682.8 33712.8 34072.7 34235.3 1219.6 1226.7 1231.3 1264.4 1284.4 16179.6 18074.0 18425.4 18541.8 18639.0 521271.0 570631.0 582098.0 583874.0 591352.0 65076.0 65740.7 65795.7 66370.3 66493.0 1555.6 1560.8 1569.1 1577.3 1641.9 34030.5 34095.8 34556.5 35091.8 35393.5 55391.0 56117.7 56191.4 56242.7 56301.7 449598.0 456692.0 457035.0 457564.0 459559.0 31333.0 31423.5 31646.0 31658.5 31791.7 52465.5 52516.5 52966.0 52988.5 53256.7 43027.8 44608.6 44998.8 45247.3 46055.5 42856.6 43756.8 43939.8 44072.0 44672.0 41042.2 41616.4 41657.6 42126.6 42165.8 35821.8 36599.5 37095.7 37358.3 38272.0 28786.3 29664.9 29886.3 29964.4 30108.7 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#2] jquery.html Cycles:180 Average:29971.59 Median:13436.29 stddev:85058.73 (633.1%) stddev-sans-first:85268.40 06:16:03 INFO - PROCESS | 15345 | Values: 419.4 427.8 428.4 432.1 433.8 18677.8 19522.4 19523.7 20008.8 20783.2 19344.9 19465.7 19509.9 19774.9 19780.7 5150.6 5400.3 5456.0 6112.5 6113.0 5924.0 6000.9 6006.4 6020.0 6043.8 5326.3 5363.8 5366.2 5997.9 6007.9 5323.2 5359.7 5369.6 5372.3 5407.2 5144.8 5167.3 5169.4 5478.1 5485.5 23456.9 23575.9 23959.6 24167.2 24426.3 2446.3 2447.3 2481.5 2483.2 2529.3 9324.3 9883.3 9965.9 10035.3 10245.4 1917.3 1958.5 2022.8 2029.3 2042.3 62069.0 70849.0 71900.6 73000.0 82204.6 11345.0 11478.7 11559.1 11594.5 11701.2 16278.3 16566.9 16568.1 16580.5 16589.1 8599.5 8649.4 8662.5 8838.3 8855.2 8431.2 8475.8 8485.8 8535.4 8695.8 4998.0 5029.4 5051.6 5063.9 5118.1 1946.9 2046.5 2068.8 2112.2 2134.9 990.6 1142.9 1209.0 1216.0 1216.4 18914.8 18950.8 19190.9 19578.2 19722.8 1031.8 1081.3 1095.1 1110.8 1116.9 10656.4 10963.4 10981.9 11028.3 11169.4 494523.0 496565.0 503346.0 528168.0 557897.0 89345.6 94748.5 98933.5 99854.5 101423.5 1045.9 1081.4 1104.0 1115.3 1122.6 17781.4 18285.0 18368.4 18406.4 18734.3 40964.4 41113.2 42607.1 43045.4 44098.3 63679.7 63700.7 63797.4 63954.0 64103.4 7758.1 7829.8 7872.7 8065.6 8368.0 12747.7 13527.8 13794.3 13903.2 13928.4 11416.8 11819.1 11864.4 12074.9 12743.1 8051.8 11615.0 11745.5 11747.7 11765.3 12283.6 12385.1 12431.0 12498.2 12537.1 8451.5 8610.3 8724.7 8743.2 8819.5 11410.8 11990.9 11993.6 12227.7 12277.9 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#3] mootools.html Cycles:180 Average:5976.27 Median:4807.14 stddev:3368.78 (70.1%) stddev-sans-first:3362.40 06:16:03 INFO - PROCESS | 15345 | Values: 1630.6 1642.3 1849.8 1910.3 1947.5 7697.0 8713.4 8915.8 9111.6 9181.7 7404.2 8319.2 8518.1 8817.0 8940.6 2389.4 2405.6 2415.6 2431.7 2434.3 2406.7 2444.2 2497.9 2503.2 2507.8 2405.6 2441.5 2462.2 2470.3 2473.5 2373.6 2409.0 2409.8 2444.4 2463.5 2422.8 2493.2 2499.6 2516.0 2516.2 9125.6 9152.9 9189.2 9203.4 9223.0 5475.7 5627.5 5652.7 5658.8 5680.1 3481.6 3576.2 3582.9 3594.2 3607.0 1047.0 1051.9 1062.2 1070.7 1092.5 12969.3 13119.9 13147.9 13163.9 13179.5 4797.4 4816.9 4862.0 4878.2 4924.5 11105.3 11287.2 11289.8 11302.0 11321.5 5665.2 5679.7 5703.9 5707.7 5710.7 4336.3 4966.7 5041.0 5107.4 5198.4 4270.1 4319.0 4346.9 4385.7 4389.2 1337.5 1371.0 1387.2 1399.5 1421.9 1014.8 1028.7 1029.6 1046.9 1047.6 6010.9 6044.6 6053.8 6141.9 6258.2 436.4 448.8 1039.2 1044.8 1057.1 4000.8 4058.7 4125.3 4141.2 4150.1 10890.1 11197.5 11239.0 11241.8 11273.1 11107.6 11109.5 11151.5 11152.4 11197.2 8387.4 8627.6 8675.5 8765.8 8771.1 5893.1 5894.8 5944.3 5978.4 6174.4 9722.1 9746.2 9819.9 9891.4 9993.7 9925.3 10000.7 10035.5 10055.8 10129.0 7047.1 7614.8 7859.6 7979.0 8075.3 8622.4 8634.3 8641.0 8659.3 8701.4 7582.0 7802.0 7880.8 7887.8 7970.5 7646.5 7868.0 7872.4 7904.1 7935.7 7284.8 7297.2 7368.8 7493.7 7499.9 5189.3 5200.3 5315.6 5328.6 5333.8 5202.9 5420.5 5455.9 5487.8 5592.0 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#4] prototype.html Cycles:180 Average:5854.43 Median:6778.96 stddev:1842.15 (27.2%) stddev-sans-first:1800.14 06:16:03 INFO - PROCESS | 15345 | Values: 335.7 341.7 343.4 343.8 345.5 6547.3 6621.7 6642.4 6711.4 6719.1 6653.9 6704.9 6707.9 6708.3 6720.3 4958.8 4973.2 4981.6 4986.7 4994.5 4989.6 4996.9 4996.9 5001.1 5002.2 4933.5 4940.0 4941.9 4945.8 4948.5 4715.4 4862.0 4897.4 4906.2 4941.2 4146.1 4167.1 4170.5 4171.2 4173.7 6298.7 6317.5 6343.8 6347.7 6354.0 5695.7 5711.7 5713.2 5727.5 5727.6 6945.2 6994.4 7020.1 7033.0 7042.9 4533.2 4656.1 4660.2 4677.1 4678.9 7268.2 7295.8 7339.9 7352.0 7365.3 4713.6 4715.3 4716.5 4721.0 4725.7 4759.9 4784.1 4784.9 4787.0 4788.7 5649.6 5650.6 5655.1 5660.5 5664.8 6945.7 7042.6 7062.1 7068.6 7074.6 1684.2 1690.5 1697.9 1709.4 1709.5 1017.4 1070.0 1079.8 1082.8 1088.6 6753.5 6957.1 6964.3 6964.4 6976.2 7376.6 7383.7 7392.9 7403.2 7412.1 6923.6 6932.0 6934.2 6934.6 6940.2 3918.9 3926.3 3961.1 3988.5 3989.6 7665.2 7668.5 7669.3 7677.4 7684.2 7463.6 7489.8 7499.7 7528.4 7535.1 7628.5 7642.5 7643.6 7648.2 7655.4 7210.5 7263.0 7334.4 7335.4 7359.2 7125.3 7176.0 7224.0 7224.2 7224.7 7603.5 7610.5 7611.8 7632.1 7637.8 4751.2 4757.5 4761.2 4762.6 4767.0 7078.9 7319.9 7325.8 7330.6 7339.0 7026.4 7038.9 7040.6 7064.4 7069.4 6963.0 7003.0 7068.7 7070.0 7080.5 6804.4 6810.5 6831.2 6849.5 6852.1 6931.8 7128.1 7139.1 7152.0 7162.4 6809.0 6938.9 6982.2 6990.7 7002.7 06:16:03 INFO - PROCESS | 15345 | 06:16:03 INFO - PROCESS | 15345 | [#5] yui.html Cycles:180 Average:16131.68 Median:4632.27 stddev:18957.22 (409.2%) stddev-sans-first:18975.86 06:16:03 INFO - PROCESS | 15345 | Values: 893.3 902.6 923.5 929.6 929.7 15201.8 15462.5 15558.5 15578.6 15639.2 14235.1 14370.6 14629.3 14709.1 14721.6 776.0 898.8 907.8 916.9 928.1 901.8 901.8 906.1 906.5 909.4 967.7 968.0 968.3 970.1 971.0 955.5 960.7 962.0 963.9 964.2 701.0 704.2 710.7 711.7 714.1 15303.9 15335.5 15399.0 15423.8 15551.9 15110.8 15127.6 15193.9 15328.2 15390.2 12371.4 12458.7 12506.7 12557.4 12704.6 4095.6 4101.4 4106.8 4111.0 4134.8 57307.7 57447.4 61898.0 62337.0 62398.7 12016.5 12089.3 12255.3 12270.6 12397.0 22255.7 22406.2 22434.2 22471.7 22496.3 8883.6 8886.3 9093.1 9247.4 9259.4 5026.0 5093.6 5109.5 5126.1 5157.8 3522.2 3591.2 3614.3 3614.3 3615.1 622.3 626.6 638.5 646.8 654.6 826.7 840.8 843.8 859.2 867.1 10090.2 10204.0 10309.9 10382.8 10420.0 827.0 828.6 829.4 834.1 847.0 4545.3 4719.2 4815.2 4834.4 4837.2 64769.4 66400.3 66696.0 66802.0 67242.0 58818.0 60546.7 61678.4 61728.7 61830.0 52471.7 53003.5 55417.0 55793.0 57369.1 9418.2 9437.6 9610.4 9619.4 9730.6 39404.6 40367.0 40894.6 41099.8 41477.0 47986.5 52484.0 52849.0 53396.0 53517.5 12140.8 12244.9 12293.9 12463.8 12557.4 13094.4 13724.2 13783.4 13787.3 13812.3 12283.6 12306.0 12358.4 12546.9 12588.9 11430.6 11683.4 11696.9 11785.2 12269.0 12138.2 12243.3 12281.9 12302.8 12431.0 10449.9 10533.6 10630.8 10672.7 10721.2 10297.4 10679.3 10777.9 10790.7 10824.7 06:16:03 INFO - PROCESS | 15345 | -------- Summary: end -------- 06:16:03 INFO - PROCESS | 15345 | 06:16:04 INFO - TEST-INFO | 15345: exit 0 06:16:04 INFO - TEST-OK | dromaeo_css | took 1108133ms 06:16:04 INFO - TEST-START | kraken 06:16:04 INFO - operating with platform_type : linux_ 06:16:04 INFO - Initialising browser for kraken test... 06:16:04 INFO - TEST-INFO | started process 15587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWb8eF_/profile http://localhost:44857/getInfo.html) 06:16:07 INFO - PROCESS | 15587 | 06:16:07 INFO - PROCESS | 15587 | (process:15665): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:08 INFO - PROCESS | 15587 | __metrics Screen width/height:1600/1200 06:16:08 INFO - PROCESS | 15587 | colorDepth:24 06:16:08 INFO - PROCESS | 15587 | Browser inner width/height: 1024/697 06:16:08 INFO - PROCESS | 15587 | __metrics 06:16:08 ERROR - PROCESS | 15587 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:16:09 INFO - TEST-INFO | 15587: exit 0 06:16:09 INFO - Browser initialized. 06:16:09 INFO - Running cycle 1/1 for kraken test... 06:16:09 INFO - TEST-INFO | started process 15716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWb8eF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:11 INFO - PROCESS | 15716 | 06:16:11 INFO - PROCESS | 15716 | (process:15788): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:21 INFO - PROCESS | 15716 | RSS: Main: 152297472 06:16:21 INFO - PROCESS | 15716 | 06:16:24 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44857/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:24 INFO - PROCESS | 15716 | RSS: Main: 157114368 06:16:24 INFO - PROCESS | 15716 | 06:16:27 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44857/tests/kraken/driver.html?testName=audio-dft) 06:16:28 INFO - PROCESS | 15716 | RSS: Main: 156909568 06:16:28 INFO - PROCESS | 15716 | 06:16:31 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44857/tests/kraken/driver.html?testName=audio-fft) 06:16:31 INFO - PROCESS | 15716 | RSS: Main: 156880896 06:16:31 INFO - PROCESS | 15716 | 06:16:33 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44857/tests/kraken/driver.html?testName=audio-oscillator) 06:16:34 INFO - PROCESS | 15716 | RSS: Main: 156700672 06:16:34 INFO - PROCESS | 15716 | 06:16:36 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:37 INFO - PROCESS | 15716 | RSS: Main: 156721152 06:16:37 INFO - PROCESS | 15716 | 06:16:40 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44857/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:40 INFO - PROCESS | 15716 | RSS: Main: 157319168 06:16:40 INFO - PROCESS | 15716 | 06:16:44 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44857/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:44 INFO - PROCESS | 15716 | RSS: Main: 157020160 06:16:44 INFO - PROCESS | 15716 | 06:16:47 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44857/tests/kraken/driver.html?testName=json-parse-financial) 06:16:48 INFO - PROCESS | 15716 | RSS: Main: 157728768 06:16:48 INFO - PROCESS | 15716 | 06:16:49 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:50 INFO - PROCESS | 15716 | RSS: Main: 157270016 06:16:50 INFO - PROCESS | 15716 | 06:16:52 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:52 INFO - PROCESS | 15716 | RSS: Main: 157134848 06:16:52 INFO - PROCESS | 15716 | 06:16:54 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:55 INFO - PROCESS | 15716 | RSS: Main: 157274112 06:16:55 INFO - PROCESS | 15716 | 06:16:57 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:58 INFO - PROCESS | 15716 | RSS: Main: 158089216 06:16:58 INFO - PROCESS | 15716 | 06:17:01 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:01 INFO - PROCESS | 15716 | RSS: Main: 157995008 06:17:01 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:44857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44857/tests/kraken/driver.html?testName=ai-astar) 06:17:03 INFO - PROCESS | 15716 | RSS: Main: 159326208 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | __start_tp_report 06:17:03 INFO - PROCESS | 15716 | _x_x_mozilla_page_load 06:17:03 INFO - PROCESS | 15716 | _x_x_mozilla_page_load_details 06:17:03 INFO - PROCESS | 15716 | |i|pagename|runs| 06:17:03 INFO - PROCESS | 15716 | |0;ai-astar;107;111;102;109;109;111;100;109;109;109 06:17:03 INFO - PROCESS | 15716 | |1;audio-beat-detection;177;133;158;173;127;149;154;129;197;123 06:17:03 INFO - PROCESS | 15716 | |2;audio-dft;164;163;164;163;161;162;164;164;162;160 06:17:03 INFO - PROCESS | 15716 | |3;audio-fft;74;74;77;191;74;76;77;73;173;76 06:17:03 INFO - PROCESS | 15716 | |4;audio-oscillator;98;92;152;93;93;93;140;93;92;140 06:17:03 INFO - PROCESS | 15716 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;117;117;117 06:17:03 INFO - PROCESS | 15716 | |6;imaging-darkroom;147;147;146;147;147;147;148;147;147;147 06:17:03 INFO - PROCESS | 15716 | |7;imaging-desaturate;95;95;95;100;97;95;97;95;95;95 06:17:03 INFO - PROCESS | 15716 | |8;json-parse-financial;57;57;58;56;58;58;60;73;55;56 06:17:03 INFO - PROCESS | 15716 | |9;json-stringify-tinderbox;57;59;58;59;58;59;58;58;58;59 06:17:03 INFO - PROCESS | 15716 | |10;stanford-crypto-aes;74;72;73;74;76;73;74;74;73;73 06:17:03 INFO - PROCESS | 15716 | |11;stanford-crypto-ccm;114;119;113;122;126;126;114;122;126;136 06:17:03 INFO - PROCESS | 15716 | |12;stanford-crypto-pbkdf2;162;158;157;159;158;160;158;158;157;156 06:17:03 INFO - PROCESS | 15716 | |13;stanford-crypto-sha256-iterative;68;68;66;66;70;64;66;66;68;65 06:17:03 INFO - PROCESS | 15716 | __end_tp_report 06:17:03 INFO - PROCESS | 15716 | __start_cc_report 06:17:03 INFO - PROCESS | 15716 | _x_x_mozilla_cycle_collect,857 06:17:03 INFO - PROCESS | 15716 | __end_cc_report 06:17:03 INFO - PROCESS | 15716 | __startTimestamp1465219023614__endTimestamp 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | ------- Summary: start ------- 06:17:03 INFO - PROCESS | 15716 | Number of tests: 14 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.69 (3.4%) stddev-sans-first:3.91 06:17:03 INFO - PROCESS | 15716 | Values: 107.0 111.0 102.0 109.0 109.0 111.0 100.0 109.0 109.0 109.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:156.00 stddev:24.71 (15.8%) stddev-sans-first:24.50 06:17:03 INFO - PROCESS | 15716 | Values: 177.0 133.0 158.0 173.0 127.0 149.0 154.0 129.0 197.0 123.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.50 stddev:1.42 (0.9%) stddev-sans-first:1.42 06:17:03 INFO - PROCESS | 15716 | Values: 164.0 163.0 164.0 163.0 161.0 162.0 164.0 164.0 162.0 160.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#3] audio-fft Cycles:10 Average:96.50 Median:75.00 stddev:45.28 (60.4%) stddev-sans-first:47.29 06:17:03 INFO - PROCESS | 15716 | Values: 74.0 74.0 77.0 191.0 74.0 76.0 77.0 73.0 173.0 76.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.70 (26.6%) stddev-sans-first:25.90 06:17:03 INFO - PROCESS | 15716 | Values: 98.0 92.0 152.0 93.0 93.0 93.0 140.0 93.0 92.0 140.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:17:03 INFO - PROCESS | 15716 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 06:17:03 INFO - PROCESS | 15716 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.66 (1.8%) stddev-sans-first:1.73 06:17:03 INFO - PROCESS | 15716 | Values: 95.0 95.0 95.0 100.0 97.0 95.0 97.0 95.0 95.0 95.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:5.18 (8.9%) stddev-sans-first:5.45 06:17:03 INFO - PROCESS | 15716 | Values: 57.0 57.0 58.0 56.0 58.0 58.0 60.0 73.0 55.0 56.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.50 stddev:0.67 (1.2%) stddev-sans-first:0.53 06:17:03 INFO - PROCESS | 15716 | Values: 57.0 59.0 58.0 59.0 58.0 59.0 58.0 58.0 58.0 59.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 06:17:03 INFO - PROCESS | 15716 | Values: 74.0 72.0 73.0 74.0 76.0 73.0 74.0 74.0 73.0 73.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:124.00 stddev:7.16 (5.8%) stddev-sans-first:7.02 06:17:03 INFO - PROCESS | 15716 | Values: 114.0 119.0 113.0 122.0 126.0 126.0 114.0 122.0 126.0 136.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.00 stddev:1.70 (1.1%) stddev-sans-first:1.17 06:17:03 INFO - PROCESS | 15716 | Values: 162.0 158.0 157.0 159.0 158.0 160.0 158.0 158.0 157.0 156.0 06:17:03 INFO - PROCESS | 15716 | 06:17:03 INFO - PROCESS | 15716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.77 (2.6%) stddev-sans-first:1.81 06:17:03 INFO - PROCESS | 15716 | Values: 68.0 68.0 66.0 66.0 70.0 64.0 66.0 66.0 68.0 65.0 06:17:03 INFO - PROCESS | 15716 | -------- Summary: end -------- 06:17:03 INFO - PROCESS | 15716 | 06:17:04 INFO - TEST-INFO | 15716: exit 0 06:17:04 INFO - TEST-OK | kraken | took 60066ms 06:17:04 INFO - SUITE-END | took 1168s 06:17:04 INFO - Completed test suite (00:19:28) 06:17:04 INFO - javascript benchmark 06:17:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.7354611631067, 3369.578802649668, 3404.7616666833333, 3434.6908778209954, 3440.707539859112, 5623.887522249553, 5641.266635337401, 5662.858428539289, 5672.9221447924865, 5683.630564013341, 5580.218769372291, 5636.041872881609, 5665.5467562594995, 5678.914816277749, 5716.428357164282, 5095.210242412422, 5138.409082955452, 5163.3545806774155, 5197.246399272103, 5214.895702085956, 5038.622103342245, 5161.587073034167, 5218.425973142951, 5293.814716484924, 5299.973500132494, 5055.266986286986, 5084.694918304914, 5106.183010718286, 5106.821261255856, 5224.085784987612, 5195.584353251749, 5207.453217412174, 5208.635395522315, 5212.53087222148, 5248.448912864133, 4966.726830024347, 5017.297578338999, 5059.241113832918, 5091.0, 5105.974470127663, 5481.75332110052, 5488.231647569343, 5525.613207075507, 5527.419620939824, 5542.11326187808, 6000.069989151689, 6001.1898393717165, 6004.219451471325, 6005.6396616203165, 6028.3971602839365, 5826.41735826414, 6026.728797204137, 6070.2412198475195, 6116.031445915052, 6141.140240366352, 5725.083986562172, 5727.455891690324, 5735.254416925814, 5735.77056917727, 5737.225474560964, 6205.348438413992, 6206.565540412218, 6221.2845522764555, 6225.875482490324, 6239.344868788802, 5708.686022268732, 5939.821805345847, 5988.251468566429, 6013.909791353133, 6022.0, 6046.879062418727, 6112.602680825732, 6113.32753397126, 6121.265448146251, 6135.60118592299, 5748.367679555246, 6028.638281703112, 6066.666333351708, 6082.908756368658, 6087.117367981707, 5943.405659434022, 5970.104484327386, 6027.638341699512, 6047.213862197974, 6065.150878876961, 4544.341070544752, 4554.95445045552, 4575.908481830411, 4582.198115329804, 4607.76961151941, 4003.919921601552, 4086.836526538905, 4107.199096176277, 4121.319982202903, 4126.690498212646, 5661.0, 5684.033714268584, 5769.538436925036, 5805.593608447368, 5824.708764561755, 6117.124563098031, 6125.907024958145, 6130.444112847226, 6130.776598292009, 6142.293636231891, 5727.799527016535, 5859.824205273763, 5865.618734782225, 5882.23530940975, 5912.822615321547, 5192.143296356135, 5237.319148510669, 5263.815766448232, 5268.157094864803, 5297.947020529822, 6038.486728628028, 6063.9090413643835, 6064.787732429432, 6066.029435290332, 6096.451319381277, 5837.94162058391, 5862.970685146547, 5911.438413350725, 5920.5559583031445, 5980.850478738066, 6274.717637706223, 6284.874302514016, 6295.874082518416, 6317.557770955989, 6323.146375239284, 5941.910871336847, 5975.34271230173, 5986.341502434641, 5995.850103747442, 6025.909611355921, 5823.970880145572, 6026.578139530191, 6038.12447195163, 6089.634621922699, 6115.816525504242, 5834.94165058361, 5893.557983151195, 5895.322037965689, 5895.764169433174, 5896.557758168069, 5868.119782032729, 5869.06095024794, 5869.119632055055, 5869.882602348014, 5908.468237858613, 5459.535939445192, 5665.943340566707, 5722.084466485342, 5736.770529178786, 5752.309722833287, 5957.0, 5960.8807823844145, 6004.8799024020145, 6010.579259451796, 6020.578559500968, 5837.970810145922, 5869.413058694096, 5882.147088672033, 5891.086881533369, 5898.1152827076285], "value": 5571.7946426624285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3713328038282, 677.0825531404946, 686.3136863136863, 734.9448791340654, 752.578556008635, 40045.79977100118, 40303.395449068215, 40498.39252411216, 40663.39004914921, 40839.79580102099, 43644.78177609116, 44139.67580972568, 44222.77888610552, 44645.33032004523, 44649.7767511162, 8767.430117042404, 8934.329925255599, 8948.507832069234, 8965.686200982967, 8976.326775491832, 8744.606492707844, 8824.735257942271, 8852.468851868909, 9048.049954754755, 9080.455172689659, 9074.319426043041, 9103.317251206154, 9121.087891210858, 9121.17909388155, 9128.224100951395, 9046.185843274105, 9090.86363704545, 9098.408603440788, 9110.635574577009, 9127.269818414577, 8920.8661870072, 9075.727728168165, 9086.318526110503, 9099.317551183687, 9120.498372589505, 44348.0, 45167.0, 45247.773761130986, 45275.320870186646, 45308.546914530765, 1805.5034865411985, 3855.8264878080554, 3871.7483363581277, 4253.02180498484, 4392.450943632046, 33634.0, 33642.1589460263, 33850.322993540234, 34080.82959585211, 34411.4838277426, 4513.661475389326, 4547.840825571089, 4553.408056952608, 4554.43069616298, 4663.0, 318522.0, 318703.0, 320345.0, 320367.0, 320385.9999999977, 63290.36709632937, 63469.0, 63542.0, 63699.36300637027, 63707.0, 72625.63687181531, 73502.63248683722, 74181.62909185527, 74209.6289518549, 74299.62850185715, 17596.03221822812, 17637.0, 17685.823141768677, 17701.46895593134, 17796.3771268005, 15530.611734706497, 15688.137152456724, 15702.450414235447, 15719.0, 15770.0, 21157.365279041653, 21574.0, 21633.242836500645, 21803.67294490584, 21929.561408771737, 7784.922150778533, 7807.492512986638, 7839.764807055683, 7992.80017999543, 8224.465409748347, 1179.9469023893946, 1195.9282443053444, 1234.0312854409246, 1235.7034311765112, 1259.4521383198337, 33340.66659333376, 33682.8315858424, 33712.831435842665, 34072.659273407444, 34235.31529369399, 1219.5548624751902, 1226.699458632623, 1231.2858542045592, 1264.386772415378, 1284.441268048402, 16179.595510112342, 18073.980034614688, 18425.447236582924, 18541.81458185428, 18639.0, 521271.0, 570631.0, 582098.0, 583874.0, 591352.0, 65076.0, 65740.67129664321, 65795.67102164458, 66370.33629663738, 66493.0, 1555.642202293479, 1560.7736878152605, 1569.0507243117977, 1577.345401658299, 1641.9343226270814, 34030.48954265638, 34095.82952085224, 34556.481652774724, 35091.82454087815, 35393.469097964065, 55391.0, 56117.71941140268, 56191.438085620255, 56242.718786407444, 56301.71849140728, 449598.0, 456692.0, 457035.0, 457564.0, 459559.0, 31333.0, 31423.528647069856, 31646.0, 31658.525122122726, 31791.682083178872, 52465.475345247585, 52516.47483525269, 52966.0, 52988.470115298354, 53256.73371633117, 43027.784861075495, 44608.553914461736, 44998.77500612476, 45247.321290180014, 46055.53944460512, 42856.5714342865, 43756.78121609372, 43939.78030109829, 44072.0, 44672.0, 41042.17915641611, 41616.375754364315, 41657.58342416537, 42126.578734212264, 42165.78917105395, 35821.82089089642, 36599.45100823436, 37095.66311991718, 37358.25283494261, 38272.0, 28786.28034299159, 29664.851675741484, 29886.25284367908, 29964.400711986073, 30108.69891301059], "value": 21542.60826752752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.40235164890026, 427.7903827124708, 428.42163079842237, 432.08182611949604, 433.78744415236525, 18677.81322186778, 19522.41432757016, 19523.70714439283, 20008.799912000875, 20783.16867325305, 19344.903275483604, 19465.70801437976, 19509.902450487763, 19774.901125494387, 19780.703289450634, 5150.639455238125, 5400.29796126503, 5456.0, 6112.510999120082, 6113.021916493362, 5924.0, 6000.879982400349, 6006.369331220225, 6019.969900150493, 6043.75824967003, 5326.2543243945875, 5363.839084827442, 5366.248725178478, 5997.940020599804, 6007.948608993431, 5323.1749078892835, 5359.705216213126, 5369.62412631116, 5372.274742909696, 5407.188921661763, 5144.794208231666, 5167.3282473278605, 5169.405518365398, 5478.068728316196, 5485.533729632986, 23456.882715586482, 23575.88212058946, 23959.640605390934, 24167.15414960468, 24426.267211983668, 2446.3028037009367, 2447.3025187821386, 2481.466484705797, 2483.2301986384277, 2529.3423709835392, 9324.25405967521, 9883.258755593359, 9965.850512242323, 10035.29752917296, 10245.385276883411, 1917.3289348727974, 1958.5103724068983, 2022.8179463848323, 2029.289748587997, 2042.3056160905214, 62069.0, 70849.0, 71900.6404967977, 73000.0, 82204.58897705533, 11345.0, 11478.655640330804, 11559.133065020158, 11594.536218551331, 11701.180917335874, 16278.348866045462, 16566.917165414096, 16568.088755118344, 16580.502584922473, 16589.087600181865, 8599.484030958163, 8649.394542381973, 8662.480251184948, 8838.337124715543, 8855.158759917798, 8431.15688431152, 8475.788105297417, 8485.830283394422, 8535.402521823537, 8695.826083478294, 4997.950020499821, 5029.446760856303, 5051.595872330205, 5063.93657331957, 5118.10433174193, 1946.912388942501, 2046.5088378788982, 2068.844836637258, 2112.186808078901, 2134.914603415877, 990.5790039233441, 1142.9428528573537, 1208.9637310880687, 1216.015027827445, 1216.4100411300512, 18914.81085189158, 18950.81049189518, 19190.904045479685, 19578.21687132499, 19722.802771972096, 1031.783325501653, 1081.259337353915, 1095.1293721491434, 1110.7611863449397, 1116.9497372618252, 10656.360618362924, 10963.397013164353, 10981.890181098086, 11028.28316159447, 11169.441527923735, 494523.0, 496565.0, 503346.0, 528168.0, 557897.0, 89345.55327223323, 94748.52625736827, 98933.50533247288, 99854.50072749589, 101423.49288253511, 1045.8954104589632, 1081.3944191252924, 1104.0339702760245, 1115.2583531951161, 1122.6239209864787, 17781.377651782124, 18285.0, 18368.357107501175, 18406.447806565826, 18734.25062997465, 40964.38553421642, 41113.1777364457, 42607.1478570433, 43045.3543196846, 44098.338524922794, 63679.68160159169, 63700.68149659407, 63797.362026381, 63954.0, 64103.35896641161, 7758.146603873456, 7829.804254893673, 7872.685092596461, 8065.556394398364, 8367.95816020916, 12747.681307967376, 13527.797083043566, 13794.310284485937, 13903.235322056978, 13928.442862285801, 11416.82874756896, 11819.11356648272, 11864.406779661154, 12074.939625301817, 12743.10798244114, 8051.83896322082, 11615.0, 11745.530178792753, 11747.706307342385, 11765.294082355085, 12283.631491055283, 12385.071119666241, 12431.0, 12498.187617804813, 12537.059720520814, 8451.535165565707, 8610.311175105851, 8724.69463568772, 8743.213110819803, 8819.470831750115, 11410.771784564427, 11990.880091198977, 11993.580224692094, 12227.69430764238, 12277.877221227673], "value": 9481.656844405374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1630.5597488678056, 1642.2773979449037, 1849.8427633651138, 1910.3218357483101, 1947.5423275530238, 7696.96151519243, 8713.433626814252, 8915.777105572364, 9111.58997845097, 9181.678641247567, 7404.2225566315565, 8319.168083191678, 8518.105598912118, 8817.0, 8940.59767310471, 2389.378761522004, 2405.5790236708594, 2415.5651982643117, 2431.7081950166007, 2434.294054724128, 2406.711194656644, 2444.2422848916804, 2497.862617556034, 2503.161440917295, 2507.849529028255, 2405.56699794037, 2441.5361081394476, 2462.212092130519, 2470.258922323296, 2473.5423946569854, 2373.608354621494, 2409.0363854458183, 2409.77107174819, 2444.4133407982135, 2463.5442443148077, 2422.7940625046717, 2493.1772515069983, 2499.600063989753, 2516.0, 2516.1822407717564, 9125.589348479334, 9152.908470915272, 9189.218916392114, 9203.40177888435, 9222.953885230598, 5475.7262136893, 5627.54979601635, 5652.74562644682, 5658.773649054033, 5680.0627896397045, 3481.617022127564, 3576.159602493412, 3582.874599389009, 3594.245208506217, 3606.963930360689, 1047.0419566097012, 1051.9211059170516, 1062.219268837404, 1070.7376692710259, 1092.4756117063853, 12969.286689232089, 13119.934400328033, 13147.868521314856, 13163.86836131636, 13179.472821087145, 4797.376341075707, 4816.903661926812, 4862.0, 4878.243872199815, 4924.482929292372, 11105.278156919774, 11287.20989530725, 11289.774204515863, 11302.039326657326, 11321.490532926038, 5665.206871038058, 5679.659220446786, 5703.914441283384, 5707.715763953077, 5710.65736055838, 4336.349547567827, 4966.6771659842, 5041.0, 5107.361579802525, 5198.350206224222, 4270.145970805851, 4318.978405107954, 4346.913061738811, 4385.6710746694125, 4389.209942210433, 1337.5452346202337, 1370.9862901371057, 1387.1607677355257, 1399.5451478269604, 1421.9075760075561, 1014.7868947521104, 1028.717102796737, 1029.6447725534679, 1046.9214808889212, 1047.6438011076118, 6010.909836352458, 6044.576879618385, 6053.818385448443, 6141.868080927878, 6258.249010118815, 436.3912342282498, 448.76439869069, 1039.194624166262, 1044.7597052677775, 1057.127869507644, 4000.7799571023293, 4058.6955978301153, 4125.278076336629, 4141.171765646883, 4150.066235097079, 10890.074343680717, 11197.49611267495, 11239.04468120219, 11241.775164496828, 11273.098152147808, 11107.611233606947, 11109.500072496758, 11151.498182581803, 11152.386618735885, 11197.16021298406, 8387.370947178864, 8627.611757470804, 8675.479471231747, 8765.824683506295, 8771.122887711177, 5893.116032594973, 5894.793682221273, 5944.256967879015, 5978.3722709116655, 6174.44430001302, 9722.125008749246, 9746.220302375934, 9819.852702209615, 9891.35706179096, 9993.650222242186, 9925.255605829736, 10000.749981250527, 10035.548400321857, 10055.798884022424, 10129.0, 7047.083879095685, 7614.771556853303, 7859.567723775019, 7979.002624671916, 8075.313598344206, 8622.353323500887, 8634.266087382643, 8641.0, 8659.307255419426, 8701.390902636755, 7582.0, 7801.9609901950125, 7880.763577092696, 7887.802804929693, 7970.4819186752675, 7646.502977306457, 7867.9606601966625, 7872.37021038327, 7904.091029531677, 7935.682572697027, 7284.817879553054, 7297.160826504807, 7368.778936631909, 7493.737719179802, 7499.8500029998, 5189.325387699726, 5200.271961925409, 5315.601329900195, 5328.60035497347, 5333.839984800462, 5202.869928251824, 5420.4850539198715, 5455.918161227664, 5487.75305111279, 5592.02139625572], "value": 4792.1122951253155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.73546429334147, 341.6600482519892, 343.38779430573453, 343.79715967579125, 345.4524578543009, 6547.312532184112, 6621.6689165541775, 6642.43539299159, 6711.362420570044, 6719.092922455461, 6653.866922661544, 6704.932950670492, 6707.899381509281, 6708.26209116998, 6720.260771315151, 4958.826441074554, 4973.179425394824, 4981.626378021645, 4986.725730084844, 4994.450610432849, 4989.600831933455, 4996.900061998758, 4996.925046124311, 5001.1248031594505, 5002.199648056312, 4933.481984391641, 4940.0, 4941.937483441059, 4945.7774400152075, 4948.505149485059, 4715.3634259374885, 4861.975690121562, 4897.363342765453, 4906.215005599105, 4941.160002799515, 4146.108586653884, 4167.083241686854, 4170.52039015511, 4171.165766846643, 4173.707840451139, 6298.68506574674, 6317.526185536103, 6343.777967771106, 6347.746090156388, 6354.046892966046, 5695.658260504383, 5711.7144142792695, 5713.200151978726, 5727.455891690282, 5727.627704199255, 6945.201301850301, 6994.370506654425, 7020.052292940439, 7033.0, 7042.859142817115, 4533.184026875161, 4656.068786242731, 4660.231061874787, 4677.064587082597, 4678.929816052762, 7268.200497945222, 7295.817604559876, 7339.88990165148, 7351.963240183765, 7365.2634736525915, 4713.622910167179, 4715.269133284278, 4716.528347165325, 4720.952790472052, 4725.669203155815, 4759.904801904012, 4784.114938736345, 4784.904301913943, 4787.01866117452, 4788.664793464424, 5649.576281778801, 5650.63270887391, 5655.066913959151, 5660.462256085665, 5664.830055098354, 6945.7221711132, 7042.6126563039525, 7062.081929349254, 7068.611226382495, 7074.610896400644, 1684.1915880377242, 1690.518202312335, 1697.949061528156, 1709.376077731619, 1709.487153853839, 1017.3590637898077, 1070.0369667299337, 1079.838024296346, 1082.7509672775147, 1088.586337191862, 6753.527253092335, 6957.095577574883, 6964.303569643096, 6964.4080253179045, 6976.232614412411, 7376.631168441664, 7383.6677349519405, 7392.926070739224, 7403.2226616204525, 7412.073490813648, 6923.584584924921, 6931.965340173267, 6934.16789985205, 6934.583924964519, 6940.236573976858, 3918.941215881764, 3926.312895243321, 3961.088949541622, 3988.521377434726, 3989.5810939851476, 7665.156832748505, 7668.53988760665, 7669.348105411103, 7677.424193185533, 7684.231576842383, 7463.619230442386, 7489.812754681067, 7499.737509187262, 7528.397728181732, 7535.095788505305, 7628.504147230412, 7642.5032372894475, 7643.617819109022, 7648.158702542716, 7655.425843061793, 7210.53437149757, 7262.96368518154, 7334.449916256409, 7335.449841262033, 7359.227281135403, 7125.251848555827, 7175.964120179575, 7224.0, 7224.241454647186, 7224.74713385029, 7603.467757256939, 7610.505317154367, 7611.771646850603, 7632.122305934889, 7637.809054773675, 4751.216049351819, 4757.500462451393, 4761.214399624023, 4762.571368576845, 4766.952330476651, 7078.86738121898, 7319.890201647086, 7325.7802265932105, 7330.560166390033, 7339.045924029842, 7026.402755765817, 7038.859222815618, 7040.577565346096, 7064.399526040139, 7069.399101076466, 6963.025176475398, 7003.0, 7068.71725130989, 7070.0, 7080.468964827555, 6804.387605115563, 6810.455163587, 6831.248562658005, 6849.520533562602, 6852.109225800614, 6931.792046238621, 7128.108986376703, 7139.07192065049, 7151.964240178766, 7162.391196748335, 6808.9659551701925, 6938.895916561357, 6982.162140543167, 6990.720371185095, 7002.719891204295], "value": 5235.8978494219045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.3210759822533, 902.6163880350849, 923.4551614547415, 929.6049179098882, 929.6839074714595, 15201.771973420407, 15462.536123916272, 15558.45545405911, 15578.610534736637, 15639.218039098043, 14235.145891246533, 14370.640733981656, 14629.268536573181, 14709.11745295283, 14721.558353249393, 775.9650815713306, 898.8067565473422, 907.8093600343935, 916.9083091690844, 928.067292371166, 901.7700486375965, 901.8196360727848, 906.0622255965078, 906.4561263242068, 909.4497828813571, 967.6564819489085, 967.9884520675876, 968.3076600230834, 970.0638883477443, 971.0435221307007, 955.5222388805597, 960.6685693435753, 961.9947155222809, 963.9373440726365, 964.1852634523816, 701.0115736811123, 704.1514974455769, 710.6766421278306, 711.6904146696152, 714.0538786108375, 15303.923480382527, 15335.463258785889, 15399.0, 15423.768643470357, 15551.922240388838, 15110.848891511165, 15127.621809454742, 15193.924030379889, 15328.23358832054, 15390.230488475643, 12371.381430928508, 12458.688532786662, 12506.686797886274, 12557.372131393393, 12704.618861434172, 4095.5904409559103, 4101.425800387948, 4106.7946602669745, 4110.979445102756, 4134.751914885086, 57307.713461432846, 57447.42552574504, 61898.0, 62337.0, 62398.68800655968, 12016.519339226334, 12089.335086570323, 12255.325957072268, 12270.631881043404, 12397.0, 22255.666165007537, 22406.215782447864, 22434.21480248216, 22471.66292505614, 22496.32511024672, 8883.57862741971, 8886.333524985652, 9093.090690930987, 9247.352685312098, 9259.444433334022, 5026.0, 5093.567046801063, 5109.514596113363, 5126.077306084941, 5157.845264641992, 3522.172289511963, 3591.174029973121, 3614.331348700499, 3614.331348700499, 3615.132368231658, 622.2657264427928, 626.5989766549412, 638.4828289085856, 646.8188907106017, 654.6497623771355, 826.6734639817358, 840.8192238668715, 843.8185790055045, 859.1751918158637, 867.0679020053468, 10090.243231757648, 10204.0, 10309.94845025785, 10382.844257336146, 10420.0, 826.9793255168548, 828.6105530400702, 829.4401279136558, 834.1200033964104, 846.9788255293544, 4545.2954792007295, 4719.244920812722, 4815.181419158752, 4834.395700537433, 4837.177679794443, 64769.35230647633, 66400.33599664038, 66696.0, 66802.0, 67242.0, 58818.0, 60546.69726651427, 61678.383216168164, 61728.69135654383, 61830.0, 52471.73764131231, 53003.469965300625, 55417.0, 55793.0, 57369.13946290725, 9418.152366287068, 9437.622495100119, 9610.423374597547, 9619.422834629944, 9730.562124704547, 39404.60595394124, 40367.0, 40894.591054089076, 41099.7945010273, 41477.0, 47986.52013479821, 52484.0, 52849.0, 53396.0, 53517.46482535125, 12140.817887731515, 12244.938775306067, 12293.93853030729, 12463.813042804184, 12557.434915428645, 13094.410751516396, 13724.176549407068, 13783.379747911167, 13787.310634468437, 13812.309384530934, 12283.570075047688, 12306.0, 12358.382080895739, 12546.874531254936, 12588.87411125877, 11430.599929002445, 11683.415829208336, 11696.88303116958, 11785.233959792586, 12269.0, 12138.150329477205, 12243.326617035793, 12281.93859030699, 12302.753944920873, 12431.005519558234, 10449.9477502612, 10533.578656853946, 10630.8405373921, 10672.733181670521, 10721.249512534048, 10297.3821570706, 10679.252452328263, 10777.89222107769, 10790.67627971162, 10824.729381765204], "value": 7304.279734347137, "unit": "score"}], "name": "dromaeo_css", "value": 7701.085686105485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 102.0, 109.0, 109.0, 111.0, 100.0, 109.0, 109.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 133.0, 158.0, 173.0, 127.0, 149.0, 154.0, 129.0, 197.0, 123.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 163.0, 161.0, 162.0, 164.0, 164.0, 162.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 191.0, 74.0, 76.0, 77.0, 73.0, 173.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 92.0, 152.0, 93.0, 93.0, 93.0, 140.0, 93.0, 92.0, 140.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 100.0, 97.0, 95.0, 97.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 56.0, 58.0, 58.0, 60.0, 73.0, 55.0, 56.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 74.0, 76.0, 73.0, 74.0, 74.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 113.0, 122.0, 126.0, 126.0, 114.0, 122.0, 126.0, 136.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 157.0, 159.0, 158.0, 160.0, 158.0, 158.0, 157.0, 156.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 70.0, 64.0, 66.0, 66.0, 68.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1525.0999999999997, "alertThreshold": 2.0}]} 06:17:04 INFO - Return code: 0 06:17:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:04 ERROR - # TBPL SUCCESS # 06:17:04 INFO - Running post-action listener: _resource_record_post_action 06:17:04 INFO - Running post-run listener: _resource_record_post_run 06:17:05 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 511549440; Read time: 0; Write time: 368868 06:17:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259440640; Read time: 0; Write time: 219548 06:17:06 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 252108800; Read time: 0; Write time: 149320 06:17:06 INFO - Running post-run listener: _upload_blobber_files 06:17:06 INFO - Blob upload gear active. 06:17:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:07 INFO - (blobuploader) - INFO - Done attempting. 06:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:07 INFO - (blobuploader) - INFO - Done attempting. 06:17:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:07 INFO - Return code: 0 06:17:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f74a20594f5062545740b46c889cc620d06a4dee58c586ee8e15367565dfa167788053a88325636a1116cefaabcba114c0653ee017a72b70374c46f6375af75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bec1d179cafa950c217dd77b39fb7fd6991fff7cb3331c85bdd464b955018f6769d4f18af18f0458e379b2e93f08ae5f48e9c1c3bbb66cc44b1f03657d7f114"} 06:17:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:07 INFO - Contents: 06:17:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f74a20594f5062545740b46c889cc620d06a4dee58c586ee8e15367565dfa167788053a88325636a1116cefaabcba114c0653ee017a72b70374c46f6375af75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bec1d179cafa950c217dd77b39fb7fd6991fff7cb3331c85bdd464b955018f6769d4f18af18f0458e379b2e93f08ae5f48e9c1c3bbb66cc44b1f03657d7f114"} 06:17:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:07 INFO - Copying logs to upload dir... 06:17:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.196336 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-06 06:17:06.271217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:06.275121) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f74a20594f5062545740b46c889cc620d06a4dee58c586ee8e15367565dfa167788053a88325636a1116cefaabcba114c0653ee017a72b70374c46f6375af75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bec1d179cafa950c217dd77b39fb7fd6991fff7cb3331c85bdd464b955018f6769d4f18af18f0458e379b2e93f08ae5f48e9c1c3bbb66cc44b1f03657d7f114"} build_url:https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/CUSzGHNHTxykKCwoTsvFhQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f74a20594f5062545740b46c889cc620d06a4dee58c586ee8e15367565dfa167788053a88325636a1116cefaabcba114c0653ee017a72b70374c46f6375af75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bec1d179cafa950c217dd77b39fb7fd6991fff7cb3331c85bdd464b955018f6769d4f18af18f0458e379b2e93f08ae5f48e9c1c3bbb66cc44b1f03657d7f114"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:06.301458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:06.301790) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465216856.111236-2006397643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:06.386057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:17:06.386400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:17:06.386779) ========= ========= Total master_lag: 0.15 =========